"./sync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -fast-list" - Starting (try 1/5) 2021/12/01 05:07:20 DEBUG : Creating backend with remote "TestB2:rclone-test-cifayex8xabekoq3cihecit6" 2021/12/01 05:07:20 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2021/12/01 05:07:21 DEBUG : Creating backend with remote "/tmp/rclone2010825627" === 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-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:07:22 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) 2021/12/01 05:07:22 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:07:22 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish --- PASS: TestCopyWithDryRun (1.66s) === RUN TestCopy run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:07:23 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:07:23 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:07:26 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/12/01 05:07:26 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopy (5.15s) === RUN TestCopyMissingDirectory run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:07:28 DEBUG : Creating backend with remote "/non-existing" 2021/12/01 05:07:28 ERROR : Local file system at /non-existing: error reading source root directory: directory not found 2021/12/01 05:07:28 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:07:28 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish --- PASS: TestCopyMissingDirectory (0.51s) === RUN TestCopyNoTraverse run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:07:29 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:07:29 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:07:29 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:07:32 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/12/01 05:07:32 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoTraverse (4.55s) === RUN TestCopyCheckFirst run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:07:33 INFO : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Running all checks before starting transfers 2021/12/01 05:07:33 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:07:33 INFO : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Checks finished, now starting transfers 2021/12/01 05:07:33 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:07:36 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/12/01 05:07:36 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyCheckFirst (6.11s) === RUN TestSyncNoTraverse run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:07:39 ERROR : Ignoring --no-traverse with sync 2021/12/01 05:07:39 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:07:39 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:07:42 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/12/01 05:07:42 INFO : sub dir/hello world: Copied (new) 2021/12/01 05:07:42 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoTraverse (4.28s) === RUN TestCopyWithDepth run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:07:43 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:07:43 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:07:45 DEBUG : hello world2: sha1 = c0bf117f9c93d02c894fe8ffd6e5cecf3545c209 OK 2021/12/01 05:07:45 INFO : hello world2: Copied (new) --- PASS: TestCopyWithDepth (3.99s) === RUN TestCopyWithFilesFrom run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:07:47 DEBUG : hello world2: Excluded 2021/12/01 05:07:47 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:07:47 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:07:50 DEBUG : potato2: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/12/01 05:07:50 INFO : potato2: Copied (new) --- PASS: TestCopyWithFilesFrom (4.78s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:07:52 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:07:52 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:07:52 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:07:57 DEBUG : potato2: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/12/01 05:07:57 INFO : potato2: Copied (new) --- PASS: TestCopyWithFilesFromAndNoTraverse (6.78s) === RUN TestCopyEmptyDirectories run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:07:59 DEBUG : sub dir2: Making directory 2021/12/01 05:07:59 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:07:59 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:08:00 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/12/01 05:08:00 INFO : sub dir/hello world: Copied (new) 2021/12/01 05:08:00 DEBUG : sub dir2: Making directory 2021/12/01 05:08:00 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: copied 1 directories fstest.go:251: Filtering empty directory "sub dir2" --- PASS: TestCopyEmptyDirectories (2.37s) === RUN TestMoveEmptyDirectories run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:08:01 DEBUG : sub dir2: Making directory 2021/12/01 05:08:01 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:08:01 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:08:03 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/12/01 05:08:03 INFO : sub dir/hello world: Copied (new) 2021/12/01 05:08:03 INFO : sub dir/hello world: Deleted 2021/12/01 05:08:03 DEBUG : sub dir2: Making directory 2021/12/01 05:08:03 DEBUG : sub dir: Making directory 2021/12/01 05:08:03 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: copied 2 directories fstest.go:251: Filtering empty directory "sub dir2" --- PASS: TestMoveEmptyDirectories (3.49s) === RUN TestSyncEmptyDirectories run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:08:04 DEBUG : sub dir2: Making directory 2021/12/01 05:08:05 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:08:05 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:08:07 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/12/01 05:08:07 INFO : sub dir/hello world: Copied (new) 2021/12/01 05:08:07 DEBUG : sub dir2: Making directory 2021/12/01 05:08:07 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: copied 1 directories 2021/12/01 05:08:07 DEBUG : Waiting for deletions to finish fstest.go:251: Filtering empty directory "sub dir2" --- PASS: TestSyncEmptyDirectories (3.28s) === RUN TestServerSideCopy run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:08:10 DEBUG : Creating backend with remote "TestB2:rclone-test-zulemed5famayez3vopiwol4" sync_test.go:275: Server side copy (if possible) B2 bucket rclone-test-cifayex8xabekoq3cihecit6 -> B2 bucket rclone-test-zulemed5famayez3vopiwol4 2021/12/01 05:08:11 DEBUG : B2 bucket rclone-test-zulemed5famayez3vopiwol4: Waiting for checks to finish 2021/12/01 05:08:11 DEBUG : B2 bucket rclone-test-zulemed5famayez3vopiwol4: Waiting for transfers to finish 2021/12/01 05:08:12 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/12/01 05:08:12 INFO : sub dir/hello world: Copied (server-side copy) 2021/12/01 05:08:12 DEBUG : B2 bucket rclone-test-zulemed5famayez3vopiwol4: Purge remote 2021/12/01 05:08:12 DEBUG : sub dir/hello world: Deleting (id "4_z7f82ad03604d7b4b7fd80e1b_f1004680c5f6ca873_d20211201_m050812_c001_v0001134_t0036") --- PASS: TestServerSideCopy (6.21s) === RUN TestCopyAfterDelete run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:08:17 ERROR : : error listing: directory not found 2021/12/01 05:08:17 DEBUG : Local file system at /tmp/rclone2010825627: Making directory 2021/12/01 05:08:17 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:08:17 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish --- PASS: TestCopyAfterDelete (7.89s) === RUN TestCopyRedownload run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:08:25 DEBUG : Local file system at /tmp/rclone2010825627: Waiting for checks to finish 2021/12/01 05:08:25 DEBUG : Local file system at /tmp/rclone2010825627: Waiting for transfers to finish 2021/12/01 05:08:53 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/12/01 05:08:53 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyRedownload (31.93s) === RUN TestSyncBasedOnCheckSum run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:08:54 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:08:54 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:08:59 DEBUG : check sum: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2021/12/01 05:08:59 INFO : check sum: Copied (new) 2021/12/01 05:08:59 DEBUG : Waiting for deletions to finish 2021/12/01 05:09:00 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:09:00 DEBUG : check sum: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2021/12/01 05:09:00 DEBUG : check sum: Size and sha1 of src and dst objects identical 2021/12/01 05:09:00 DEBUG : check sum: Unchanged skipping 2021/12/01 05:09:00 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:09:00 DEBUG : Waiting for deletions to finish 2021/12/01 05:09:00 INFO : There was nothing to transfer --- PASS: TestSyncBasedOnCheckSum (10.96s) === RUN TestSyncSizeOnly run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:09:05 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:09:05 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:09:14 DEBUG : sizeonly: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2021/12/01 05:09:14 INFO : sizeonly: Copied (new) 2021/12/01 05:09:14 DEBUG : Waiting for deletions to finish 2021/12/01 05:09:15 DEBUG : sizeonly: Sizes identical 2021/12/01 05:09:15 DEBUG : sizeonly: Unchanged skipping 2021/12/01 05:09:15 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:09:15 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:09:15 DEBUG : Waiting for deletions to finish 2021/12/01 05:09:15 INFO : There was nothing to transfer --- PASS: TestSyncSizeOnly (10.95s) === RUN TestSyncIgnoreSize run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:09:16 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:09:16 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:09:21 DEBUG : ignore-size: sha1 = 4a756ca07e9487f482465a99e8286abc86ba4dc7 OK 2021/12/01 05:09:21 INFO : ignore-size: Copied (new) 2021/12/01 05:09:21 DEBUG : Waiting for deletions to finish 2021/12/01 05:09:21 DEBUG : ignore-size: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:09:21 DEBUG : ignore-size: Unchanged skipping 2021/12/01 05:09:21 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:09:21 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:09:21 DEBUG : Waiting for deletions to finish 2021/12/01 05:09:21 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreSize (6.44s) === RUN TestSyncIgnoreTimes run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:09:22 DEBUG : existing: Clearing upload URL because of error: no tomes available (503 service_unavailable) 2021/12/01 05:09:22 DEBUG : pacer: low level retry 1/1 (error no tomes available (503 service_unavailable)) 2021/12/01 05:09:22 DEBUG : pacer: Rate limited, increasing sleep to 1s run.go:283: Retry Put of "existing" to B2 bucket rclone-test-cifayex8xabekoq3cihecit6: 1/10 (no tomes available (503 service_unavailable)) 2021/12/01 05:09:24 DEBUG : pacer: Reducing sleep to 500ms 2021/12/01 05:09:26 DEBUG : pacer: Reducing sleep to 250ms 2021/12/01 05:09:26 DEBUG : pacer: Reducing sleep to 125ms 2021/12/01 05:09:26 DEBUG : pacer: Reducing sleep to 62.5ms 2021/12/01 05:09:26 DEBUG : existing: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:09:26 DEBUG : existing: Unchanged skipping 2021/12/01 05:09:26 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:09:26 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:09:26 DEBUG : Waiting for deletions to finish 2021/12/01 05:09:26 INFO : There was nothing to transfer 2021/12/01 05:09:27 DEBUG : pacer: Reducing sleep to 31.25ms 2021/12/01 05:09:27 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2021/12/01 05:09:27 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:09:27 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:09:27 DEBUG : pacer: Reducing sleep to 15.625ms 2021/12/01 05:09:27 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2021/12/01 05:09:27 INFO : existing: Copied (replaced existing) 2021/12/01 05:09:27 DEBUG : Waiting for deletions to finish 2021/12/01 05:09:27 DEBUG : pacer: Reducing sleep to 10ms --- PASS: TestSyncIgnoreTimes (7.67s) === RUN TestSyncIgnoreExisting run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:09:30 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:09:30 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:09:30 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2021/12/01 05:09:30 INFO : existing: Copied (new) 2021/12/01 05:09:30 DEBUG : Waiting for deletions to finish 2021/12/01 05:09:30 DEBUG : existing: Destination exists, skipping 2021/12/01 05:09:30 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:09:30 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:09:30 DEBUG : Waiting for deletions to finish 2021/12/01 05:09:30 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreExisting (2.25s) === RUN TestSyncIgnoreErrors run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:09:33 DEBUG : d: Making directory fstest.go:251: Filtering empty directory "d" 2021/12/01 05:09:33 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/01 05:09:33 DEBUG : c/non empty space: Unchanged skipping 2021/12/01 05:09:33 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:09:33 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:09:33 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/12/01 05:09:33 INFO : a/potato2: Copied (new) 2021/12/01 05:09:33 DEBUG : Waiting for deletions to finish 2021/12/01 05:09:34 INFO : b/potato: Deleted --- PASS: TestSyncIgnoreErrors (5.37s) === RUN TestSyncAfterChangingModtimeOnly run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:09:38 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:09:38 DEBUG : empty space: Modification times differ by -95456h54m52.624456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499 +0000 UTC 2021/12/01 05:09:38 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2021/12/01 05:09:38 NOTICE: empty space: Skipped update modification time as --dry-run is set (size 1) 2021/12/01 05:09:38 DEBUG : empty space: Unchanged skipping 2021/12/01 05:09:38 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:09:38 DEBUG : Waiting for deletions to finish 2021/12/01 05:09:38 INFO : There was nothing to transfer 2021/12/01 05:09:38 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:09:38 DEBUG : empty space: Modification times differ by -95456h54m52.624456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499 +0000 UTC 2021/12/01 05:09:38 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2021/12/01 05:09:40 INFO : empty space: Updated modification time in destination 2021/12/01 05:09:40 DEBUG : empty space: Unchanged skipping 2021/12/01 05:09:40 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:09:40 DEBUG : Waiting for deletions to finish 2021/12/01 05:09:40 INFO : There was nothing to transfer --- PASS: TestSyncAfterChangingModtimeOnly (3.59s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:09:41 DEBUG : empty space: Modification times differ by -95456h54m52.624456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499 +0000 UTC 2021/12/01 05:09:41 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:09:42 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2021/12/01 05:09:42 DEBUG : empty space: Unchanged skipping 2021/12/01 05:09:42 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:09:42 DEBUG : Waiting for deletions to finish 2021/12/01 05:09:42 INFO : There was nothing to transfer --- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (2.31s) === RUN TestSyncDoesntUpdateModtime run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:09:44 DEBUG : foo: Modification times differ by -95456h54m52.624456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499 +0000 UTC 2021/12/01 05:09:44 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:09:44 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 (Local file system at /tmp/rclone2010825627) 2021/12/01 05:09:44 DEBUG : foo: sha1 = 62cdb7020ff920e5aa642c3d4066950dd1f01f4d (B2 bucket rclone-test-cifayex8xabekoq3cihecit6) 2021/12/01 05:09:44 DEBUG : foo: sha1 differ 2021/12/01 05:09:44 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:09:44 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 OK 2021/12/01 05:09:44 INFO : foo: Copied (replaced existing) 2021/12/01 05:09:44 DEBUG : Waiting for deletions to finish --- PASS: TestSyncDoesntUpdateModtime (1.80s) === RUN TestSyncAfterAddingAFile run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:09:46 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/01 05:09:46 DEBUG : empty space: Unchanged skipping 2021/12/01 05:09:46 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:09:46 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:09:46 DEBUG : potato: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/12/01 05:09:46 INFO : potato: Copied (new) 2021/12/01 05:09:46 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterAddingAFile (2.20s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:09:48 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2021/12/01 05:09:48 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:09:48 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:09:48 DEBUG : potato: sha1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f OK 2021/12/01 05:09:48 INFO : potato: Copied (replaced existing) 2021/12/01 05:09:48 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingFilesSizeOnly (2.09s) === RUN TestSyncAfterChangingContentsOnly run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:09:50 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:09:50 DEBUG : potato: Modification times differ by 119h59m59.876543211s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2011-12-30 12:59:59 +0000 UTC 2021/12/01 05:09:50 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f (Local file system at /tmp/rclone2010825627) 2021/12/01 05:09:50 DEBUG : potato: sha1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f (B2 bucket rclone-test-cifayex8xabekoq3cihecit6) 2021/12/01 05:09:50 DEBUG : potato: sha1 differ 2021/12/01 05:09:50 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:09:50 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f OK 2021/12/01 05:09:50 INFO : potato: Copied (replaced existing) 2021/12/01 05:09:50 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingContentsOnly (1.59s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:09:52 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/01 05:09:52 DEBUG : empty space: Unchanged skipping 2021/12/01 05:09:52 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:09:52 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:09:52 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2021/12/01 05:09:52 DEBUG : Waiting for deletions to finish 2021/12/01 05:09:52 NOTICE: potato: Skipped delete as --dry-run is set (size 21) --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (2.11s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:09:54 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:09:54 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/01 05:09:54 DEBUG : empty space: Unchanged skipping 2021/12/01 05:09:54 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:09:54 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/12/01 05:09:54 INFO : potato2: Copied (new) 2021/12/01 05:09:54 DEBUG : Waiting for deletions to finish 2021/12/01 05:09:54 INFO : potato: Deleted --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (2.68s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:09:56 DEBUG : d: Making directory 2021/12/01 05:09:56 DEBUG : d/e: Making directory fstest.go:251: Filtering empty directory "d" fstest.go:251: Filtering empty directory "d/e" 2021/12/01 05:09:56 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:09:56 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/01 05:09:56 DEBUG : c/non empty space: Unchanged skipping 2021/12/01 05:09:56 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:09:57 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/12/01 05:09:57 INFO : a/potato2: Copied (new) 2021/12/01 05:09:57 DEBUG : Waiting for deletions to finish 2021/12/01 05:09:58 INFO : b/potato: Deleted --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (5.95s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:10:03 DEBUG : d: Making directory fstest.go:251: Filtering empty directory "d" 2021/12/01 05:10:03 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:10:03 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/01 05:10:03 DEBUG : c/non empty space: Unchanged skipping 2021/12/01 05:10:03 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:10:03 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/12/01 05:10:03 INFO : a/potato2: Copied (new) 2021/12/01 05:10:03 ERROR : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: not deleting files as there were IO errors 2021/12/01 05:10:03 ERROR : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: not deleting directories as there were IO errors fstest.go:251: Filtering empty directory "d" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (5.18s) === RUN TestSyncDeleteAfter --- PASS: TestSyncDeleteAfter (0.00s) === RUN TestSyncDeleteDuring run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:10:07 DEBUG : Waiting for deletions to finish 2021/12/01 05:10:08 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/01 05:10:08 DEBUG : empty space: Unchanged skipping 2021/12/01 05:10:08 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:10:08 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:10:08 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/12/01 05:10:08 INFO : potato2: Copied (new) 2021/12/01 05:10:08 INFO : potato: Deleted --- PASS: TestSyncDeleteDuring (2.91s) === RUN TestSyncDeleteBefore run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:10:12 DEBUG : Waiting for deletions to finish 2021/12/01 05:10:12 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:10:12 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:10:13 INFO : potato: Deleted 2021/12/01 05:10:13 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:10:13 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/01 05:10:13 DEBUG : empty space: Unchanged skipping 2021/12/01 05:10:13 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:10:13 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/12/01 05:10:13 INFO : potato2: Copied (new) --- PASS: TestSyncDeleteBefore (8.02s) === RUN TestCopyDeleteBefore run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:10:18 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:10:18 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:10:19 DEBUG : potato2: sha1 = 810274f0df19dab60a894a562b7a8ff04c072623 OK 2021/12/01 05:10:19 INFO : potato2: Copied (new) --- PASS: TestCopyDeleteBefore (2.37s) === RUN TestSyncWithExclude run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:10:21 DEBUG : enormous: Excluded 2021/12/01 05:10:21 DEBUG : potato2: Excluded 2021/12/01 05:10:21 DEBUG : potato2: Excluded from sync (and deletion) 2021/12/01 05:10:21 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/01 05:10:21 DEBUG : empty space: Unchanged skipping 2021/12/01 05:10:21 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:10:21 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:10:21 DEBUG : Waiting for deletions to finish 2021/12/01 05:10:21 INFO : There was nothing to transfer 2021/12/01 05:10:21 DEBUG : enormous: Excluded 2021/12/01 05:10:21 DEBUG : potato2: Excluded 2021/12/01 05:10:21 DEBUG : potato2: Excluded from sync (and deletion) 2021/12/01 05:10:21 DEBUG : empty space: Size and modification time the same (differ by 456.789µs, within tolerance 1ms) 2021/12/01 05:10:21 DEBUG : empty space: Unchanged skipping 2021/12/01 05:10:21 DEBUG : Local file system at /tmp/rclone2010825627: Waiting for checks to finish 2021/12/01 05:10:21 DEBUG : Local file system at /tmp/rclone2010825627: Waiting for transfers to finish 2021/12/01 05:10:21 DEBUG : Waiting for deletions to finish 2021/12/01 05:10:21 INFO : There was nothing to transfer --- PASS: TestSyncWithExclude (2.24s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:10:23 DEBUG : enormous: Excluded 2021/12/01 05:10:23 DEBUG : potato2: Excluded 2021/12/01 05:10:23 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:10:23 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/01 05:10:23 DEBUG : empty space: Unchanged skipping 2021/12/01 05:10:23 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:10:23 DEBUG : Waiting for deletions to finish 2021/12/01 05:10:24 INFO : enormous: Deleted 2021/12/01 05:10:24 INFO : potato2: Deleted 2021/12/01 05:10:24 INFO : There was nothing to transfer 2021/12/01 05:10:25 DEBUG : empty space: Size and modification time the same (differ by 456.789µs, within tolerance 1ms) 2021/12/01 05:10:25 DEBUG : empty space: Unchanged skipping 2021/12/01 05:10:25 DEBUG : Local file system at /tmp/rclone2010825627: Waiting for checks to finish 2021/12/01 05:10:25 DEBUG : Local file system at /tmp/rclone2010825627: Waiting for transfers to finish 2021/12/01 05:10:25 DEBUG : Waiting for deletions to finish 2021/12/01 05:10:25 INFO : enormous: Deleted 2021/12/01 05:10:25 INFO : potato2: Deleted 2021/12/01 05:10:25 INFO : There was nothing to transfer --- PASS: TestSyncWithExcludeAndDeleteExcluded (3.41s) === RUN TestSyncWithUpdateOlder run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:10:27 DEBUG : one: Destination is newer than source, skipping 2021/12/01 05:10:27 DEBUG : three: Sizes identical 2021/12/01 05:10:27 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2021/12/01 05:10:27 DEBUG : four: Sizes differ (src 4 vs dst 8) 2021/12/01 05:10:27 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2021/12/01 05:10:27 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:10:27 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b (Local file system at /tmp/rclone2010825627) 2021/12/01 05:10:27 DEBUG : two: sha1 = b10e0da85e90399abfec36c7376b20aa4596461b (B2 bucket rclone-test-cifayex8xabekoq3cihecit6) 2021/12/01 05:10:27 DEBUG : two: sha1 differ 2021/12/01 05:10:27 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:10:27 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2021/12/01 05:10:27 INFO : five: Copied (new) 2021/12/01 05:10:28 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2021/12/01 05:10:28 INFO : two: Copied (replaced existing) 2021/12/01 05:10:29 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2021/12/01 05:10:29 INFO : four: Copied (replaced existing) 2021/12/01 05:10:29 DEBUG : Waiting for deletions to finish 2021/12/01 05:10:29 DEBUG : one: Destination is newer than source, skipping 2021/12/01 05:10:29 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:10:29 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2021/12/01 05:10:29 DEBUG : five: Size and sha1 of src and dst objects identical 2021/12/01 05:10:29 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2021/12/01 05:10:29 DEBUG : five: Destination mod time is within 1s of source and files identical, skipping 2021/12/01 05:10:29 DEBUG : four: Size and sha1 of src and dst objects identical 2021/12/01 05:10:29 DEBUG : four: Destination mod time is within 1s of source and files identical, skipping 2021/12/01 05:10:29 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb (Local file system at /tmp/rclone2010825627) 2021/12/01 05:10:29 DEBUG : three: sha1 = 03731cad13f4cf7b59703c77529381cdec1632e5 (B2 bucket rclone-test-cifayex8xabekoq3cihecit6) 2021/12/01 05:10:29 DEBUG : three: sha1 differ 2021/12/01 05:10:29 DEBUG : three: Destination mod time is within 1s of source but files differ, transferring 2021/12/01 05:10:29 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2021/12/01 05:10:29 DEBUG : two: Size and sha1 of src and dst objects identical 2021/12/01 05:10:29 DEBUG : two: Destination mod time is within 1s of source and files identical, skipping 2021/12/01 05:10:29 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:10:29 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2021/12/01 05:10:29 INFO : three: Copied (replaced existing) 2021/12/01 05:10:29 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithUpdateOlder (8.71s) === 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-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" sync_test.go:1058: Can track renames: true 2021/12/01 05:10:35 INFO : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Making map for --track-renames 2021/12/01 05:10:35 INFO : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Finished making map for --track-renames 2021/12/01 05:10:35 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:10:35 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for renames to finish 2021/12/01 05:10:35 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:10:36 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2021/12/01 05:10:36 INFO : yam: Copied (new) 2021/12/01 05:10:36 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2021/12/01 05:10:36 INFO : potato: Copied (new) 2021/12/01 05:10:36 DEBUG : Waiting for deletions to finish 2021/12/01 05:10:36 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:10:36 DEBUG : potato: Unchanged skipping 2021/12/01 05:10:36 INFO : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Making map for --track-renames 2021/12/01 05:10:36 INFO : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Finished making map for --track-renames 2021/12/01 05:10:36 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:10:36 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for renames to finish 2021/12/01 05:10:37 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:10:37 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2021/12/01 05:10:37 INFO : yam: Copied (server-side copy) to: yaml 2021/12/01 05:10:38 INFO : yam: Deleted 2021/12/01 05:10:38 INFO : yaml: Renamed from "yam" 2021/12/01 05:10:38 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:10:38 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenames (5.92s) === RUN TestParseRenamesStrategyModtime --- PASS: TestParseRenamesStrategyModtime (0.00s) === RUN TestRenamesStrategyModtime --- PASS: TestRenamesStrategyModtime (0.00s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" sync_test.go:1127: Can track renames: true 2021/12/01 05:10:41 INFO : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Making map for --track-renames 2021/12/01 05:10:41 INFO : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Finished making map for --track-renames 2021/12/01 05:10:41 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:10:41 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for renames to finish 2021/12/01 05:10:41 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:10:41 DEBUG : yam: Clearing upload URL because of error: Post "https://pod-000-1033-11.backblaze.com/b2api/v1/b2_upload_file/8f42dde3603d7b4b7fd80e1b/c001_v0001033_t0009": EOF 2021/12/01 05:10:41 DEBUG : pacer: low level retry 1/1 (error Post "https://pod-000-1033-11.backblaze.com/b2api/v1/b2_upload_file/8f42dde3603d7b4b7fd80e1b/c001_v0001033_t0009": EOF) 2021/12/01 05:10:41 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2021/12/01 05:10:41 DEBUG : yam: Received error: Post "https://pod-000-1033-11.backblaze.com/b2api/v1/b2_upload_file/8f42dde3603d7b4b7fd80e1b/c001_v0001033_t0009": EOF - low level retry 1/10 2021/12/01 05:10:41 DEBUG : yam: Clearing upload URL because of error: Post "https://pod-000-1131-17.backblaze.com/b2api/v1/b2_upload_file/8f42dde3603d7b4b7fd80e1b/c001_v0001131_t0034": EOF 2021/12/01 05:10:41 DEBUG : pacer: low level retry 1/1 (error Post "https://pod-000-1131-17.backblaze.com/b2api/v1/b2_upload_file/8f42dde3603d7b4b7fd80e1b/c001_v0001131_t0034": EOF) 2021/12/01 05:10:41 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2021/12/01 05:10:41 DEBUG : yam: Received error: Post "https://pod-000-1131-17.backblaze.com/b2api/v1/b2_upload_file/8f42dde3603d7b4b7fd80e1b/c001_v0001131_t0034": EOF - low level retry 2/10 2021/12/01 05:10:41 DEBUG : pacer: Reducing sleep to 20ms 2021/12/01 05:10:41 DEBUG : pacer: Reducing sleep to 10ms 2021/12/01 05:10:41 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2021/12/01 05:10:41 INFO : potato: Copied (new) 2021/12/01 05:10:42 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2021/12/01 05:10:42 INFO : yam: Copied (new) 2021/12/01 05:10:42 DEBUG : Waiting for deletions to finish 2021/12/01 05:10:42 INFO : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Making map for --track-renames 2021/12/01 05:10:42 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:10:42 DEBUG : potato: Unchanged skipping 2021/12/01 05:10:42 INFO : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Finished making map for --track-renames 2021/12/01 05:10:42 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:10:42 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for renames to finish 2021/12/01 05:10:43 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:10:44 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2021/12/01 05:10:44 INFO : yam: Copied (server-side copy) to: yaml 2021/12/01 05:10:44 INFO : yam: Deleted 2021/12/01 05:10:44 INFO : yaml: Renamed from "yam" 2021/12/01 05:10:44 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:10:44 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenamesStrategyModtime (5.45s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" sync_test.go:1163: Can track renames: true 2021/12/01 05:10:46 INFO : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Making map for --track-renames 2021/12/01 05:10:46 INFO : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Finished making map for --track-renames 2021/12/01 05:10:46 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:10:46 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for renames to finish 2021/12/01 05:10:46 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:10:46 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2021/12/01 05:10:46 INFO : potato: Copied (new) 2021/12/01 05:10:47 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2021/12/01 05:10:47 INFO : sub/yam: Copied (new) 2021/12/01 05:10:47 DEBUG : Waiting for deletions to finish 2021/12/01 05:10:48 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:10:48 DEBUG : potato: Unchanged skipping 2021/12/01 05:10:48 INFO : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Making map for --track-renames 2021/12/01 05:10:48 INFO : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Finished making map for --track-renames 2021/12/01 05:10:48 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:10:48 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for renames to finish 2021/12/01 05:10:49 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:10:49 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2021/12/01 05:10:49 INFO : sub/yam: Copied (server-side copy) to: yam 2021/12/01 05:10:50 INFO : sub/yam: Deleted 2021/12/01 05:10:50 INFO : yam: Renamed from "sub/yam" 2021/12/01 05:10:50 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:10:50 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenamesStrategyLeaf (5.77s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:10:52 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:10:52 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:10:53 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/12/01 05:10:53 INFO : sub dir/hello world: Copied (new) 2021/12/01 05:10:53 INFO : sub dir/hello world: Deleted 2021/12/01 05:10:54 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2021/12/01 05:10:54 INFO : nested/sub dir/file: Copied (new) 2021/12/01 05:10:54 INFO : nested/sub dir/file: Deleted 2021/12/01 05:10:54 INFO : sub dir: Removing directory 2021/12/01 05:10:54 INFO : nested/sub dir: Removing directory 2021/12/01 05:10:54 INFO : nested: Removing directory 2021/12/01 05:10:54 DEBUG : Local file system at /tmp/rclone2010825627: deleted 3 directories --- PASS: TestMoveWithDeleteEmptySrcDirs (4.00s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:10:56 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:10:56 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:10:56 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/12/01 05:10:56 INFO : sub dir/hello world: Copied (new) 2021/12/01 05:10:56 INFO : sub dir/hello world: Deleted 2021/12/01 05:10:57 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2021/12/01 05:10:57 INFO : nested/sub dir/file: Copied (new) 2021/12/01 05:10:57 INFO : nested/sub dir/file: Deleted --- PASS: TestMoveWithoutDeleteEmptySrcDirs (3.06s) === RUN TestMoveWithIgnoreExisting run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:10:59 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:10:59 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:10:59 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2021/12/01 05:10:59 INFO : existing: Copied (new) 2021/12/01 05:10:59 INFO : existing: Deleted 2021/12/01 05:11:04 DEBUG : existing-b: sha1 = 321f6b7e8bf7f29aab89c5e41a555b1b0baa41a9 OK 2021/12/01 05:11:04 INFO : existing-b: Copied (new) 2021/12/01 05:11:04 INFO : existing-b: Deleted 2021/12/01 05:11:04 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_list_file_names": EOF) 2021/12/01 05:11:04 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2021/12/01 05:11:05 DEBUG : pacer: Reducing sleep to 10ms 2021/12/01 05:11:05 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:11:05 DEBUG : existing: Destination exists, skipping 2021/12/01 05:11:05 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2021/12/01 05:11:05 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:11:05 INFO : There was nothing to transfer --- PASS: TestMoveWithIgnoreExisting (8.80s) === RUN TestServerSideMove run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:11:08 DEBUG : Creating backend with remote "TestB2:rclone-test-liyohar2culidiz9vipoyis6" 2021/12/01 05:11:08 DEBUG : Config file has changed externaly - reloading sync_test.go:1215: Server side move (if possible) B2 bucket rclone-test-cifayex8xabekoq3cihecit6 -> B2 bucket rclone-test-liyohar2culidiz9vipoyis6 2021/12/01 05:11:14 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ms) 2021/12/01 05:11:14 DEBUG : empty space: Unchanged skipping 2021/12/01 05:11:14 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2021/12/01 05:11:14 DEBUG : B2 bucket rclone-test-liyohar2culidiz9vipoyis6: Waiting for checks to finish 2021/12/01 05:11:15 INFO : empty space: Deleted 2021/12/01 05:11:15 DEBUG : B2 bucket rclone-test-liyohar2culidiz9vipoyis6: Waiting for transfers to finish 2021/12/01 05:11:15 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2021/12/01 05:11:15 INFO : potato3: Copied (server-side copy) 2021/12/01 05:11:15 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/12/01 05:11:15 INFO : potato2: Copied (server-side copy) 2021/12/01 05:11:16 INFO : potato3: Deleted 2021/12/01 05:11:16 INFO : potato2: Deleted 2021/12/01 05:11:16 DEBUG : Creating backend with remote "TestB2:rclone-test-qusoyiz4ruqeruq4zasopit0" 2021/12/01 05:11:17 DEBUG : B2 bucket rclone-test-qusoyiz4ruqeruq4zasopit0: Waiting for checks to finish 2021/12/01 05:11:17 DEBUG : B2 bucket rclone-test-qusoyiz4ruqeruq4zasopit0: Waiting for transfers to finish 2021/12/01 05:11:20 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2021/12/01 05:11:20 INFO : potato3: Copied (server-side copy) 2021/12/01 05:11:20 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2021/12/01 05:11:20 INFO : empty space: Copied (server-side copy) 2021/12/01 05:11:20 INFO : potato3: Deleted 2021/12/01 05:11:20 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/12/01 05:11:20 INFO : potato2: Copied (server-side copy) 2021/12/01 05:11:21 INFO : potato2: Deleted 2021/12/01 05:11:21 INFO : empty space: Deleted 2021/12/01 05:11:22 DEBUG : B2 bucket rclone-test-qusoyiz4ruqeruq4zasopit0: Purge remote 2021/12/01 05:11:22 DEBUG : empty space: Deleting (id "4_zff327d83607d7b4b7fd80e1b_f1099e6a21546e8bb_d20211201_m051119_c001_v0001041_t0033") 2021/12/01 05:11:22 DEBUG : potato2: Deleting (id "4_zff327d83607d7b4b7fd80e1b_f109191615d96bc9a_d20211201_m051119_c001_v0001044_t0051") 2021/12/01 05:11:22 DEBUG : potato3: Deleting (id "4_zff327d83607d7b4b7fd80e1b_f113a227326a910fc_d20211201_m051119_c001_v0001120_t0016") 2021/12/01 05:11:22 DEBUG : B2 bucket rclone-test-liyohar2culidiz9vipoyis6: Purge remote 2021/12/01 05:11:23 DEBUG : empty space: Deleting (id "4_zdf025de3607d7b4b7fd80e1b_f1026980c72e1c18b_d20211201_m051120_c001_v0001013_t0036") 2021/12/01 05:11:23 DEBUG : empty space: Deleting (id "4_zdf025de3607d7b4b7fd80e1b_f106c6c5c84529a48_d20211201_m051112_c001_v0001017_t0002") 2021/12/01 05:11:23 DEBUG : potato2: Deleting (id "4_zdf025de3607d7b4b7fd80e1b_f108a694dcbb559d2_d20211201_m051120_c001_v0001117_t0038") 2021/12/01 05:11:23 DEBUG : potato2: Deleting (id "4_zdf025de3607d7b4b7fd80e1b_f1056367a5a18f52c_d20211201_m051115_c001_v0001001_t0007") 2021/12/01 05:11:23 DEBUG : potato3: Deleting (id "4_zdf025de3607d7b4b7fd80e1b_f1141b2e1033b0ff2_d20211201_m051120_c001_v0001157_t0046") 2021/12/01 05:11:23 DEBUG : potato3: Deleting (id "4_zdf025de3607d7b4b7fd80e1b_f103fa11be02659aa_d20211201_m051115_c001_v0001093_t0018") 2021/12/01 05:11:23 DEBUG : potato3: Deleting (id "4_zdf025de3607d7b4b7fd80e1b_f106c6c5c84529a4a_d20211201_m051113_c001_v0001017_t0036") --- PASS: TestServerSideMove (16.38s) === RUN TestServerSideMoveWithFilter run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:11:24 DEBUG : Creating backend with remote "TestB2:rclone-test-dezobec0royuder0mapemih9" sync_test.go:1215: Server side move (if possible) B2 bucket rclone-test-cifayex8xabekoq3cihecit6 -> B2 bucket rclone-test-dezobec0royuder0mapemih9 2021/12/01 05:11:37 DEBUG : empty space: Excluded from sync (and deletion) 2021/12/01 05:11:37 DEBUG : empty space: Excluded from sync (and deletion) 2021/12/01 05:11:37 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2021/12/01 05:11:37 DEBUG : B2 bucket rclone-test-dezobec0royuder0mapemih9: Waiting for checks to finish 2021/12/01 05:11:37 DEBUG : B2 bucket rclone-test-dezobec0royuder0mapemih9: Waiting for transfers to finish 2021/12/01 05:11:38 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/12/01 05:11:38 INFO : potato2: Copied (server-side copy) 2021/12/01 05:11:38 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2021/12/01 05:11:38 INFO : potato3: Copied (server-side copy) 2021/12/01 05:11:39 INFO : potato3: Deleted 2021/12/01 05:11:39 INFO : potato2: Deleted 2021/12/01 05:11:40 DEBUG : Creating backend with remote "TestB2:rclone-test-cequfaj0tawenul4lefilox6" 2021/12/01 05:11:41 DEBUG : empty space: Excluded from sync (and deletion) 2021/12/01 05:11:41 DEBUG : B2 bucket rclone-test-cequfaj0tawenul4lefilox6: Waiting for checks to finish 2021/12/01 05:11:41 DEBUG : B2 bucket rclone-test-cequfaj0tawenul4lefilox6: Waiting for transfers to finish 2021/12/01 05:11:42 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/12/01 05:11:42 INFO : potato2: Copied (server-side copy) 2021/12/01 05:11:43 INFO : potato2: Deleted 2021/12/01 05:11:43 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2021/12/01 05:11:43 INFO : potato3: Copied (server-side copy) 2021/12/01 05:11:44 INFO : potato3: Deleted 2021/12/01 05:11:44 DEBUG : B2 bucket rclone-test-cequfaj0tawenul4lefilox6: Purge remote 2021/12/01 05:11:44 DEBUG : potato2: Deleting (id "4_z1ff2dd43607d7b4b7fd80e1b_f106060f988779312_d20211201_m051141_c001_v0001157_t0025") 2021/12/01 05:11:44 DEBUG : potato3: Deleting (id "4_z1ff2dd43607d7b4b7fd80e1b_f108d5b89115d799e_d20211201_m051142_c001_v0001003_t0020") 2021/12/01 05:11:45 DEBUG : B2 bucket rclone-test-dezobec0royuder0mapemih9: Purge remote 2021/12/01 05:11:46 DEBUG : empty space: Deleting (id "4_zef72ade3607d7b4b7fd80e1b_f100c32f98536edd8_d20211201_m051133_c001_v0001117_t0022") 2021/12/01 05:11:46 DEBUG : potato2: Deleting (id "4_zef72ade3607d7b4b7fd80e1b_f115e59d8f22c78bd_d20211201_m051142_c001_v0001097_t0013") 2021/12/01 05:11:46 DEBUG : potato2: Deleting (id "4_zef72ade3607d7b4b7fd80e1b_f1194f69139442ba7_d20211201_m051138_c001_v0001117_t0023") 2021/12/01 05:11:46 DEBUG : potato3: Deleting (id "4_zef72ade3607d7b4b7fd80e1b_f10093e2df2a03576_d20211201_m051144_c001_v0001043_t0008") 2021/12/01 05:11:46 DEBUG : potato3: Deleting (id "4_zef72ade3607d7b4b7fd80e1b_f100ded582268080e_d20211201_m051138_c001_v0001097_t0057") 2021/12/01 05:11:46 DEBUG : potato3: Deleting (id "4_zef72ade3607d7b4b7fd80e1b_f100c32f98536ee1b_d20211201_m051136_c001_v0001117_t0043") --- PASS: TestServerSideMoveWithFilter (25.59s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:11:49 DEBUG : Creating backend with remote "TestB2:rclone-test-faraxob4wadonuq1ruqupum4" 2021/12/01 05:11:53 DEBUG : tomatoDir: Making directory sync_test.go:1215: Server side move (if possible) B2 bucket rclone-test-cifayex8xabekoq3cihecit6 -> B2 bucket rclone-test-faraxob4wadonuq1ruqupum4 2021/12/01 05:11:56 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ms) 2021/12/01 05:11:56 DEBUG : empty space: Unchanged skipping 2021/12/01 05:11:56 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2021/12/01 05:11:56 DEBUG : B2 bucket rclone-test-faraxob4wadonuq1ruqupum4: Waiting for checks to finish 2021/12/01 05:11:56 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/12/01 05:11:56 INFO : potato2: Copied (server-side copy) 2021/12/01 05:11:57 INFO : potato2: Deleted 2021/12/01 05:11:57 INFO : empty space: Deleted 2021/12/01 05:11:57 DEBUG : B2 bucket rclone-test-faraxob4wadonuq1ruqupum4: Waiting for transfers to finish 2021/12/01 05:11:59 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2021/12/01 05:11:59 INFO : potato3: Copied (server-side copy) 2021/12/01 05:11:59 INFO : potato3: Deleted 2021/12/01 05:12:00 DEBUG : Creating backend with remote "TestB2:rclone-test-jezotil2rijewed1naxemob7" 2021/12/01 05:12:01 DEBUG : tomatoDir: Making directory 2021/12/01 05:12:01 DEBUG : B2 bucket rclone-test-jezotil2rijewed1naxemob7: Waiting for checks to finish 2021/12/01 05:12:01 DEBUG : B2 bucket rclone-test-jezotil2rijewed1naxemob7: Waiting for transfers to finish 2021/12/01 05:12:02 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2021/12/01 05:12:02 INFO : empty space: Copied (server-side copy) 2021/12/01 05:12:02 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2021/12/01 05:12:02 INFO : potato3: Copied (server-side copy) 2021/12/01 05:12:02 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/12/01 05:12:02 INFO : potato2: Copied (server-side copy) 2021/12/01 05:12:02 INFO : empty space: Deleted 2021/12/01 05:12:02 INFO : potato3: Deleted 2021/12/01 05:12:04 INFO : potato2: Deleted 2021/12/01 05:12:04 DEBUG : B2 bucket rclone-test-jezotil2rijewed1naxemob7: Purge remote 2021/12/01 05:12:04 DEBUG : empty space: Deleting (id "4_z7fb22d23608d7b4b7fd80e1b_f119048f3d1a4adad_d20211201_m051202_c001_v0001093_t0048") 2021/12/01 05:12:04 DEBUG : potato2: Deleting (id "4_z7fb22d23608d7b4b7fd80e1b_f10278772f141ad22_d20211201_m051202_c001_v0001042_t0024") 2021/12/01 05:12:04 DEBUG : potato3: Deleting (id "4_z7fb22d23608d7b4b7fd80e1b_f118cd6f0365ed5bb_d20211201_m051202_c001_v0001161_t0013") 2021/12/01 05:12:05 DEBUG : B2 bucket rclone-test-faraxob4wadonuq1ruqupum4: Purge remote 2021/12/01 05:12:05 DEBUG : empty space: Deleting (id "4_z9f520d43608d7b4b7fd80e1b_f108e04990f1d6fb8_d20211201_m051202_c001_v0001041_t0033") 2021/12/01 05:12:05 DEBUG : empty space: Deleting (id "4_z9f520d43608d7b4b7fd80e1b_f1183e10aa60b43ef_d20211201_m051155_c001_v0001090_t0057") 2021/12/01 05:12:05 DEBUG : potato2: Deleting (id "4_z9f520d43608d7b4b7fd80e1b_f1143acee5fc93df9_d20211201_m051202_c001_v0001018_t0036") 2021/12/01 05:12:05 DEBUG : potato2: Deleting (id "4_z9f520d43608d7b4b7fd80e1b_f105ab676d99dcc12_d20211201_m051156_c001_v0001150_t0048") 2021/12/01 05:12:05 DEBUG : potato3: Deleting (id "4_z9f520d43608d7b4b7fd80e1b_f1149f05ee6d0efb5_d20211201_m051202_c001_v0001137_t0043") 2021/12/01 05:12:05 DEBUG : potato3: Deleting (id "4_z9f520d43608d7b4b7fd80e1b_f1061b75dc91bcb96_d20211201_m051157_c001_v0001144_t0022") 2021/12/01 05:12:05 DEBUG : potato3: Deleting (id "4_z9f520d43608d7b4b7fd80e1b_f1183e10aa60b43f3_d20211201_m051156_c001_v0001090_t0038") --- PASS: TestServerSideMoveDeleteEmptySourceDirs (17.53s) === RUN TestServerSideMoveOverlap run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:12:07 DEBUG : Creating backend with remote "TestB2:rclone-test-cifayex8xabekoq3cihecit6/rclone-move-test" 2021/12/01 05:12:08 DEBUG : Couldn't decode error response: EOF --- PASS: TestServerSideMoveOverlap (3.86s) === RUN TestSyncOverlap run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:12:11 DEBUG : Creating backend with remote "TestB2:rclone-test-cifayex8xabekoq3cihecit6/rclone-sync-test" 2021/12/01 05:12:11 DEBUG : Couldn't decode error response: EOF --- PASS: TestSyncOverlap (0.71s) === RUN TestSyncCompareDest run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:12:12 DEBUG : Creating backend with remote "TestB2:rclone-test-cifayex8xabekoq3cihecit6/dst" 2021/12/01 05:12:12 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:12:12 DEBUG : Creating backend with remote "TestB2:rclone-test-cifayex8xabekoq3cihecit6/CompareDest" 2021/12/01 05:12:12 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:12:13 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:12:13 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for checks to finish 2021/12/01 05:12:13 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for transfers to finish 2021/12/01 05:12:14 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/12/01 05:12:14 INFO : one: Copied (new) 2021/12/01 05:12:14 DEBUG : Waiting for deletions to finish 2021/12/01 05:12:15 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for checks to finish 2021/12/01 05:12:15 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:12:15 DEBUG : one: Sizes differ (src 5 vs dst 3) 2021/12/01 05:12:15 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for transfers to finish 2021/12/01 05:12:16 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2021/12/01 05:12:16 INFO : one: Copied (replaced existing) 2021/12/01 05:12:16 DEBUG : Waiting for deletions to finish 2021/12/01 05:12:18 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for checks to finish 2021/12/01 05:12:18 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/01 05:12:18 DEBUG : one: Destination found in --compare-dest, skipping 2021/12/01 05:12:18 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for transfers to finish 2021/12/01 05:12:18 DEBUG : Waiting for deletions to finish 2021/12/01 05:12:18 INFO : There was nothing to transfer 2021/12/01 05:12:19 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/01 05:12:19 DEBUG : two: Destination found in --compare-dest, skipping 2021/12/01 05:12:19 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for checks to finish 2021/12/01 05:12:20 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/01 05:12:20 DEBUG : one: Destination found in --compare-dest, skipping 2021/12/01 05:12:20 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for transfers to finish 2021/12/01 05:12:20 DEBUG : Waiting for deletions to finish 2021/12/01 05:12:20 INFO : There was nothing to transfer 2021/12/01 05:12:20 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/01 05:12:20 DEBUG : two: Destination found in --compare-dest, skipping 2021/12/01 05:12:20 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for checks to finish 2021/12/01 05:12:20 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/01 05:12:20 DEBUG : one: Destination found in --compare-dest, skipping 2021/12/01 05:12:20 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for transfers to finish 2021/12/01 05:12:20 DEBUG : Waiting for deletions to finish 2021/12/01 05:12:20 INFO : There was nothing to transfer 2021/12/01 05:12:21 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 2021/12/01 05:12:21 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2021/12/01 05:12:21 DEBUG : two: Destination found in --compare-dest, skipping 2021/12/01 05:12:21 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for checks to finish 2021/12/01 05:12:21 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/01 05:12:21 DEBUG : one: Destination found in --compare-dest, skipping 2021/12/01 05:12:21 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for transfers to finish 2021/12/01 05:12:21 DEBUG : Waiting for deletions to finish 2021/12/01 05:12:21 INFO : There was nothing to transfer 2021/12/01 05:12:22 DEBUG : two: Sizes differ (src 5 vs dst 3) 2021/12/01 05:12:22 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for checks to finish 2021/12/01 05:12:22 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/01 05:12:22 DEBUG : one: Destination found in --compare-dest, skipping 2021/12/01 05:12:22 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for transfers to finish 2021/12/01 05:12:23 DEBUG : two: sha1 = a4be8877ad88f3109a6411985a1f359e10e2d930 OK 2021/12/01 05:12:23 INFO : two: Copied (new) 2021/12/01 05:12:23 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (13.81s) === RUN TestSyncMultipleCompareDest run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:12:28 DEBUG : Creating backend with remote "TestB2:rclone-test-cifayex8xabekoq3cihecit6/dest" 2021/12/01 05:12:29 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:12:29 DEBUG : Creating backend with remote "TestB2:rclone-test-cifayex8xabekoq3cihecit6/pre-dest1" 2021/12/01 05:12:29 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:12:29 DEBUG : Creating backend with remote "TestB2:rclone-test-cifayex8xabekoq3cihecit6/pre-dest2" 2021/12/01 05:12:30 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:12:30 DEBUG : 1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:12:30 DEBUG : 1: Destination found in --compare-dest, skipping 2021/12/01 05:12:30 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:12:31 DEBUG : 2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:12:31 DEBUG : 2: Destination found in --compare-dest, skipping 2021/12/01 05:12:31 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:12:31 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:12:31 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dest: Waiting for checks to finish 2021/12/01 05:12:31 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dest: Waiting for transfers to finish 2021/12/01 05:12:32 DEBUG : 3: sha1 = 77de68daecd823babbb58edb1c8e14d7106e83bb OK 2021/12/01 05:12:32 INFO : 3: Copied (new) 2021/12/01 05:12:32 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (8.77s) === RUN TestSyncCopyDest run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:12:34 DEBUG : Creating backend with remote "TestB2:rclone-test-cifayex8xabekoq3cihecit6/dst" 2021/12/01 05:12:35 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:12:35 DEBUG : Creating backend with remote "TestB2:rclone-test-cifayex8xabekoq3cihecit6/CopyDest" 2021/12/01 05:12:35 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:12:35 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:12:35 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for checks to finish 2021/12/01 05:12:35 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for transfers to finish 2021/12/01 05:12:37 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/12/01 05:12:37 INFO : one: Copied (new) 2021/12/01 05:12:37 DEBUG : Waiting for deletions to finish 2021/12/01 05:12:38 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for checks to finish 2021/12/01 05:12:38 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:12:38 DEBUG : one: Sizes differ (src 5 vs dst 3) 2021/12/01 05:12:38 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for transfers to finish 2021/12/01 05:12:38 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2021/12/01 05:12:38 INFO : one: Copied (replaced existing) 2021/12/01 05:12:38 DEBUG : Waiting for deletions to finish 2021/12/01 05:12:41 DEBUG : Creating backend with remote "TestB2:rclone-test-cifayex8xabekoq3cihecit6/BackupDir" 2021/12/01 05:12:42 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:12:42 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for checks to finish 2021/12/01 05:12:42 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/01 05:12:42 DEBUG : one: Sizes differ (src 5 vs dst 3) 2021/12/01 05:12:43 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:12:44 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/12/01 05:12:44 INFO : one: Copied (server-side copy) 2021/12/01 05:12:45 INFO : one: Deleted 2021/12/01 05:12:45 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2021/12/01 05:12:45 INFO : one: Copied (server-side copy) 2021/12/01 05:12:45 DEBUG : one: Destination found in --copy-dest, using server-side copy 2021/12/01 05:12:45 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for transfers to finish 2021/12/01 05:12:45 DEBUG : Waiting for deletions to finish 2021/12/01 05:12:45 DEBUG : CopyDest/two: Clearing upload URL because of error: Post "https://pod-000-1117-17.backblaze.com/b2api/v1/b2_upload_file/8f42dde3603d7b4b7fd80e1b/c001_v0001117_t0039": EOF 2021/12/01 05:12:45 DEBUG : pacer: low level retry 1/1 (error Post "https://pod-000-1117-17.backblaze.com/b2api/v1/b2_upload_file/8f42dde3603d7b4b7fd80e1b/c001_v0001117_t0039": EOF) 2021/12/01 05:12:45 DEBUG : pacer: Rate limited, increasing sleep to 20ms run.go:283: Retry Put of "CopyDest/two" to B2 bucket rclone-test-cifayex8xabekoq3cihecit6: 1/10 (Post "https://pod-000-1117-17.backblaze.com/b2api/v1/b2_upload_file/8f42dde3603d7b4b7fd80e1b/c001_v0001117_t0039": EOF) 2021/12/01 05:12:48 DEBUG : pacer: Reducing sleep to 10ms 2021/12/01 05:12:49 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/01 05:12:49 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2021/12/01 05:12:49 INFO : two: Copied (server-side copy) 2021/12/01 05:12:49 DEBUG : two: Destination found in --copy-dest, using server-side copy 2021/12/01 05:12:49 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for checks to finish 2021/12/01 05:12:50 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/01 05:12:50 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/01 05:12:50 DEBUG : one: Unchanged skipping 2021/12/01 05:12:50 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for transfers to finish 2021/12/01 05:12:50 DEBUG : Waiting for deletions to finish 2021/12/01 05:12:50 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for checks to finish 2021/12/01 05:12:50 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/01 05:12:50 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/01 05:12:50 DEBUG : one: Unchanged skipping 2021/12/01 05:12:50 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/01 05:12:50 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/01 05:12:50 DEBUG : two: Unchanged skipping 2021/12/01 05:12:50 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for transfers to finish 2021/12/01 05:12:50 DEBUG : Waiting for deletions to finish 2021/12/01 05:12:50 INFO : There was nothing to transfer 2021/12/01 05:12:51 DEBUG : three: Sizes differ (src 7 vs dst 5) 2021/12/01 05:12:51 DEBUG : three: Destination not found in --copy-dest 2021/12/01 05:12:51 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for checks to finish 2021/12/01 05:12:51 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/01 05:12:51 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/01 05:12:51 DEBUG : one: Unchanged skipping 2021/12/01 05:12:52 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/01 05:12:52 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/01 05:12:52 DEBUG : two: Unchanged skipping 2021/12/01 05:12:52 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for transfers to finish 2021/12/01 05:12:52 DEBUG : three: sha1 = 370e613335f3cf2f19b2a2d35a86402f55c659f8 OK 2021/12/01 05:12:52 INFO : three: Copied (new) 2021/12/01 05:12:52 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCopyDest (30.35s) === RUN TestSyncBackupDir run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:13:06 DEBUG : Creating backend with remote "TestB2:rclone-test-cifayex8xabekoq3cihecit6/dst" 2021/12/01 05:13:07 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:13:07 DEBUG : Creating backend with remote "TestB2:rclone-test-cifayex8xabekoq3cihecit6/backup" 2021/12/01 05:13:07 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:13:08 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/12/01 05:13:08 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:13:08 DEBUG : two: Unchanged skipping 2021/12/01 05:13:08 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for checks to finish 2021/12/01 05:13:08 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:13:09 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/12/01 05:13:09 INFO : one: Copied (server-side copy) 2021/12/01 05:13:09 INFO : one: Deleted 2021/12/01 05:13:09 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for transfers to finish 2021/12/01 05:13:12 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/12/01 05:13:12 INFO : one: Copied (new) 2021/12/01 05:13:12 DEBUG : Waiting for deletions to finish 2021/12/01 05:13:12 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:13:14 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2021/12/01 05:13:14 INFO : three.txt: Copied (server-side copy) 2021/12/01 05:13:14 INFO : three.txt: Deleted 2021/12/01 05:13:14 INFO : three.txt: Moved into backup dir 2021/12/01 05:13:16 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/12/01 05:13:16 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for checks to finish 2021/12/01 05:13:16 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:13:16 DEBUG : two: Unchanged skipping 2021/12/01 05:13:16 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/12/01 05:13:16 INFO : one: Copied (server-side copy) 2021/12/01 05:13:18 INFO : one: Deleted 2021/12/01 05:13:18 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for transfers to finish 2021/12/01 05:13:21 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2021/12/01 05:13:21 INFO : one: Copied (new) 2021/12/01 05:13:21 DEBUG : Waiting for deletions to finish 2021/12/01 05:13:23 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2021/12/01 05:13:23 INFO : three.txt: Copied (server-side copy) 2021/12/01 05:13:24 INFO : three.txt: Deleted 2021/12/01 05:13:24 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (21.84s) === RUN TestSyncBackupDirWithSuffix run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:13:28 DEBUG : Creating backend with remote "TestB2:rclone-test-cifayex8xabekoq3cihecit6/dst" 2021/12/01 05:13:29 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:13:29 DEBUG : Creating backend with remote "TestB2:rclone-test-cifayex8xabekoq3cihecit6/backup" 2021/12/01 05:13:30 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:13:30 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/12/01 05:13:30 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:13:30 DEBUG : two: Unchanged skipping 2021/12/01 05:13:30 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for checks to finish 2021/12/01 05:13:30 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:13:32 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/12/01 05:13:32 INFO : one: Copied (server-side copy) to: one.bak 2021/12/01 05:13:33 INFO : one: Deleted 2021/12/01 05:13:33 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for transfers to finish 2021/12/01 05:13:34 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/12/01 05:13:34 INFO : one: Copied (new) 2021/12/01 05:13:34 DEBUG : Waiting for deletions to finish 2021/12/01 05:13:34 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:13:35 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2021/12/01 05:13:35 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2021/12/01 05:13:36 INFO : three.txt: Deleted 2021/12/01 05:13:36 INFO : three.txt: Moved into backup dir 2021/12/01 05:13:37 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/12/01 05:13:37 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:13:37 DEBUG : two: Unchanged skipping 2021/12/01 05:13:37 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for checks to finish 2021/12/01 05:13:40 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/12/01 05:13:40 INFO : one: Copied (server-side copy) to: one.bak 2021/12/01 05:13:40 INFO : one: Deleted 2021/12/01 05:13:40 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for transfers to finish 2021/12/01 05:13:41 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2021/12/01 05:13:41 INFO : one: Copied (new) 2021/12/01 05:13:41 DEBUG : Waiting for deletions to finish 2021/12/01 05:13:42 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2021/12/01 05:13:42 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2021/12/01 05:13:43 INFO : three.txt: Deleted 2021/12/01 05:13:43 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (19.41s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:13:47 DEBUG : Creating backend with remote "TestB2:rclone-test-cifayex8xabekoq3cihecit6/dst" 2021/12/01 05:13:49 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:13:49 DEBUG : Creating backend with remote "TestB2:rclone-test-cifayex8xabekoq3cihecit6/backup" 2021/12/01 05:13:49 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:13:49 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for checks to finish 2021/12/01 05:13:49 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/12/01 05:13:49 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:13:49 DEBUG : two: Unchanged skipping 2021/12/01 05:13:50 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:13:51 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/12/01 05:13:51 INFO : one: Copied (server-side copy) to: one-2019-01-01 2021/12/01 05:13:51 INFO : one: Deleted 2021/12/01 05:13:51 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for transfers to finish 2021/12/01 05:13:53 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/12/01 05:13:53 INFO : one: Copied (new) 2021/12/01 05:13:53 DEBUG : Waiting for deletions to finish 2021/12/01 05:13:53 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:13:54 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2021/12/01 05:13:54 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2021/12/01 05:13:55 INFO : three.txt: Deleted 2021/12/01 05:13:55 INFO : three.txt: Moved into backup dir 2021/12/01 05:13:56 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for checks to finish 2021/12/01 05:13:56 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/12/01 05:13:56 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:13:56 DEBUG : two: Unchanged skipping 2021/12/01 05:13:58 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/12/01 05:13:58 INFO : one: Copied (server-side copy) to: one-2019-01-01 2021/12/01 05:13:58 INFO : one: Deleted 2021/12/01 05:13:58 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for transfers to finish 2021/12/01 05:14:00 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2021/12/01 05:14:00 INFO : one: Copied (new) 2021/12/01 05:14:00 DEBUG : Waiting for deletions to finish 2021/12/01 05:14:01 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2021/12/01 05:14:01 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2021/12/01 05:14:02 INFO : three.txt: Deleted 2021/12/01 05:14:02 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (30.12s) === RUN TestSyncBackupDirSuffixOnly run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:14:17 DEBUG : Creating backend with remote "TestB2:rclone-test-cifayex8xabekoq3cihecit6/dst" 2021/12/01 05:14:19 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:14:19 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/12/01 05:14:19 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:14:19 DEBUG : two: Unchanged skipping 2021/12/01 05:14:19 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for checks to finish 2021/12/01 05:14:19 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:14:21 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/12/01 05:14:21 INFO : one: Copied (server-side copy) to: one.bak 2021/12/01 05:14:23 INFO : one: Deleted 2021/12/01 05:14:23 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for transfers to finish 2021/12/01 05:14:26 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/12/01 05:14:26 INFO : one: Copied (new) 2021/12/01 05:14:26 DEBUG : Waiting for deletions to finish 2021/12/01 05:14:27 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:14:27 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2021/12/01 05:14:27 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2021/12/01 05:14:29 INFO : three.txt: Deleted 2021/12/01 05:14:29 INFO : three.txt: Moved into backup dir 2021/12/01 05:14:30 DEBUG : one.bak: Excluded from sync (and deletion) 2021/12/01 05:14:30 DEBUG : three.txt.bak: Excluded from sync (and deletion) 2021/12/01 05:14:30 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for checks to finish 2021/12/01 05:14:30 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/12/01 05:14:30 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:14:30 DEBUG : two: Unchanged skipping 2021/12/01 05:14:30 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/12/01 05:14:30 INFO : one: Copied (server-side copy) to: one.bak 2021/12/01 05:14:31 INFO : one: Deleted 2021/12/01 05:14:31 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6 path dst: Waiting for transfers to finish 2021/12/01 05:14:32 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2021/12/01 05:14:32 INFO : one: Copied (new) 2021/12/01 05:14:32 DEBUG : Waiting for deletions to finish 2021/12/01 05:14:33 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2021/12/01 05:14:33 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2021/12/01 05:14:33 INFO : three.txt: Deleted 2021/12/01 05:14:33 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (24.18s) === RUN TestSyncSuffix run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:14:41 DEBUG : Creating backend with remote "TestB2:rclone-test-cifayex8xabekoq3cihecit6/dst" 2021/12/01 05:14:43 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:14:43 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/12/01 05:14:43 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:14:45 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/12/01 05:14:45 INFO : one: Copied (server-side copy) to: one.bak 2021/12/01 05:14:46 INFO : one: Deleted 2021/12/01 05:14:47 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/12/01 05:14:47 INFO : one: Copied (new) 2021/12/01 05:14:47 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:14:47 DEBUG : two: Unchanged skipping 2021/12/01 05:14:47 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2021/12/01 05:14:47 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:14:48 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2021/12/01 05:14:48 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2021/12/01 05:14:51 INFO : three.txt: Deleted 2021/12/01 05:14:52 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2021/12/01 05:14:52 INFO : three.txt: Copied (new) 2021/12/01 05:14:53 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/12/01 05:15:01 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/12/01 05:15:01 INFO : one: Copied (server-side copy) to: one.bak 2021/12/01 05:15:02 INFO : one: Deleted 2021/12/01 05:15:03 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2021/12/01 05:15:03 INFO : one: Copied (new) 2021/12/01 05:15:04 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:15:04 DEBUG : two: Unchanged skipping 2021/12/01 05:15:04 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2021/12/01 05:15:05 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2021/12/01 05:15:05 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2021/12/01 05:15:05 INFO : three.txt: Deleted 2021/12/01 05:15:06 DEBUG : three.txt: sha1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK 2021/12/01 05:15:06 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (30.82s) === RUN TestSyncSuffixKeepExtension run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:15:12 DEBUG : Creating backend with remote "TestB2:rclone-test-cifayex8xabekoq3cihecit6/dst" 2021/12/01 05:15:14 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:15:14 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/12/01 05:15:14 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:15:16 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/12/01 05:15:16 INFO : one: Copied (server-side copy) to: one-2019-01-01 2021/12/01 05:15:17 INFO : one: Deleted 2021/12/01 05:15:18 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/12/01 05:15:18 INFO : one: Copied (new) 2021/12/01 05:15:18 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:15:18 DEBUG : two: Unchanged skipping 2021/12/01 05:15:18 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2021/12/01 05:15:19 DEBUG : Couldn't decode error response: EOF 2021/12/01 05:15:21 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2021/12/01 05:15:21 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2021/12/01 05:15:21 INFO : three.txt: Deleted 2021/12/01 05:15:22 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2021/12/01 05:15:22 INFO : three.txt: Copied (new) 2021/12/01 05:15:23 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/12/01 05:15:25 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/12/01 05:15:25 INFO : one: Copied (server-side copy) to: one-2019-01-01 2021/12/01 05:15:25 INFO : one: Deleted 2021/12/01 05:15:26 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2021/12/01 05:15:26 INFO : one: Copied (new) 2021/12/01 05:15:26 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:15:26 DEBUG : two: Unchanged skipping 2021/12/01 05:15:26 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2021/12/01 05:15:27 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2021/12/01 05:15:27 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2021/12/01 05:15:28 INFO : three.txt: Deleted 2021/12/01 05:15:28 DEBUG : three.txt: sha1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK 2021/12/01 05:15:28 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (24.00s) === RUN TestSyncUTFNorm run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:15:36 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2021/12/01 05:15:36 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:15:36 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:15:36 DEBUG : Testêé: sha1 = a54d88e06612d820bc3be72877c74f257b561b19 OK 2021/12/01 05:15:36 INFO : Testêé: Copied (replaced existing) to: Testêé 2021/12/01 05:15:36 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (2.21s) === RUN TestSyncImmutable run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:15:37 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:15:37 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:15:38 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2021/12/01 05:15:38 INFO : existing: Copied (new) 2021/12/01 05:15:38 DEBUG : Waiting for deletions to finish 2021/12/01 05:15:38 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2021/12/01 05:15:38 ERROR : existing: Source and destination exist but do not match: immutable file modified 2021/12/01 05:15:38 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:15:38 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:15:38 ERROR : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: not deleting files as there were IO errors 2021/12/01 05:15:38 ERROR : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: not deleting directories as there were IO errors --- PASS: TestSyncImmutable (1.97s) === RUN TestSyncIgnoreCase run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:15:42 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:15:42 DEBUG : existing: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:15:42 DEBUG : existing: Unchanged skipping 2021/12/01 05:15:42 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:15:42 DEBUG : Waiting for deletions to finish 2021/12/01 05:15:42 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (5.51s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" sync_test.go:1989: This test only runs on local === RUN TestMaxTransfer/Soft run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" sync_test.go:1989: This test only runs on local === RUN TestMaxTransfer/Cautious run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" sync_test.go:1989: This test only runs on local --- PASS: TestMaxTransfer (1.10s) --- SKIP: TestMaxTransfer/Hard (0.36s) --- SKIP: TestMaxTransfer/Soft (0.38s) --- SKIP: TestMaxTransfer/Cautious (0.36s) === RUN TestSyncConcurrentDelete run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:15:56 DEBUG : both1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:15:56 DEBUG : both1: Unchanged skipping 2021/12/01 05:15:56 DEBUG : both11: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:15:56 DEBUG : both10: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:15:56 DEBUG : both11: Unchanged skipping 2021/12/01 05:15:56 DEBUG : both10: Unchanged skipping 2021/12/01 05:15:56 DEBUG : both13: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:15:56 DEBUG : both14: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:15:56 DEBUG : both13: Unchanged skipping 2021/12/01 05:15:56 DEBUG : both14: Unchanged skipping 2021/12/01 05:15:56 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:15:56 DEBUG : both0: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:15:56 DEBUG : both0: Unchanged skipping 2021/12/01 05:15:56 DEBUG : both17: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:15:56 DEBUG : both17: Unchanged skipping 2021/12/01 05:15:56 DEBUG : both18: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:15:56 DEBUG : both18: Unchanged skipping 2021/12/01 05:15:56 DEBUG : both19: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:15:56 DEBUG : both19: Unchanged skipping 2021/12/01 05:15:56 DEBUG : both2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:15:56 DEBUG : both2: Unchanged skipping 2021/12/01 05:15:56 DEBUG : both3: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:15:56 DEBUG : both3: Unchanged skipping 2021/12/01 05:15:56 DEBUG : both4: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:15:56 DEBUG : both4: Unchanged skipping 2021/12/01 05:15:56 DEBUG : both5: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:15:56 DEBUG : both5: Unchanged skipping 2021/12/01 05:15:56 DEBUG : both12: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:15:56 DEBUG : both6: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:15:56 DEBUG : both6: Unchanged skipping 2021/12/01 05:15:56 DEBUG : both12: Unchanged skipping 2021/12/01 05:15:56 DEBUG : both15: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:15:56 DEBUG : both15: Unchanged skipping 2021/12/01 05:15:56 DEBUG : both9: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:15:56 DEBUG : both7: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:15:56 DEBUG : both7: Unchanged skipping 2021/12/01 05:15:56 DEBUG : both8: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:15:56 DEBUG : both8: Unchanged skipping 2021/12/01 05:15:56 DEBUG : both9: Unchanged skipping 2021/12/01 05:15:56 DEBUG : both16: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:15:56 DEBUG : both16: Unchanged skipping 2021/12/01 05:15:56 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:15:56 DEBUG : Waiting for deletions to finish 2021/12/01 05:15:56 INFO : only14: Deleted 2021/12/01 05:15:57 INFO : only17: Deleted 2021/12/01 05:15:57 INFO : only15: Deleted 2021/12/01 05:15:58 INFO : only10: Deleted 2021/12/01 05:15:58 INFO : only18: Deleted 2021/12/01 05:15:58 INFO : only7: Deleted 2021/12/01 05:15:58 INFO : only9: Deleted 2021/12/01 05:15:58 INFO : only0: Deleted 2021/12/01 05:15:58 INFO : only5: Deleted 2021/12/01 05:15:59 INFO : only13: Deleted 2021/12/01 05:15:59 INFO : only4: Deleted 2021/12/01 05:15:59 INFO : only16: Deleted 2021/12/01 05:15:59 INFO : only19: Deleted 2021/12/01 05:15:59 INFO : only8: Deleted 2021/12/01 05:16:00 INFO : only6: Deleted 2021/12/01 05:16:00 INFO : only11: Deleted 2021/12/01 05:16:00 INFO : only1: Deleted 2021/12/01 05:16:00 INFO : only2: Deleted 2021/12/01 05:16:00 INFO : only12: Deleted 2021/12/01 05:16:01 INFO : only3: Deleted 2021/12/01 05:16:01 INFO : There was nothing to transfer --- PASS: TestSyncConcurrentDelete (29.08s) === RUN TestSyncConcurrentTruncate run.go:181: Remote "B2 bucket rclone-test-cifayex8xabekoq3cihecit6", Local "Local file system at /tmp/rclone2010825627", Modify Window "1ms" 2021/12/01 05:16:26 DEBUG : both0: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:16:26 DEBUG : both0: Unchanged skipping 2021/12/01 05:16:26 DEBUG : both12: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:16:26 DEBUG : both12: Unchanged skipping 2021/12/01 05:16:26 DEBUG : both13: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:16:26 DEBUG : both13: Unchanged skipping 2021/12/01 05:16:26 DEBUG : both11: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:16:26 DEBUG : both10: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:16:26 DEBUG : both10: Unchanged skipping 2021/12/01 05:16:26 DEBUG : both15: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:16:26 DEBUG : both15: Unchanged skipping 2021/12/01 05:16:26 DEBUG : both16: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:16:26 DEBUG : both16: Unchanged skipping 2021/12/01 05:16:26 DEBUG : both17: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:16:26 DEBUG : both17: Unchanged skipping 2021/12/01 05:16:26 DEBUG : both18: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:16:26 DEBUG : both18: Unchanged skipping 2021/12/01 05:16:26 DEBUG : both19: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:16:26 DEBUG : both19: Unchanged skipping 2021/12/01 05:16:26 DEBUG : both2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:16:26 DEBUG : both2: Unchanged skipping 2021/12/01 05:16:26 DEBUG : both3: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:16:26 DEBUG : both3: Unchanged skipping 2021/12/01 05:16:26 DEBUG : both4: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:16:26 DEBUG : both4: Unchanged skipping 2021/12/01 05:16:26 DEBUG : both5: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:16:26 DEBUG : both5: Unchanged skipping 2021/12/01 05:16:26 DEBUG : both6: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:16:26 DEBUG : both6: Unchanged skipping 2021/12/01 05:16:26 DEBUG : both7: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:16:26 DEBUG : both7: Unchanged skipping 2021/12/01 05:16:26 DEBUG : both8: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:16:26 DEBUG : both8: Unchanged skipping 2021/12/01 05:16:26 DEBUG : both9: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:16:26 DEBUG : both9: Unchanged skipping 2021/12/01 05:16:26 DEBUG : both14: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:16:26 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2021/12/01 05:16:26 DEBUG : both14: Unchanged skipping 2021/12/01 05:16:26 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2021/12/01 05:16:26 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2021/12/01 05:16:26 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2021/12/01 05:16:26 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2021/12/01 05:16:26 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2021/12/01 05:16:26 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2021/12/01 05:16:26 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2021/12/01 05:16:26 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2021/12/01 05:16:26 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2021/12/01 05:16:26 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2021/12/01 05:16:26 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2021/12/01 05:16:26 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2021/12/01 05:16:26 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2021/12/01 05:16:26 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2021/12/01 05:16:26 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2021/12/01 05:16:26 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2021/12/01 05:16:26 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2021/12/01 05:16:26 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2021/12/01 05:16:26 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2021/12/01 05:16:26 DEBUG : both11: Unchanged skipping 2021/12/01 05:16:26 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for checks to finish 2021/12/01 05:16:26 DEBUG : both1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/01 05:16:26 DEBUG : both1: Unchanged skipping 2021/12/01 05:16:26 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Waiting for transfers to finish 2021/12/01 05:16:26 DEBUG : only0: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/01 05:16:26 INFO : only0: Copied (replaced existing) 2021/12/01 05:16:26 DEBUG : only13: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/01 05:16:26 INFO : only13: Copied (replaced existing) 2021/12/01 05:16:27 DEBUG : only1: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/01 05:16:27 INFO : only1: Copied (replaced existing) 2021/12/01 05:16:27 DEBUG : only14: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/01 05:16:27 INFO : only14: Copied (replaced existing) 2021/12/01 05:16:27 DEBUG : only16: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/01 05:16:27 INFO : only16: Copied (replaced existing) 2021/12/01 05:16:27 DEBUG : only15: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/01 05:16:27 INFO : only15: Copied (replaced existing) 2021/12/01 05:16:27 DEBUG : only10: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/01 05:16:27 INFO : only10: Copied (replaced existing) 2021/12/01 05:16:27 DEBUG : only17: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/01 05:16:27 INFO : only17: Copied (replaced existing) 2021/12/01 05:16:27 DEBUG : only18: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/01 05:16:27 INFO : only18: Copied (replaced existing) 2021/12/01 05:16:27 DEBUG : only2: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/01 05:16:27 INFO : only2: Copied (replaced existing) 2021/12/01 05:16:27 DEBUG : only12: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/01 05:16:27 INFO : only12: Copied (replaced existing) 2021/12/01 05:16:28 DEBUG : only4: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/01 05:16:28 INFO : only4: Copied (replaced existing) 2021/12/01 05:16:28 DEBUG : only19: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/01 05:16:28 INFO : only19: Copied (replaced existing) 2021/12/01 05:16:28 DEBUG : only6: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/01 05:16:28 INFO : only6: Copied (replaced existing) 2021/12/01 05:16:28 DEBUG : only8: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/01 05:16:28 INFO : only8: Copied (replaced existing) 2021/12/01 05:16:28 DEBUG : only9: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/01 05:16:28 INFO : only9: Copied (replaced existing) 2021/12/01 05:16:28 DEBUG : only7: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/01 05:16:28 INFO : only7: Copied (replaced existing) 2021/12/01 05:16:28 DEBUG : only5: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/01 05:16:28 INFO : only5: Copied (replaced existing) 2021/12/01 05:16:29 DEBUG : only11: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/01 05:16:29 INFO : only11: Copied (replaced existing) 2021/12/01 05:16:30 DEBUG : only3: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/01 05:16:30 INFO : only3: Copied (replaced existing) 2021/12/01 05:16:30 DEBUG : Waiting for deletions to finish --- PASS: TestSyncConcurrentTruncate (47.88s) PASS 2021/12/01 05:17:03 DEBUG : B2 bucket rclone-test-cifayex8xabekoq3cihecit6: Purge remote 2021/12/01 05:17:03 DEBUG : BackupDir/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f101b59f5c253014b_d20211201_m051253_c001_v0001038_t0037") 2021/12/01 05:17:03 DEBUG : BackupDir/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f11490daaa3270699_d20211201_m051244_c001_v0001146_t0024") 2021/12/01 05:17:03 DEBUG : CompareDest/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f109f9a96ff661006_d20211201_m051223_c001_v0001038_t0003") 2021/12/01 05:17:03 DEBUG : CompareDest/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1174e483f502b199_d20211201_m051217_c001_v0001117_t0030") 2021/12/01 05:17:03 DEBUG : CompareDest/two: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1198a45f8b723ab1_d20211201_m051224_c001_v0001150_t0018") 2021/12/01 05:17:03 DEBUG : CompareDest/two: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e63c1_d20211201_m051219_c001_v0001165_t0004") 2021/12/01 05:17:03 DEBUG : CopyDest/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f11681881144765a6_d20211201_m051253_c001_v0001161_t0036") 2021/12/01 05:17:03 DEBUG : CopyDest/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6434_d20211201_m051241_c001_v0001165_t0036") 2021/12/01 05:17:03 DEBUG : CopyDest/three: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10526d05db427862_d20211201_m051254_c001_v0001117_t0027") 2021/12/01 05:17:03 DEBUG : CopyDest/three: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6479_d20211201_m051251_c001_v0001165_t0053") 2021/12/01 05:17:04 DEBUG : CopyDest/two: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1143f29a44459f11_d20211201_m051256_c001_v0001036_t0023") 2021/12/01 05:17:04 DEBUG : CopyDest/two: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e645c_d20211201_m051248_c001_v0001165_t0038") 2021/12/01 05:17:04 DEBUG : EXISTING: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10637d70bd9193ef_d20211201_m051542_c001_v0001036_t0020") 2021/12/01 05:17:04 DEBUG : EXISTING: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6969_d20211201_m051541_c001_v0001165_t0011") 2021/12/01 05:17:04 DEBUG : Testêé: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f117243f3ce382a74_d20211201_m051538_c001_v0001150_t0054") 2021/12/01 05:17:04 DEBUG : Testêé: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e694e_d20211201_m051537_c001_v0001165_t0026") 2021/12/01 05:17:04 DEBUG : Testêé: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6948_d20211201_m051536_c001_v0001165_t0035") 2021/12/01 05:17:04 DEBUG : a/potato2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f116153d8d5832916_d20211201_m051004_c001_v0001146_t0013") 2021/12/01 05:17:04 DEBUG : a/potato2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e60c4_d20211201_m051003_c001_v0001165_t0004") 2021/12/01 05:17:04 DEBUG : a/potato2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f102bca8860af6b61_d20211201_m050959_c001_v0001117_t0038") 2021/12/01 05:17:04 DEBUG : a/potato2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e608a_d20211201_m050957_c001_v0001165_t0057") 2021/12/01 05:17:04 DEBUG : a/potato2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119dc2fb13beeb00_d20211201_m050934_c001_v0001003_t0008") 2021/12/01 05:17:04 DEBUG : a/potato2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e5fe4_d20211201_m050933_c001_v0001165_t0035") 2021/12/01 05:17:04 DEBUG : b/potato: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10410dd554ef35ba_d20211201_m051004_c001_v0001097_t0019") 2021/12/01 05:17:04 DEBUG : b/potato: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e60b4_d20211201_m051002_c001_v0001165_t0034") 2021/12/01 05:17:04 DEBUG : b/potato: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f113b025f83c8c140_d20211201_m050957_c001_v0001097_t0027") 2021/12/01 05:17:05 DEBUG : b/potato: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6084_d20211201_m050956_c001_v0001165_t0059") 2021/12/01 05:17:05 DEBUG : b/potato: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f109390b6a12cd51c_d20211201_m050933_c001_v0001008_t0037") 2021/12/01 05:17:05 DEBUG : b/potato: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e5fdc_d20211201_m050932_c001_v0001165_t0004") 2021/12/01 05:17:05 DEBUG : backup/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1175c19a3364e353_d20211201_m051324_c001_v0001165_t0051") 2021/12/01 05:17:05 DEBUG : backup/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1028c155c6ca7aae_d20211201_m051316_c001_v0001038_t0009") 2021/12/01 05:17:05 DEBUG : backup/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f107a9f22bcef180f_d20211201_m051309_c001_v0001146_t0046") 2021/12/01 05:17:05 DEBUG : backup/one-2019-01-01: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1123cd9afa97ea93_d20211201_m051403_c001_v0001033_t0001") 2021/12/01 05:17:05 DEBUG : backup/one-2019-01-01: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f114b4733ef2718ca_d20211201_m051357_c001_v0001040_t0012") 2021/12/01 05:17:05 DEBUG : backup/one-2019-01-01: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1089b5ad15d0af3d_d20211201_m051351_c001_v0001093_t0033") 2021/12/01 05:17:05 DEBUG : backup/one.bak: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f107b4be53ada25a7_d20211201_m051343_c001_v0001097_t0016") 2021/12/01 05:17:05 DEBUG : backup/one.bak: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f112884b891f17427_d20211201_m051338_c001_v0001117_t0036") 2021/12/01 05:17:05 DEBUG : backup/one.bak: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f11047fc0bf7e73cb_d20211201_m051331_c001_v0001003_t0022") 2021/12/01 05:17:05 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f108a694dcbb563b5_d20211201_m051414_c001_v0001117_t0020") 2021/12/01 05:17:05 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f11716aa982c0e1ec_d20211201_m051401_c001_v0001090_t0005") 2021/12/01 05:17:05 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1174e483f502b804_d20211201_m051353_c001_v0001117_t0050") 2021/12/01 05:17:05 DEBUG : backup/three.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f11264cf7143f9254_d20211201_m051324_c001_v0001023_t0032") 2021/12/01 05:17:05 DEBUG : backup/three.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f112884b891f17317_d20211201_m051322_c001_v0001117_t0025") 2021/12/01 05:17:05 DEBUG : backup/three.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f108a694dcbb5602e_d20211201_m051312_c001_v0001117_t0003") 2021/12/01 05:17:05 DEBUG : backup/three.txt.bak: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1069503f0dfd45aa_d20211201_m051344_c001_v0001009_t0007") 2021/12/01 05:17:06 DEBUG : backup/three.txt.bak: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10509315d7c158f8_d20211201_m051342_c001_v0001038_t0004") 2021/12/01 05:17:06 DEBUG : backup/three.txt.bak: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f116df0cc0cdf04a5_d20211201_m051334_c001_v0001150_t0058") 2021/12/01 05:17:06 DEBUG : both0: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10526d05db428745_d20211201_m051630_c001_v0001117_t0046") 2021/12/01 05:17:06 DEBUG : both0: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6a99_d20211201_m051615_c001_v0001165_t0014") 2021/12/01 05:17:06 DEBUG : both0: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1109318fc8ff9423_d20211201_m051601_c001_v0001165_t0010") 2021/12/01 05:17:06 DEBUG : both0: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6997_d20211201_m051546_c001_v0001165_t0046") 2021/12/01 05:17:06 DEBUG : both1: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f113a436093c35822_d20211201_m051632_c001_v0001029_t0015") 2021/12/01 05:17:06 DEBUG : both1: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6aa4_d20211201_m051616_c001_v0001165_t0039") 2021/12/01 05:17:06 DEBUG : both1: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f11490daaa3270d41_d20211201_m051601_c001_v0001146_t0044") 2021/12/01 05:17:06 DEBUG : both1: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e69a1_d20211201_m051546_c001_v0001165_t0028") 2021/12/01 05:17:06 DEBUG : both10: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f116cd7d9464738fa_d20211201_m051632_c001_v0001041_t0004") 2021/12/01 05:17:06 DEBUG : both10: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6ae5_d20211201_m051620_c001_v0001165_t0032") 2021/12/01 05:17:06 DEBUG : both10: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1101847b8796262f_d20211201_m051602_c001_v0001153_t0004") 2021/12/01 05:17:06 DEBUG : both10: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e69db_d20211201_m051551_c001_v0001165_t0006") 2021/12/01 05:17:06 DEBUG : both11: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f106aa2e831b9b843_d20211201_m051633_c001_v0001117_t0032") 2021/12/01 05:17:06 DEBUG : both11: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6aea_d20211201_m051621_c001_v0001165_t0035") 2021/12/01 05:17:07 DEBUG : both11: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f106941c445ca51b3_d20211201_m051602_c001_v0001130_t0026") 2021/12/01 05:17:07 DEBUG : both11: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e69df_d20211201_m051551_c001_v0001165_t0024") 2021/12/01 05:17:07 DEBUG : both12: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f11820454122d3450_d20211201_m051634_c001_v0001146_t0000") 2021/12/01 05:17:07 DEBUG : both12: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6af3_d20211201_m051621_c001_v0001165_t0010") 2021/12/01 05:17:07 DEBUG : both12: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1194a177770b6aa4_d20211201_m051602_c001_v0001153_t0020") 2021/12/01 05:17:07 DEBUG : both12: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e69e6_d20211201_m051552_c001_v0001165_t0027") 2021/12/01 05:17:07 DEBUG : both13: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1174e483f502c2cf_d20211201_m051634_c001_v0001117_t0027") 2021/12/01 05:17:07 DEBUG : both13: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6afb_d20211201_m051622_c001_v0001165_t0027") 2021/12/01 05:17:07 DEBUG : both13: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f112fcac86ecc8188_d20211201_m051602_c001_v0001038_t0012") 2021/12/01 05:17:07 DEBUG : both13: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e69f1_d20211201_m051552_c001_v0001165_t0057") 2021/12/01 05:17:07 DEBUG : both14: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f116acb5520d69cd9_d20211201_m051636_c001_v0001093_t0033") 2021/12/01 05:17:07 DEBUG : both14: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6b04_d20211201_m051622_c001_v0001165_t0014") 2021/12/01 05:17:07 DEBUG : both14: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f11817352ae6fcbf6_d20211201_m051604_c001_v0001131_t0039") 2021/12/01 05:17:07 DEBUG : both14: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e69f7_d20211201_m051552_c001_v0001165_t0004") 2021/12/01 05:17:07 DEBUG : both15: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119b356153a35dc3_d20211201_m051636_c001_v0001043_t0001") 2021/12/01 05:17:07 DEBUG : both15: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6b0c_d20211201_m051623_c001_v0001165_t0013") 2021/12/01 05:17:07 DEBUG : both15: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1181113b2b0630bd_d20211201_m051604_c001_v0001093_t0044") 2021/12/01 05:17:08 DEBUG : both15: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e69fe_d20211201_m051553_c001_v0001165_t0026") 2021/12/01 05:17:08 DEBUG : both16: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f114158545e3f79e0_d20211201_m051636_c001_v0001044_t0003") 2021/12/01 05:17:08 DEBUG : both16: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6b11_d20211201_m051623_c001_v0001165_t0005") 2021/12/01 05:17:08 DEBUG : both16: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10912ed92ba4fac9_d20211201_m051605_c001_v0001097_t0056") 2021/12/01 05:17:08 DEBUG : both16: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6a07_d20211201_m051553_c001_v0001165_t0000") 2021/12/01 05:17:08 DEBUG : both17: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f117657634af7fb8b_d20211201_m051637_c001_v0001093_t0025") 2021/12/01 05:17:08 DEBUG : both17: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6b17_d20211201_m051623_c001_v0001165_t0010") 2021/12/01 05:17:08 DEBUG : both17: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1171c6faf7b068c6_d20211201_m051607_c001_v0001044_t0036") 2021/12/01 05:17:08 DEBUG : both17: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6a0e_d20211201_m051554_c001_v0001165_t0005") 2021/12/01 05:17:08 DEBUG : both18: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1137717f9f4377e3_d20211201_m051637_c001_v0001032_t0018") 2021/12/01 05:17:08 DEBUG : both18: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6b1e_d20211201_m051624_c001_v0001165_t0013") 2021/12/01 05:17:08 DEBUG : both18: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f108630f900ed9a91_d20211201_m051608_c001_v0001039_t0025") 2021/12/01 05:17:08 DEBUG : both18: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6a17_d20211201_m051554_c001_v0001165_t0037") 2021/12/01 05:17:08 DEBUG : both19: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f100d1a96eaef1b87_d20211201_m051638_c001_v0001130_t0018") 2021/12/01 05:17:08 DEBUG : both19: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6b27_d20211201_m051624_c001_v0001165_t0009") 2021/12/01 05:17:08 DEBUG : both19: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1130a5f9a5d8fc6c_d20211201_m051610_c001_v0001033_t0009") 2021/12/01 05:17:09 DEBUG : both19: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6a1c_d20211201_m051555_c001_v0001165_t0027") 2021/12/01 05:17:09 DEBUG : both2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1074005f0803b50c_d20211201_m051639_c001_v0001041_t0034") 2021/12/01 05:17:09 DEBUG : both2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6aa8_d20211201_m051616_c001_v0001165_t0058") 2021/12/01 05:17:09 DEBUG : both2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1111ba8bf5024494_d20211201_m051610_c001_v0001134_t0002") 2021/12/01 05:17:09 DEBUG : both2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e69a8_d20211201_m051547_c001_v0001165_t0034") 2021/12/01 05:17:09 DEBUG : both3: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f112638605fc374f9_d20211201_m051640_c001_v0001036_t0032") 2021/12/01 05:17:09 DEBUG : both3: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6aae_d20211201_m051617_c001_v0001165_t0004") 2021/12/01 05:17:09 DEBUG : both3: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1031557366ad06eb_d20211201_m051611_c001_v0001042_t0006") 2021/12/01 05:17:09 DEBUG : both3: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e69af_d20211201_m051547_c001_v0001165_t0057") 2021/12/01 05:17:09 DEBUG : both4: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10480beed20af3ec_d20211201_m051641_c001_v0001144_t0046") 2021/12/01 05:17:09 DEBUG : both4: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6ab8_d20211201_m051617_c001_v0001165_t0026") 2021/12/01 05:17:09 DEBUG : both4: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f102774b0d4436b51_d20211201_m051611_c001_v0001033_t0056") 2021/12/01 05:17:09 DEBUG : both4: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e69b9_d20211201_m051548_c001_v0001165_t0003") 2021/12/01 05:17:09 DEBUG : both5: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f105d515fce5b8d74_d20211201_m051643_c001_v0001037_t0032") 2021/12/01 05:17:09 DEBUG : both5: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6ac1_d20211201_m051618_c001_v0001165_t0034") 2021/12/01 05:17:09 DEBUG : both5: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f107b4be53ada3381_d20211201_m051612_c001_v0001097_t0013") 2021/12/01 05:17:09 DEBUG : both5: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e69bd_d20211201_m051548_c001_v0001165_t0001") 2021/12/01 05:17:09 DEBUG : both6: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f110dde850bdc440d_d20211201_m051643_c001_v0001006_t0042") 2021/12/01 05:17:09 DEBUG : both6: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6aca_d20211201_m051618_c001_v0001165_t0058") 2021/12/01 05:17:09 DEBUG : both6: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f11039bb94b84258f_d20211201_m051612_c001_v0001038_t0034") 2021/12/01 05:17:09 DEBUG : both6: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e69c2_d20211201_m051549_c001_v0001165_t0010") 2021/12/01 05:17:09 DEBUG : both7: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10480beed20af416_d20211201_m051646_c001_v0001144_t0012") 2021/12/01 05:17:10 DEBUG : both7: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6ad0_d20211201_m051619_c001_v0001165_t0052") 2021/12/01 05:17:10 DEBUG : both7: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1074c11b831e92aa_d20211201_m051613_c001_v0001030_t0032") 2021/12/01 05:17:10 DEBUG : both7: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e69c8_d20211201_m051549_c001_v0001165_t0054") 2021/12/01 05:17:10 DEBUG : both8: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f103dedf87de99e8e_d20211201_m051649_c001_v0001039_t0029") 2021/12/01 05:17:10 DEBUG : both8: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6ada_d20211201_m051619_c001_v0001165_t0022") 2021/12/01 05:17:10 DEBUG : both8: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1001cc8119897893_d20211201_m051614_c001_v0001009_t0018") 2021/12/01 05:17:10 DEBUG : both8: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e69ce_d20211201_m051550_c001_v0001165_t0009") 2021/12/01 05:17:10 DEBUG : both9: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1150c938302b8ac1_d20211201_m051650_c001_v0001145_t0002") 2021/12/01 05:17:10 DEBUG : both9: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6ae0_d20211201_m051620_c001_v0001165_t0031") 2021/12/01 05:17:10 DEBUG : both9: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f107b9066400f1ef2_d20211201_m051614_c001_v0001117_t0018") 2021/12/01 05:17:10 DEBUG : both9: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e69d4_d20211201_m051550_c001_v0001165_t0042") 2021/12/01 05:17:10 DEBUG : c/non empty space: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f109aaa45e0619fae_d20211201_m051006_c001_v0001033_t0032") 2021/12/01 05:17:10 DEBUG : c/non empty space: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e60b9_d20211201_m051003_c001_v0001165_t0024") 2021/12/01 05:17:10 DEBUG : c/non empty space: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f113e6c3fccbc2c05_d20211201_m051000_c001_v0001117_t0023") 2021/12/01 05:17:11 DEBUG : c/non empty space: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6086_d20211201_m050956_c001_v0001165_t0038") 2021/12/01 05:17:11 DEBUG : c/non empty space: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10595ff2507d1d80_d20211201_m050937_c001_v0001161_t0017") 2021/12/01 05:17:11 DEBUG : c/non empty space: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e5fde_d20211201_m050932_c001_v0001165_t0019") 2021/12/01 05:17:11 DEBUG : check sum: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f114f19876c8f3de3_d20211201_m050901_c001_v0001117_t0052") 2021/12/01 05:17:11 DEBUG : check sum: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f113312722a630efe_d20211201_m050855_c001_v0001144_t0016") 2021/12/01 05:17:11 DEBUG : dest/3: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10502ab829128cf0_d20211201_m051233_c001_v0001097_t0010") 2021/12/01 05:17:11 DEBUG : dest/3: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10595ff2507d2290_d20211201_m051232_c001_v0001161_t0018") 2021/12/01 05:17:11 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f115d779939d5d632_d20211201_m051528_c001_v0001117_t0031") 2021/12/01 05:17:11 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f117939a9d67560b9_d20211201_m051526_c001_v0001005_t0011") 2021/12/01 05:17:11 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f104591a377d6d94d_d20211201_m051525_c001_v0001091_t0000") 2021/12/01 05:17:11 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f117939a9d67560b1_d20211201_m051517_c001_v0001005_t0030") 2021/12/01 05:17:11 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f117002690a5f67b7_d20211201_m051516_c001_v0001097_t0056") 2021/12/01 05:17:11 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e688f_d20211201_m051512_c001_v0001165_t0006") 2021/12/01 05:17:11 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f11542aff09f00c81_d20211201_m051507_c001_v0001040_t0048") 2021/12/01 05:17:11 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10800751db4b8796_d20211201_m051503_c001_v0001150_t0014") 2021/12/01 05:17:12 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1140706ec730a24d_d20211201_m051502_c001_v0001029_t0041") 2021/12/01 05:17:12 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10800751db4b874d_d20211201_m051446_c001_v0001150_t0004") 2021/12/01 05:17:12 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f11304bed66ca7f8c_d20211201_m051445_c001_v0001145_t0013") 2021/12/01 05:17:12 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e67a6_d20211201_m051441_c001_v0001165_t0035") 2021/12/01 05:17:12 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f118229723a6225f0_d20211201_m051434_c001_v0001120_t0005") 2021/12/01 05:17:12 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f116e7ed843697181_d20211201_m051432_c001_v0001117_t0028") 2021/12/01 05:17:12 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f103517be1dadcb6e_d20211201_m051431_c001_v0001134_t0020") 2021/12/01 05:17:12 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f116e7ed8436970fa_d20211201_m051424_c001_v0001117_t0053") 2021/12/01 05:17:12 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f112c982f617dbf3b_d20211201_m051421_c001_v0001090_t0015") 2021/12/01 05:17:12 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e66f0_d20211201_m051416_c001_v0001165_t0053") 2021/12/01 05:17:12 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f117d23f462e2df6e_d20211201_m051415_c001_v0001161_t0026") 2021/12/01 05:17:12 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1100ca2176c2f346_d20211201_m051359_c001_v0001032_t0033") 2021/12/01 05:17:12 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f116111a55c9d8a5c_d20211201_m051358_c001_v0001043_t0011") 2021/12/01 05:17:12 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1100ca2176c2f334_d20211201_m051352_c001_v0001032_t0030") 2021/12/01 05:17:12 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1084cdcd3faaa772_d20211201_m051351_c001_v0001091_t0051") 2021/12/01 05:17:12 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e661c_d20211201_m051346_c001_v0001165_t0039") 2021/12/01 05:17:12 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f11652040dc0c9756_d20211201_m051345_c001_v0001029_t0026") 2021/12/01 05:17:12 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f113d1966b69fda07_d20211201_m051341_c001_v0001131_t0012") 2021/12/01 05:17:12 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f100326d0de2ab536_d20211201_m051340_c001_v0001145_t0054") 2021/12/01 05:17:13 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f113d1966b69fd9e9_d20211201_m051334_c001_v0001131_t0023") 2021/12/01 05:17:13 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f113e6c3fccbc3c11_d20211201_m051332_c001_v0001117_t0048") 2021/12/01 05:17:13 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e659a_d20211201_m051327_c001_v0001165_t0027") 2021/12/01 05:17:13 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f107e1086ea333982_d20211201_m051325_c001_v0001033_t0039") 2021/12/01 05:17:13 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f104c79e594d21ae8_d20211201_m051318_c001_v0001117_t0010") 2021/12/01 05:17:13 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f107b9066400f11fc_d20211201_m051317_c001_v0001117_t0004") 2021/12/01 05:17:13 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f104c79e594d21a4d_d20211201_m051310_c001_v0001117_t0037") 2021/12/01 05:17:13 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1068c6636364a20f_d20211201_m051309_c001_v0001043_t0057") 2021/12/01 05:17:13 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e64f0_d20211201_m051305_c001_v0001165_t0047") 2021/12/01 05:17:13 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10579538d7c6bc23_d20211201_m051256_c001_v0001144_t0033") 2021/12/01 05:17:13 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f112dcef9ef2b1a46_d20211201_m051245_c001_v0001165_t0044") 2021/12/01 05:17:13 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f112b6e569a4e6f6c_d20211201_m051244_c001_v0001130_t0056") 2021/12/01 05:17:13 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1174e483f502b305_d20211201_m051239_c001_v0001117_t0052") 2021/12/01 05:17:13 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10858b4793a7e433_d20211201_m051238_c001_v0001153_t0019") 2021/12/01 05:17:13 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10858b4793a7e42a_d20211201_m051236_c001_v0001153_t0018") 2021/12/01 05:17:13 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1080400c4b678706_d20211201_m051224_c001_v0001033_t0022") 2021/12/01 05:17:14 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e63b3_d20211201_m051216_c001_v0001165_t0057") 2021/12/01 05:17:14 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1002cd7d0e680445_d20211201_m051215_c001_v0001161_t0053") 2021/12/01 05:17:14 DEBUG : dst/one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1002cd7d0e68043e_d20211201_m051214_c001_v0001161_t0008") 2021/12/01 05:17:14 DEBUG : dst/one-2019-01-01: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f111c97bf26f8f1b8_d20211201_m051529_c001_v0001144_t0037") 2021/12/01 05:17:14 DEBUG : dst/one-2019-01-01: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1004428c0ca7cbf7_d20211201_m051523_c001_v0001033_t0049") 2021/12/01 05:17:14 DEBUG : dst/one-2019-01-01: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1003cd5b53ecb931_d20211201_m051515_c001_v0001030_t0015") 2021/12/01 05:17:14 DEBUG : dst/one.bak: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f117da1597626c983_d20211201_m051508_c001_v0001130_t0058") 2021/12/01 05:17:14 DEBUG : dst/one.bak: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f108233f87a3cc974_d20211201_m051501_c001_v0001097_t0030") 2021/12/01 05:17:14 DEBUG : dst/one.bak: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119d2fbedfcfc061_d20211201_m051444_c001_v0001134_t0013") 2021/12/01 05:17:14 DEBUG : dst/one.bak: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f112dcef9ef2b1dfb_d20211201_m051439_c001_v0001165_t0016") 2021/12/01 05:17:14 DEBUG : dst/one.bak: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f11234a4a69380d41_d20211201_m051430_c001_v0001161_t0002") 2021/12/01 05:17:14 DEBUG : dst/one.bak: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10199f82aa66e240_d20211201_m051420_c001_v0001041_t0004") 2021/12/01 05:17:14 DEBUG : dst/three: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f100c32f98536f3ce_d20211201_m051258_c001_v0001117_t0044") 2021/12/01 05:17:14 DEBUG : dst/three: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10858b4793a7e45a_d20211201_m051252_c001_v0001153_t0008") 2021/12/01 05:17:14 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f11223e4427bbf570_d20211201_m051531_c001_v0001113_t0056") 2021/12/01 05:17:14 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1068c6636364a3f2_d20211201_m051527_c001_v0001043_t0020") 2021/12/01 05:17:14 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1141fc3733d9f037_d20211201_m051519_c001_v0001038_t0002") 2021/12/01 05:17:14 DEBUG : dst/three.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f111c97bf26f8f1d6_d20211201_m051532_c001_v0001144_t0007") 2021/12/01 05:17:14 DEBUG : dst/three.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f117939a9d67560bc_d20211201_m051528_c001_v0001005_t0010") 2021/12/01 05:17:14 DEBUG : dst/three.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1193fc93623d07f7_d20211201_m051527_c001_v0001113_t0013") 2021/12/01 05:17:15 DEBUG : dst/three.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f117939a9d67560b6_d20211201_m051522_c001_v0001005_t0013") 2021/12/01 05:17:15 DEBUG : dst/three.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1099e6a21546ea9c_d20211201_m051521_c001_v0001041_t0056") 2021/12/01 05:17:15 DEBUG : dst/three.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6896_d20211201_m051512_c001_v0001165_t0057") 2021/12/01 05:17:15 DEBUG : dst/three.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1191bab4362a2674_d20211201_m051508_c001_v0001008_t0004") 2021/12/01 05:17:15 DEBUG : dst/three.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10800751db4b87a2_d20211201_m051506_c001_v0001150_t0043") 2021/12/01 05:17:15 DEBUG : dst/three.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1083577f1a6556b5_d20211201_m051505_c001_v0001157_t0052") 2021/12/01 05:17:15 DEBUG : dst/three.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10800751db4b876e_d20211201_m051451_c001_v0001150_t0015") 2021/12/01 05:17:15 DEBUG : dst/three.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10526d05db428030_d20211201_m051448_c001_v0001117_t0024") 2021/12/01 05:17:15 DEBUG : dst/three.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e67ae_d20211201_m051441_c001_v0001165_t0045") 2021/12/01 05:17:15 DEBUG : dst/three.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10509315d7c1599d_d20211201_m051433_c001_v0001038_t0020") 2021/12/01 05:17:15 DEBUG : dst/three.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e675a_d20211201_m051429_c001_v0001165_t0025") 2021/12/01 05:17:15 DEBUG : dst/three.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1028768c04d76a3e_d20211201_m051427_c001_v0001037_t0003") 2021/12/01 05:17:15 DEBUG : dst/three.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e66f9_d20211201_m051417_c001_v0001165_t0034") 2021/12/01 05:17:15 DEBUG : dst/three.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f102bca8860af7d37_d20211201_m051401_c001_v0001117_t0048") 2021/12/01 05:17:15 DEBUG : dst/three.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e666c_d20211201_m051356_c001_v0001165_t0010") 2021/12/01 05:17:15 DEBUG : dst/three.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1022d1e6ba3537d1_d20211201_m051354_c001_v0001012_t0038") 2021/12/01 05:17:15 DEBUG : dst/three.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6624_d20211201_m051347_c001_v0001165_t0035") 2021/12/01 05:17:15 DEBUG : dst/three.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f11580828b2647c84_d20211201_m051342_c001_v0001150_t0041") 2021/12/01 05:17:15 DEBUG : dst/three.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e65db_d20211201_m051337_c001_v0001165_t0003") 2021/12/01 05:17:15 DEBUG : dst/three.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10232d343e662f92_d20211201_m051335_c001_v0001097_t0002") 2021/12/01 05:17:16 DEBUG : dst/three.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e65a2_d20211201_m051327_c001_v0001165_t0005") 2021/12/01 05:17:16 DEBUG : dst/three.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10177b7538c805b0_d20211201_m051324_c001_v0001146_t0054") 2021/12/01 05:17:16 DEBUG : dst/three.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e654c_d20211201_m051315_c001_v0001165_t0027") 2021/12/01 05:17:16 DEBUG : dst/three.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f104a4c5ef506273b_d20211201_m051314_c001_v0001131_t0013") 2021/12/01 05:17:16 DEBUG : dst/three.txt: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e64f8_d20211201_m051306_c001_v0001165_t0016") 2021/12/01 05:17:16 DEBUG : dst/three.txt.bak: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f103fa11be0265f14_d20211201_m051509_c001_v0001093_t0007") 2021/12/01 05:17:16 DEBUG : dst/three.txt.bak: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1172c7c4169def71_d20211201_m051504_c001_v0001136_t0045") 2021/12/01 05:17:16 DEBUG : dst/three.txt.bak: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f11982840431106d2_d20211201_m051447_c001_v0001137_t0057") 2021/12/01 05:17:16 DEBUG : dst/three.txt.bak: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1140706ec730a22d_d20211201_m051439_c001_v0001029_t0011") 2021/12/01 05:17:16 DEBUG : dst/three.txt.bak: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f105585482ec2e6cc_d20211201_m051432_c001_v0001130_t0042") 2021/12/01 05:17:16 DEBUG : dst/three.txt.bak: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f117b67bf4dc464dc_d20211201_m051427_c001_v0001033_t0005") 2021/12/01 05:17:16 DEBUG : dst/two: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f11235be68f51998e_d20211201_m051534_c001_v0001136_t0006") 2021/12/01 05:17:16 DEBUG : dst/two: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6892_d20211201_m051512_c001_v0001165_t0013") 2021/12/01 05:17:16 DEBUG : dst/two: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f113b025f83c8d957_d20211201_m051510_c001_v0001097_t0022") 2021/12/01 05:17:16 DEBUG : dst/two: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e67a9_d20211201_m051441_c001_v0001165_t0027") 2021/12/01 05:17:16 DEBUG : dst/two: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1141b2e1033b158d_d20211201_m051439_c001_v0001157_t0016") 2021/12/01 05:17:16 DEBUG : dst/two: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e66f3_d20211201_m051417_c001_v0001165_t0031") 2021/12/01 05:17:16 DEBUG : dst/two: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1080917fe3e414fe_d20211201_m051415_c001_v0001120_t0050") 2021/12/01 05:17:16 DEBUG : dst/two: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6620_d20211201_m051347_c001_v0001165_t0037") 2021/12/01 05:17:16 DEBUG : dst/two: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1057d5eb4456fafb_d20211201_m051345_c001_v0001113_t0025") 2021/12/01 05:17:17 DEBUG : dst/two: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e65a0_d20211201_m051327_c001_v0001165_t0006") 2021/12/01 05:17:17 DEBUG : dst/two: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f106184571aabf0c2_d20211201_m051326_c001_v0001093_t0016") 2021/12/01 05:17:17 DEBUG : dst/two: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e64f4_d20211201_m051305_c001_v0001165_t0042") 2021/12/01 05:17:17 DEBUG : dst/two: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1008ba5319fbacb5_d20211201_m051303_c001_v0001113_t0023") 2021/12/01 05:17:17 DEBUG : dst/two: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1193f0ae7cf29c6b_d20211201_m051249_c001_v0001033_t0034") 2021/12/01 05:17:17 DEBUG : dst/two: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119934273f48f8c2_d20211201_m051225_c001_v0001041_t0040") 2021/12/01 05:17:17 DEBUG : dst/two: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1002cd7d0e680471_d20211201_m051222_c001_v0001161_t0031") 2021/12/01 05:17:17 DEBUG : empty space: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f111c93dbd91308d2_d20211201_m051156_c001_v0001097_t0034") 2021/12/01 05:17:17 DEBUG : empty space: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1174e483f502b01d_d20211201_m051152_c001_v0001117_t0019") 2021/12/01 05:17:17 DEBUG : empty space: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f118cee90bf05bfab_d20211201_m051147_c001_v0001023_t0011") 2021/12/01 05:17:17 DEBUG : empty space: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e62bb_d20211201_m051128_c001_v0001165_t0046") 2021/12/01 05:17:17 DEBUG : empty space: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f113c3b36952569b2_d20211201_m051115_c001_v0001146_t0035") 2021/12/01 05:17:17 DEBUG : empty space: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1174e483f502ad76_d20211201_m051110_c001_v0001117_t0056") 2021/12/01 05:17:17 DEBUG : empty space: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f11955e98970be71a_d20211201_m051025_c001_v0001017_t0003") 2021/12/01 05:17:17 DEBUG : empty space: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6135_d20211201_m051023_c001_v0001165_t0032") 2021/12/01 05:17:17 DEBUG : empty space: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10707738ac900025_d20211201_m051022_c001_v0001150_t0004") 2021/12/01 05:17:17 DEBUG : empty space: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6126_d20211201_m051020_c001_v0001165_t0035") 2021/12/01 05:17:17 DEBUG : empty space: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f103c12c1fc97ae1c_d20211201_m051014_c001_v0001154_t0017") 2021/12/01 05:17:17 DEBUG : empty space: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e60f2_d20211201_m051011_c001_v0001165_t0040") 2021/12/01 05:17:18 DEBUG : empty space: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1061dabea3ef455d_d20211201_m051009_c001_v0001033_t0009") 2021/12/01 05:17:18 DEBUG : empty space: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e60e0_d20211201_m051007_c001_v0001165_t0058") 2021/12/01 05:17:18 DEBUG : empty space: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f11415aa49dc5e50c_d20211201_m050955_c001_v0001001_t0011") 2021/12/01 05:17:18 DEBUG : empty space: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6077_d20211201_m050953_c001_v0001165_t0009") 2021/12/01 05:17:18 DEBUG : empty space: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1026e68e0c841386_d20211201_m050952_c001_v0001044_t0021") 2021/12/01 05:17:18 DEBUG : empty space: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e606c_d20211201_m050951_c001_v0001165_t0014") 2021/12/01 05:17:18 DEBUG : empty space: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f100d1a96eaef1395_d20211201_m050946_c001_v0001130_t0026") 2021/12/01 05:17:18 DEBUG : empty space: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6040_d20211201_m050945_c001_v0001165_t0025") 2021/12/01 05:17:18 DEBUG : empty space: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1171c6faf7b065cf_d20211201_m050942_c001_v0001044_t0044") 2021/12/01 05:17:18 DEBUG : empty space: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e601d_d20211201_m050941_c001_v0001165_t0038") 2021/12/01 05:17:18 DEBUG : empty space: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10040c5ae39a7c0a_d20211201_m050940_c001_v0001029_t0016") 2021/12/01 05:17:18 DEBUG : empty space: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f102774b0d4436336_d20211201_m050939_c001_v0001033_t0021") 2021/12/01 05:17:18 DEBUG : empty space: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6008_d20211201_m050937_c001_v0001165_t0038") 2021/12/01 05:17:18 DEBUG : enormous: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f102763083678d6eb_d20211201_m051024_c001_v0001134_t0001") 2021/12/01 05:17:18 DEBUG : enormous: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6138_d20211201_m051023_c001_v0001165_t0035") 2021/12/01 05:17:18 DEBUG : existing: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f105f589a5a34fcb2_d20211201_m051539_c001_v0001154_t0009") 2021/12/01 05:17:18 DEBUG : existing: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6955_d20211201_m051538_c001_v0001165_t0009") 2021/12/01 05:17:18 DEBUG : existing: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1101b654573326a7_d20211201_m051105_c001_v0001117_t0052") 2021/12/01 05:17:18 DEBUG : existing: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6204_d20211201_m051059_c001_v0001165_t0029") 2021/12/01 05:17:18 DEBUG : existing: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f112884b891f16446_d20211201_m050931_c001_v0001117_t0006") 2021/12/01 05:17:19 DEBUG : existing: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e5fcc_d20211201_m050930_c001_v0001165_t0016") 2021/12/01 05:17:19 DEBUG : existing: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f106aa2e831b99c6c_d20211201_m050928_c001_v0001117_t0052") 2021/12/01 05:17:19 DEBUG : existing: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e5fae_d20211201_m050927_c001_v0001165_t0042") 2021/12/01 05:17:19 DEBUG : existing: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e5fa8_d20211201_m050926_c001_v0001165_t0038") 2021/12/01 05:17:19 DEBUG : existing-b: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f116df0cc0cdf0266_d20211201_m051107_c001_v0001150_t0008") 2021/12/01 05:17:19 DEBUG : existing-b: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1174e483f502acd1_d20211201_m051101_c001_v0001117_t0039") 2021/12/01 05:17:19 DEBUG : five: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f114a09729d709513_d20211201_m051030_c001_v0001097_t0023") 2021/12/01 05:17:19 DEBUG : five: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6153_d20211201_m051027_c001_v0001165_t0025") 2021/12/01 05:17:19 DEBUG : foo: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f107e1086ea333688_d20211201_m050945_c001_v0001033_t0025") 2021/12/01 05:17:19 DEBUG : foo: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6038_d20211201_m050944_c001_v0001165_t0009") 2021/12/01 05:17:19 DEBUG : foo: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6035_d20211201_m050943_c001_v0001165_t0021") 2021/12/01 05:17:19 DEBUG : four: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10361acfede9521a_d20211201_m051030_c001_v0001013_t0030") 2021/12/01 05:17:19 DEBUG : four: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f111c1a5471f1e4de_d20211201_m051028_c001_v0001033_t0025") 2021/12/01 05:17:19 DEBUG : four: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e614e_d20211201_m051027_c001_v0001165_t0006") 2021/12/01 05:17:19 DEBUG : hello world2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f11749b0359cd510d_d20211201_m050746_c001_v0001042_t0020") 2021/12/01 05:17:19 DEBUG : hello world2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f113312722a630c99_d20211201_m050743_c001_v0001144_t0000") 2021/12/01 05:17:19 DEBUG : ignore-size: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f11223e4427bbeed2_d20211201_m050921_c001_v0001113_t0006") 2021/12/01 05:17:19 DEBUG : ignore-size: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f113312722a630fb9_d20211201_m050916_c001_v0001144_t0058") 2021/12/01 05:17:19 DEBUG : nested/sub dir/file: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f115e6e73b646aff8_d20211201_m051057_c001_v0001146_t0022") 2021/12/01 05:17:19 DEBUG : nested/sub dir/file: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1174e483f502ac85_d20211201_m051056_c001_v0001117_t0042") 2021/12/01 05:17:20 DEBUG : nested/sub dir/file: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f116cd7d94647351d_d20211201_m051054_c001_v0001041_t0027") 2021/12/01 05:17:20 DEBUG : nested/sub dir/file: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1174e483f502ac4f_d20211201_m051052_c001_v0001117_t0002") 2021/12/01 05:17:20 DEBUG : one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f107e3ccaa67ffd6a_d20211201_m051032_c001_v0001025_t0032") 2021/12/01 05:17:20 DEBUG : one: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6145_d20211201_m051026_c001_v0001165_t0027") 2021/12/01 05:17:20 DEBUG : only0: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f118c2cd1157c087d_d20211201_m051650_c001_v0001039_t0001") 2021/12/01 05:17:20 DEBUG : only0: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6b36_d20211201_m051626_c001_v0001165_t0040") 2021/12/01 05:17:20 DEBUG : only0: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6aa1_d20211201_m051616_c001_v0001165_t0009") 2021/12/01 05:17:20 DEBUG : only0: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f105c9081a92dc03f_d20211201_m051558_c001_v0001136_t0034") 2021/12/01 05:17:20 DEBUG : only0: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e699d_d20211201_m051546_c001_v0001165_t0017") 2021/12/01 05:17:20 DEBUG : only1: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1151e752a1d80a4b_d20211201_m051652_c001_v0001022_t0044") 2021/12/01 05:17:20 DEBUG : only1: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1183e10aa60b46eb_d20211201_m051626_c001_v0001090_t0058") 2021/12/01 05:17:20 DEBUG : only1: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6aa6_d20211201_m051616_c001_v0001165_t0011") 2021/12/01 05:17:20 DEBUG : only1: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f103715becb92183c_d20211201_m051600_c001_v0001131_t0001") 2021/12/01 05:17:20 DEBUG : only1: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e69a6_d20211201_m051546_c001_v0001165_t0005") 2021/12/01 05:17:20 DEBUG : only10: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1097696cfeedd23e_d20211201_m051653_c001_v0001003_t0026") 2021/12/01 05:17:20 DEBUG : only10: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f11039bb94b8425b5_d20211201_m051627_c001_v0001038_t0021") 2021/12/01 05:17:20 DEBUG : only10: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6ae8_d20211201_m051620_c001_v0001165_t0054") 2021/12/01 05:17:20 DEBUG : only10: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f100ded582268235d_d20211201_m051557_c001_v0001097_t0010") 2021/12/01 05:17:20 DEBUG : only10: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e69dd_d20211201_m051551_c001_v0001165_t0045") 2021/12/01 05:17:20 DEBUG : only11: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f112bb528803f5f39_d20211201_m051653_c001_v0001041_t0024") 2021/12/01 05:17:21 DEBUG : only11: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6b63_d20211201_m051629_c001_v0001165_t0051") 2021/12/01 05:17:21 DEBUG : only11: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6af1_d20211201_m051621_c001_v0001165_t0047") 2021/12/01 05:17:21 DEBUG : only11: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1195831da914211a_d20211201_m051559_c001_v0001036_t0026") 2021/12/01 05:17:21 DEBUG : only11: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e69e3_d20211201_m051551_c001_v0001165_t0056") 2021/12/01 05:17:21 DEBUG : only12: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f106b698a1e023cbf_d20211201_m051654_c001_v0001037_t0040") 2021/12/01 05:17:21 DEBUG : only12: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f113e6c3fccbc49c8_d20211201_m051627_c001_v0001117_t0000") 2021/12/01 05:17:21 DEBUG : only12: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6af8_d20211201_m051621_c001_v0001165_t0031") 2021/12/01 05:17:21 DEBUG : only12: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f106aa2e831b9b59e_d20211201_m051559_c001_v0001117_t0052") 2021/12/01 05:17:21 DEBUG : only12: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e69ed_d20211201_m051552_c001_v0001165_t0001") 2021/12/01 05:17:21 DEBUG : only13: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f101858cf49a63c0f_d20211201_m051654_c001_v0001097_t0015") 2021/12/01 05:17:21 DEBUG : only13: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6b3d_d20211201_m051626_c001_v0001165_t0013") 2021/12/01 05:17:21 DEBUG : only13: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6afd_d20211201_m051622_c001_v0001165_t0001") 2021/12/01 05:17:21 DEBUG : only13: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f115e6e73b646b61e_d20211201_m051558_c001_v0001146_t0034") 2021/12/01 05:17:21 DEBUG : only13: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e69f5_d20211201_m051552_c001_v0001165_t0021") 2021/12/01 05:17:21 DEBUG : only14: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f102763083678e9ca_d20211201_m051655_c001_v0001134_t0034") 2021/12/01 05:17:21 DEBUG : only14: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6b41_d20211201_m051627_c001_v0001165_t0017") 2021/12/01 05:17:21 DEBUG : only14: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6b06_d20211201_m051622_c001_v0001165_t0037") 2021/12/01 05:17:21 DEBUG : only14: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f109ff60b671f7c29_d20211201_m051556_c001_v0001137_t0009") 2021/12/01 05:17:21 DEBUG : only14: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e69f9_d20211201_m051553_c001_v0001165_t0036") 2021/12/01 05:17:21 DEBUG : only15: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10243b6b6d9c8d04_d20211201_m051655_c001_v0001032_t0024") 2021/12/01 05:17:22 DEBUG : only15: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1183e10aa60b46ef_d20211201_m051627_c001_v0001090_t0037") 2021/12/01 05:17:22 DEBUG : only15: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6b0f_d20211201_m051623_c001_v0001165_t0047") 2021/12/01 05:17:22 DEBUG : only15: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f11508b8754da3266_d20211201_m051557_c001_v0001044_t0041") 2021/12/01 05:17:22 DEBUG : only15: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6a04_d20211201_m051553_c001_v0001165_t0054") 2021/12/01 05:17:22 DEBUG : only16: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f112aabeb161f1a6d_d20211201_m051656_c001_v0001022_t0027") 2021/12/01 05:17:22 DEBUG : only16: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6b47_d20211201_m051627_c001_v0001165_t0012") 2021/12/01 05:17:22 DEBUG : only16: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6b15_d20211201_m051623_c001_v0001165_t0037") 2021/12/01 05:17:22 DEBUG : only16: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10538e53bae5b592_d20211201_m051558_c001_v0001025_t0031") 2021/12/01 05:17:22 DEBUG : only16: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6a0c_d20211201_m051554_c001_v0001165_t0037") 2021/12/01 05:17:22 DEBUG : only17: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1151d26071cbe6ea_d20211201_m051656_c001_v0001161_t0058") 2021/12/01 05:17:22 DEBUG : only17: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6b49_d20211201_m051627_c001_v0001165_t0003") 2021/12/01 05:17:22 DEBUG : only17: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6b1b_d20211201_m051624_c001_v0001165_t0029") 2021/12/01 05:17:22 DEBUG : only17: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f115d779939d5d801_d20211201_m051556_c001_v0001117_t0041") 2021/12/01 05:17:22 DEBUG : only17: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6a12_d20211201_m051554_c001_v0001165_t0058") 2021/12/01 05:17:22 DEBUG : only18: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f104b3e282b2fe268_d20211201_m051657_c001_v0001154_t0022") 2021/12/01 05:17:22 DEBUG : only18: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1183e10aa60b46f1_d20211201_m051627_c001_v0001090_t0024") 2021/12/01 05:17:22 DEBUG : only18: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6b21_d20211201_m051624_c001_v0001165_t0054") 2021/12/01 05:17:22 DEBUG : only18: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f111625c534e2ed39_d20211201_m051557_c001_v0001006_t0030") 2021/12/01 05:17:22 DEBUG : only18: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6a19_d20211201_m051554_c001_v0001165_t0045") 2021/12/01 05:17:23 DEBUG : only19: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1138528a9df13510_d20211201_m051657_c001_v0001136_t0042") 2021/12/01 05:17:23 DEBUG : only19: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f11039bb94b8425b7_d20211201_m051627_c001_v0001038_t0052") 2021/12/01 05:17:23 DEBUG : only19: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6b2c_d20211201_m051625_c001_v0001165_t0055") 2021/12/01 05:17:23 DEBUG : only19: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1093e40434eed49f_d20211201_m051557_c001_v0001144_t0027") 2021/12/01 05:17:23 DEBUG : only19: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6a21_d20211201_m051555_c001_v0001165_t0035") 2021/12/01 05:17:23 DEBUG : only2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10502ab82912a3c1_d20211201_m051657_c001_v0001097_t0052") 2021/12/01 05:17:23 DEBUG : only2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6b4d_d20211201_m051627_c001_v0001165_t0045") 2021/12/01 05:17:23 DEBUG : only2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6aac_d20211201_m051617_c001_v0001165_t0055") 2021/12/01 05:17:23 DEBUG : only2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f112638605fc3746a_d20211201_m051600_c001_v0001036_t0040") 2021/12/01 05:17:23 DEBUG : only2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e69ad_d20211201_m051547_c001_v0001165_t0015") 2021/12/01 05:17:23 DEBUG : only3: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1071d6d4997f23dd_d20211201_m051658_c001_v0001165_t0030") 2021/12/01 05:17:23 DEBUG : only3: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1183e10aa60b46f4_d20211201_m051627_c001_v0001090_t0052") 2021/12/01 05:17:23 DEBUG : only3: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6ab5_d20211201_m051617_c001_v0001165_t0027") 2021/12/01 05:17:23 DEBUG : only3: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f102d4074786ca3e9_d20211201_m051600_c001_v0001161_t0012") 2021/12/01 05:17:23 DEBUG : only3: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e69b4_d20211201_m051547_c001_v0001165_t0023") 2021/12/01 05:17:23 DEBUG : only4: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f106d65f9a5e7a334_d20211201_m051658_c001_v0001011_t0016") 2021/12/01 05:17:23 DEBUG : only4: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6b50_d20211201_m051627_c001_v0001165_t0031") 2021/12/01 05:17:23 DEBUG : only4: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6abf_d20211201_m051618_c001_v0001165_t0056") 2021/12/01 05:17:23 DEBUG : only4: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f118cd6f0365edb45_d20211201_m051558_c001_v0001161_t0032") 2021/12/01 05:17:23 DEBUG : only4: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e69bb_d20211201_m051548_c001_v0001165_t0018") 2021/12/01 05:17:24 DEBUG : only5: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f103a9c08b984a4e5_d20211201_m051659_c001_v0001128_t0017") 2021/12/01 05:17:24 DEBUG : only5: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f113e6c3fccbc49df_d20211201_m051627_c001_v0001117_t0015") 2021/12/01 05:17:24 DEBUG : only5: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6ac3_d20211201_m051618_c001_v0001165_t0019") 2021/12/01 05:17:24 DEBUG : only5: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1103658689f032b9_d20211201_m051558_c001_v0001136_t0010") 2021/12/01 05:17:24 DEBUG : only5: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e69c0_d20211201_m051548_c001_v0001165_t0036") 2021/12/01 05:17:24 DEBUG : only6: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10165fab5db81b81_d20211201_m051659_c001_v0001040_t0046") 2021/12/01 05:17:24 DEBUG : only6: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6b52_d20211201_m051628_c001_v0001165_t0035") 2021/12/01 05:17:24 DEBUG : only6: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6acc_d20211201_m051618_c001_v0001165_t0058") 2021/12/01 05:17:24 DEBUG : only6: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1100abe70a4848a3_d20211201_m051559_c001_v0001097_t0047") 2021/12/01 05:17:24 DEBUG : only6: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e69c4_d20211201_m051549_c001_v0001165_t0059") 2021/12/01 05:17:24 DEBUG : only7: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f11632ec986b544fd_d20211201_m051701_c001_v0001042_t0035") 2021/12/01 05:17:24 DEBUG : only7: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f11039bb94b8425b9_d20211201_m051628_c001_v0001038_t0034") 2021/12/01 05:17:24 DEBUG : only7: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6ad6_d20211201_m051619_c001_v0001165_t0020") 2021/12/01 05:17:24 DEBUG : only7: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f117745206ad7b459_d20211201_m051557_c001_v0001011_t0043") 2021/12/01 05:17:24 DEBUG : only7: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e69ca_d20211201_m051549_c001_v0001165_t0021") 2021/12/01 05:17:24 DEBUG : only8: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f109f9a96ff661325_d20211201_m051702_c001_v0001038_t0041") 2021/12/01 05:17:24 DEBUG : only8: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6b55_d20211201_m051628_c001_v0001165_t0018") 2021/12/01 05:17:24 DEBUG : only8: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6adc_d20211201_m051619_c001_v0001165_t0015") 2021/12/01 05:17:24 DEBUG : only8: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119a2b9d90abcbee_d20211201_m051559_c001_v0001092_t0011") 2021/12/01 05:17:25 DEBUG : only8: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e69d1_d20211201_m051550_c001_v0001165_t0032") 2021/12/01 05:17:25 DEBUG : only9: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f117657634af7fc10_d20211201_m051702_c001_v0001093_t0021") 2021/12/01 05:17:25 DEBUG : only9: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6b5c_d20211201_m051628_c001_v0001165_t0052") 2021/12/01 05:17:25 DEBUG : only9: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6ae2_d20211201_m051620_c001_v0001165_t0038") 2021/12/01 05:17:25 DEBUG : only9: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1173d9c5a38cd308_d20211201_m051558_c001_v0001137_t0036") 2021/12/01 05:17:25 DEBUG : only9: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e69d6_d20211201_m051550_c001_v0001165_t0046") 2021/12/01 05:17:25 DEBUG : potato: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1189c8aa30270425_d20211201_m051050_c001_v0001033_t0022") 2021/12/01 05:17:25 DEBUG : potato: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e61b4_d20211201_m051046_c001_v0001165_t0017") 2021/12/01 05:17:25 DEBUG : potato: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f113a835e3f559930_d20211201_m051045_c001_v0001003_t0029") 2021/12/01 05:17:25 DEBUG : potato: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e61a5_d20211201_m051041_c001_v0001165_t0027") 2021/12/01 05:17:25 DEBUG : potato: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10410dd554ef38b2_d20211201_m051039_c001_v0001097_t0025") 2021/12/01 05:17:25 DEBUG : potato: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f11790fbbe06d1e8d_d20211201_m051035_c001_v0001131_t0031") 2021/12/01 05:17:25 DEBUG : potato: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f107485d99cd0d542_d20211201_m051019_c001_v0001134_t0055") 2021/12/01 05:17:25 DEBUG : potato: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6117_d20211201_m051018_c001_v0001165_t0001") 2021/12/01 05:17:25 DEBUG : potato: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f106aa2e831b99f6e_d20211201_m051012_c001_v0001117_t0032") 2021/12/01 05:17:25 DEBUG : potato: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e60ec_d20211201_m051011_c001_v0001165_t0026") 2021/12/01 05:17:25 DEBUG : potato: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1171b667f67cb9e7_d20211201_m051008_c001_v0001128_t0001") 2021/12/01 05:17:25 DEBUG : potato: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e60db_d20211201_m051007_c001_v0001165_t0051") 2021/12/01 05:17:25 DEBUG : potato: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f101c987e39b5c6a3_d20211201_m050957_c001_v0001029_t0026") 2021/12/01 05:17:25 DEBUG : potato: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6075_d20211201_m050956_c001_v0001165_t0021") 2021/12/01 05:17:26 DEBUG : potato: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f100c32f98536e5c2_d20211201_m050955_c001_v0001117_t0023") 2021/12/01 05:17:26 DEBUG : potato: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e606a_d20211201_m050954_c001_v0001165_t0035") 2021/12/01 05:17:26 DEBUG : potato: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f102dfff5b209c533_d20211201_m050953_c001_v0001136_t0050") 2021/12/01 05:17:26 DEBUG : potato: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6064_d20211201_m050952_c001_v0001165_t0040") 2021/12/01 05:17:26 DEBUG : potato: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6061_d20211201_m050951_c001_v0001165_t0016") 2021/12/01 05:17:26 DEBUG : potato: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1101b654573321af_d20211201_m050950_c001_v0001117_t0053") 2021/12/01 05:17:26 DEBUG : potato: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6055_d20211201_m050949_c001_v0001165_t0045") 2021/12/01 05:17:26 DEBUG : potato: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6050_d20211201_m050948_c001_v0001165_t0004") 2021/12/01 05:17:26 DEBUG : potato: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10502ab829127f40_d20211201_m050947_c001_v0001097_t0010") 2021/12/01 05:17:26 DEBUG : potato: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6044_d20211201_m050946_c001_v0001165_t0045") 2021/12/01 05:17:26 DEBUG : potato2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119b2de6cba06cf6_d20211201_m051210_c001_v0001038_t0003") 2021/12/01 05:17:26 DEBUG : potato2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1174e483f502b119_d20211201_m051209_c001_v0001117_t0042") 2021/12/01 05:17:26 DEBUG : potato2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10410dd554ef3f04_d20211201_m051156_c001_v0001097_t0044") 2021/12/01 05:17:26 DEBUG : potato2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6346_d20211201_m051151_c001_v0001165_t0008") 2021/12/01 05:17:26 DEBUG : potato2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f118feda8266d7ecc_d20211201_m051138_c001_v0001036_t0021") 2021/12/01 05:17:26 DEBUG : potato2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1174e483f502ae6a_d20211201_m051125_c001_v0001117_t0027") 2021/12/01 05:17:26 DEBUG : potato2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1148a9aaea1c8d4c_d20211201_m051116_c001_v0001023_t0040") 2021/12/01 05:17:26 DEBUG : potato2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6235_d20211201_m051109_c001_v0001165_t0055") 2021/12/01 05:17:26 DEBUG : potato2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f113ab4053c41a1bf_d20211201_m051024_c001_v0001128_t0003") 2021/12/01 05:17:27 DEBUG : potato2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6131_d20211201_m051023_c001_v0001165_t0024") 2021/12/01 05:17:27 DEBUG : potato2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1114a4729476add5_d20211201_m051022_c001_v0001157_t0001") 2021/12/01 05:17:27 DEBUG : potato2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6124_d20211201_m051021_c001_v0001165_t0046") 2021/12/01 05:17:27 DEBUG : potato2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f110c4caa492f0e23_d20211201_m051020_c001_v0001131_t0005") 2021/12/01 05:17:27 DEBUG : potato2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e611b_d20211201_m051018_c001_v0001165_t0010") 2021/12/01 05:17:27 DEBUG : potato2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1162ba336c4c5346_d20211201_m051014_c001_v0001144_t0022") 2021/12/01 05:17:27 DEBUG : potato2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e60fb_d20211201_m051013_c001_v0001165_t0007") 2021/12/01 05:17:27 DEBUG : potato2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f102b5255c1be1fa4_d20211201_m051009_c001_v0001036_t0034") 2021/12/01 05:17:27 DEBUG : potato2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e60e6_d20211201_m051008_c001_v0001165_t0025") 2021/12/01 05:17:27 DEBUG : potato2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1062d75c9f25ef00_d20211201_m050955_c001_v0001128_t0037") 2021/12/01 05:17:27 DEBUG : potato2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e607c_d20211201_m050954_c001_v0001165_t0000") 2021/12/01 05:17:27 DEBUG : potato2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f107bd5340f5d3bbd_d20211201_m050758_c001_v0001128_t0046") 2021/12/01 05:17:27 DEBUG : potato2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f113312722a630cec_d20211201_m050753_c001_v0001144_t0052") 2021/12/01 05:17:27 DEBUG : potato2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f110541e3ce92ff20_d20211201_m050750_c001_v0001040_t0016") 2021/12/01 05:17:27 DEBUG : potato2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f113312722a630cb4_d20211201_m050747_c001_v0001144_t0034") 2021/12/01 05:17:27 DEBUG : potato3: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f114a09729d709cc8_d20211201_m051159_c001_v0001097_t0048") 2021/12/01 05:17:27 DEBUG : potato3: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e634f_d20211201_m051153_c001_v0001165_t0044") 2021/12/01 05:17:28 DEBUG : potato3: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f102d4074786c961a_d20211201_m051138_c001_v0001161_t0047") 2021/12/01 05:17:28 DEBUG : potato3: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1174e483f502aea8_d20211201_m051128_c001_v0001117_t0009") 2021/12/01 05:17:28 DEBUG : potato3: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10177b7538c803ed_d20211201_m051115_c001_v0001146_t0043") 2021/12/01 05:17:28 DEBUG : potato3: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6241_d20211201_m051110_c001_v0001165_t0049") 2021/12/01 05:17:28 DEBUG : pre-dest1/1: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10163a2cd689eb70_d20211201_m051233_c001_v0001157_t0003") 2021/12/01 05:17:28 DEBUG : pre-dest1/1: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1174e483f502b22e_d20211201_m051226_c001_v0001117_t0023") 2021/12/01 05:17:28 DEBUG : pre-dest2/2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1019530a09d4e00c_d20211201_m051234_c001_v0001165_t0045") 2021/12/01 05:17:28 DEBUG : pre-dest2/2: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e63f0_d20211201_m051227_c001_v0001165_t0012") 2021/12/01 05:17:28 DEBUG : sizeonly: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f11817352ae6fc516_d20211201_m050915_c001_v0001131_t0059") 2021/12/01 05:17:28 DEBUG : sizeonly: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f113312722a630f51_d20211201_m050905_c001_v0001144_t0050") 2021/12/01 05:17:28 DEBUG : sub dir/hello world: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1194f691394428f0_d20211201_m051057_c001_v0001117_t0011") 2021/12/01 05:17:28 DEBUG : sub dir/hello world: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e61f2_d20211201_m051056_c001_v0001165_t0043") 2021/12/01 05:17:28 DEBUG : sub dir/hello world: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1036b59ebfe64c26_d20211201_m051055_c001_v0001136_t0003") 2021/12/01 05:17:28 DEBUG : sub dir/hello world: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e61dd_d20211201_m051052_c001_v0001165_t0013") 2021/12/01 05:17:28 DEBUG : sub dir/hello world: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f11411a7414e0fef3_d20211201_m050853_c001_v0001154_t0002") 2021/12/01 05:17:29 DEBUG : sub dir/hello world: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f113312722a630de6_d20211201_m050822_c001_v0001144_t0027") 2021/12/01 05:17:29 DEBUG : sub dir/hello world: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f107005c58572d84d_d20211201_m050818_c001_v0001144_t0056") 2021/12/01 05:17:29 DEBUG : sub dir/hello world: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f113312722a630da3_d20211201_m050814_c001_v0001144_t0005") 2021/12/01 05:17:29 DEBUG : sub dir/hello world: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1114a4729476ab17_d20211201_m050813_c001_v0001157_t0028") 2021/12/01 05:17:29 DEBUG : sub dir/hello world: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f113312722a630d65_d20211201_m050808_c001_v0001144_t0046") 2021/12/01 05:17:29 DEBUG : sub dir/hello world: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1138528a9df12ce3_d20211201_m050807_c001_v0001136_t0018") 2021/12/01 05:17:29 DEBUG : sub dir/hello world: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f113312722a630d48_d20211201_m050805_c001_v0001144_t0002") 2021/12/01 05:17:29 DEBUG : sub dir/hello world: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10861c41cd1e339f_d20211201_m050804_c001_v0001032_t0018") 2021/12/01 05:17:29 DEBUG : sub dir/hello world: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f113312722a630d2a_d20211201_m050801_c001_v0001144_t0004") 2021/12/01 05:17:29 DEBUG : sub dir/hello world: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f113c3b3695256291_d20211201_m050800_c001_v0001146_t0058") 2021/12/01 05:17:29 DEBUG : sub dir/hello world: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f113312722a630d1b_d20211201_m050759_c001_v0001144_t0009") 2021/12/01 05:17:29 DEBUG : sub dir/hello world: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1156d099abcc947f_d20211201_m050743_c001_v0001165_t0036") 2021/12/01 05:17:29 DEBUG : sub dir/hello world: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f113312722a630c7c_d20211201_m050739_c001_v0001144_t0022") 2021/12/01 05:17:29 DEBUG : sub dir/hello world: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f118c2cd1157c03de_d20211201_m050737_c001_v0001039_t0055") 2021/12/01 05:17:30 DEBUG : sub dir/hello world: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f113312722a630c53_d20211201_m050733_c001_v0001144_t0036") 2021/12/01 05:17:30 DEBUG : sub dir/hello world: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1068c66363649da8_d20211201_m050732_c001_v0001043_t0050") 2021/12/01 05:17:30 DEBUG : sub dir/hello world: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f113312722a630c33_d20211201_m050729_c001_v0001144_t0045") 2021/12/01 05:17:30 DEBUG : sub dir/hello world: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1083c79d142846aa_d20211201_m050727_c001_v0001031_t0031") 2021/12/01 05:17:30 DEBUG : sub dir/hello world: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f113312722a630c0c_d20211201_m050723_c001_v0001144_t0030") 2021/12/01 05:17:30 DEBUG : sub/yam: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f101a7810ab758ca6_d20211201_m051050_c001_v0001150_t0032") 2021/12/01 05:17:30 DEBUG : sub/yam: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1174e483f502abe7_d20211201_m051046_c001_v0001117_t0054") 2021/12/01 05:17:30 DEBUG : three: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f108a694dcbb556f7_d20211201_m051032_c001_v0001117_t0057") 2021/12/01 05:17:30 DEBUG : three: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e615a_d20211201_m051029_c001_v0001165_t0008") 2021/12/01 05:17:30 DEBUG : three: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e614c_d20211201_m051026_c001_v0001165_t0046") 2021/12/01 05:17:30 DEBUG : two: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1187afdd3e24c6e8_d20211201_m051034_c001_v0001128_t0043") 2021/12/01 05:17:30 DEBUG : two: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f11790fbbe06d1e62_d20211201_m051028_c001_v0001131_t0006") 2021/12/01 05:17:30 DEBUG : two: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f119ba93ba57e6147_d20211201_m051026_c001_v0001165_t0056") 2021/12/01 05:17:30 DEBUG : yam: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f118229723a62220e_d20211201_m051051_c001_v0001120_t0051") 2021/12/01 05:17:30 DEBUG : yam: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1164241070c75eaf_d20211201_m051049_c001_v0001113_t0000") 2021/12/01 05:17:30 DEBUG : yam: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f102774b0d44364f7_d20211201_m051044_c001_v0001033_t0004") 2021/12/01 05:17:31 DEBUG : yam: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1174e483f502ab8c_d20211201_m051042_c001_v0001117_t0024") 2021/12/01 05:17:31 DEBUG : yam: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f11580828b264799f_d20211201_m051037_c001_v0001150_t0016") 2021/12/01 05:17:31 DEBUG : yam: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f111c1a5471f1e4fc_d20211201_m051035_c001_v0001033_t0050") 2021/12/01 05:17:31 DEBUG : yaml: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f10714038899a4e32_d20211201_m051045_c001_v0001018_t0012") 2021/12/01 05:17:31 DEBUG : yaml: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1100abe70a482eb6_d20211201_m051043_c001_v0001097_t0049") 2021/12/01 05:17:31 DEBUG : yaml: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f1064437c0aa351db_d20211201_m051039_c001_v0001137_t0023") 2021/12/01 05:17:31 DEBUG : yaml: Deleting (id "4_z8f42dde3603d7b4b7fd80e1b_f102861ac36d2f19c_d20211201_m051037_c001_v0001157_t0029") "./sync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -fast-list" - Finished OK in 10m11.935984715s (try 1/5)