"./sync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Starting (try 1/5) 2022/05/21 05:18:11 DEBUG : Creating backend with remote "TestB2:rclone-test-basolug0menateb8qudarej7" 2022/05/21 05:18:11 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2022/05/21 05:18:11 DEBUG : Creating backend with remote "/tmp/rclone2849254064" === 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-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:18:12 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:18:12 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:18:12 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) --- PASS: TestCopyWithDryRun (1.61s) === RUN TestCopy run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:18:13 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:18:13 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:18:14 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/05/21 05:18:14 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopy (3.32s) === RUN TestCopyMissingDirectory run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:18:16 DEBUG : Creating backend with remote "/non-existing" 2022/05/21 05:18:16 ERROR : Local file system at /non-existing: error reading source root directory: directory not found 2022/05/21 05:18:16 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:18:16 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish --- PASS: TestCopyMissingDirectory (0.52s) === RUN TestCopyNoTraverse run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:18:17 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:18:17 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:18:17 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:18:18 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/05/21 05:18:18 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoTraverse (4.88s) === RUN TestCopyCheckFirst run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:18:22 INFO : B2 bucket rclone-test-basolug0menateb8qudarej7: Running all checks before starting transfers 2022/05/21 05:18:22 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:18:22 INFO : B2 bucket rclone-test-basolug0menateb8qudarej7: Checks finished, now starting transfers 2022/05/21 05:18:22 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:18:22 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/05/21 05:18:22 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyCheckFirst (1.99s) === RUN TestSyncNoTraverse run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:18:24 ERROR : Ignoring --no-traverse with sync 2022/05/21 05:18:24 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:18:24 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:18:24 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/05/21 05:18:24 INFO : sub dir/hello world: Copied (new) 2022/05/21 05:18:24 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoTraverse (1.89s) === RUN TestCopyWithDepth run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:18:26 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:18:26 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:18:26 DEBUG : hello world2: sha1 = c0bf117f9c93d02c894fe8ffd6e5cecf3545c209 OK 2022/05/21 05:18:26 INFO : hello world2: Copied (new) --- PASS: TestCopyWithDepth (2.40s) === RUN TestCopyWithFilesFrom run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:18:28 DEBUG : hello world2: Excluded 2022/05/21 05:18:28 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:18:28 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:18:29 DEBUG : potato2: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/05/21 05:18:29 INFO : potato2: Copied (new) --- PASS: TestCopyWithFilesFrom (3.07s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:18:31 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:18:31 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:18:31 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:18:33 DEBUG : potato2: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/05/21 05:18:33 INFO : potato2: Copied (new) --- PASS: TestCopyWithFilesFromAndNoTraverse (4.80s) === RUN TestCopyEmptyDirectories run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:18:36 DEBUG : sub dir2: Making directory 2022/05/21 05:18:36 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:18:36 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:18:37 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/05/21 05:18:37 INFO : sub dir/hello world: Copied (new) 2022/05/21 05:18:37 DEBUG : sub dir2: Making directory 2022/05/21 05:18:37 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: copied 1 directories fstest.go:251: Filtering empty directory "sub dir2" --- PASS: TestCopyEmptyDirectories (3.46s) === RUN TestMoveEmptyDirectories run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:18:39 DEBUG : sub dir2: Making directory 2022/05/21 05:18:39 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:18:39 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:18:40 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/05/21 05:18:40 INFO : sub dir/hello world: Copied (new) 2022/05/21 05:18:40 INFO : sub dir/hello world: Deleted 2022/05/21 05:18:40 DEBUG : sub dir: Making directory 2022/05/21 05:18:40 DEBUG : sub dir2: Making directory 2022/05/21 05:18:40 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: copied 2 directories fstest.go:251: Filtering empty directory "sub dir2" --- PASS: TestMoveEmptyDirectories (2.85s) === RUN TestSyncEmptyDirectories run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:18:42 DEBUG : sub dir2: Making directory 2022/05/21 05:18:42 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:18:42 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:18:43 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/05/21 05:18:43 INFO : sub dir/hello world: Copied (new) 2022/05/21 05:18:43 DEBUG : sub dir2: Making directory 2022/05/21 05:18:43 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: copied 1 directories 2022/05/21 05:18:43 DEBUG : Waiting for deletions to finish fstest.go:251: Filtering empty directory "sub dir2" --- PASS: TestSyncEmptyDirectories (2.41s) === RUN TestServerSideCopy run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:18:45 DEBUG : Creating backend with remote "TestB2:rclone-test-kimuzeb8diwusef4roluzol5" sync_test.go:275: Server side copy (if possible) B2 bucket rclone-test-basolug0menateb8qudarej7 -> B2 bucket rclone-test-kimuzeb8diwusef4roluzol5 2022/05/21 05:18:46 DEBUG : B2 bucket rclone-test-kimuzeb8diwusef4roluzol5: Waiting for checks to finish 2022/05/21 05:18:46 DEBUG : B2 bucket rclone-test-kimuzeb8diwusef4roluzol5: Waiting for transfers to finish 2022/05/21 05:18:48 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/05/21 05:18:48 INFO : sub dir/hello world: Copied (server-side copy) 2022/05/21 05:18:48 DEBUG : B2 bucket rclone-test-kimuzeb8diwusef4roluzol5: Purge remote 2022/05/21 05:18:48 DEBUG : sub dir/hello world: Deleting (id "4_zffe2cd5300ddeb5b8f080e1b_f116c8609f54fd4df_d20220521_m051847_c001_v0001101_t0024_u01653110327476") --- PASS: TestServerSideCopy (5.84s) === RUN TestCopyAfterDelete run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:18:51 ERROR : : error listing: directory not found 2022/05/21 05:18:51 DEBUG : Local file system at /tmp/rclone2849254064: Making directory 2022/05/21 05:18:51 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:18:51 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish --- PASS: TestCopyAfterDelete (2.91s) === RUN TestCopyRedownload run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:18:54 DEBUG : Local file system at /tmp/rclone2849254064: Waiting for checks to finish 2022/05/21 05:18:54 DEBUG : Local file system at /tmp/rclone2849254064: Waiting for transfers to finish 2022/05/21 05:18:55 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/05/21 05:18:55 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyRedownload (2.49s) === RUN TestSyncBasedOnCheckSum run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:18:56 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:18:56 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:18:57 DEBUG : check sum: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/05/21 05:18:57 INFO : check sum: Copied (new) 2022/05/21 05:18:57 DEBUG : Waiting for deletions to finish 2022/05/21 05:18:57 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:18:57 DEBUG : check sum: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/05/21 05:18:57 DEBUG : check sum: Size and sha1 of src and dst objects identical 2022/05/21 05:18:57 DEBUG : check sum: Unchanged skipping 2022/05/21 05:18:57 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:18:57 DEBUG : Waiting for deletions to finish 2022/05/21 05:18:57 INFO : There was nothing to transfer --- PASS: TestSyncBasedOnCheckSum (4.03s) === RUN TestSyncSizeOnly run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:19:00 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:19:00 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:19:02 DEBUG : sizeonly: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2022/05/21 05:19:02 INFO : sizeonly: Copied (new) 2022/05/21 05:19:02 DEBUG : Waiting for deletions to finish 2022/05/21 05:19:02 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:19:02 DEBUG : sizeonly: Sizes identical 2022/05/21 05:19:02 DEBUG : sizeonly: Unchanged skipping 2022/05/21 05:19:02 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:19:02 DEBUG : Waiting for deletions to finish 2022/05/21 05:19:02 INFO : There was nothing to transfer --- PASS: TestSyncSizeOnly (6.40s) === RUN TestSyncIgnoreSize run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:19:06 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:19:06 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:19:07 DEBUG : ignore-size: sha1 = 4a756ca07e9487f482465a99e8286abc86ba4dc7 OK 2022/05/21 05:19:07 INFO : ignore-size: Copied (new) 2022/05/21 05:19:07 DEBUG : Waiting for deletions to finish 2022/05/21 05:19:07 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:19:07 DEBUG : ignore-size: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:19:07 DEBUG : ignore-size: Unchanged skipping 2022/05/21 05:19:07 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:19:07 DEBUG : Waiting for deletions to finish 2022/05/21 05:19:07 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreSize (5.54s) === RUN TestSyncIgnoreTimes run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:19:13 DEBUG : existing: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:19:13 DEBUG : existing: Unchanged skipping 2022/05/21 05:19:13 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:19:13 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:19:13 DEBUG : Waiting for deletions to finish 2022/05/21 05:19:13 INFO : There was nothing to transfer 2022/05/21 05:19:13 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:19:13 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2022/05/21 05:19:13 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:19:14 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2022/05/21 05:19:14 INFO : existing: Copied (replaced existing) 2022/05/21 05:19:14 DEBUG : Waiting for deletions to finish --- PASS: TestSyncIgnoreTimes (3.90s) === RUN TestSyncIgnoreExisting run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:19:16 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:19:16 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:19:17 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2022/05/21 05:19:17 INFO : existing: Copied (new) 2022/05/21 05:19:17 DEBUG : Waiting for deletions to finish 2022/05/21 05:19:17 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:19:17 DEBUG : existing: Destination exists, skipping 2022/05/21 05:19:17 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:19:17 DEBUG : Waiting for deletions to finish 2022/05/21 05:19:17 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreExisting (2.68s) === RUN TestSyncIgnoreErrors run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:19:21 DEBUG : d: Making directory fstest.go:251: Filtering empty directory "d" 2022/05/21 05:19:22 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/21 05:19:22 DEBUG : c/non empty space: Unchanged skipping 2022/05/21 05:19:22 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:19:22 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:19:23 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/05/21 05:19:23 INFO : a/potato2: Copied (new) 2022/05/21 05:19:23 DEBUG : Waiting for deletions to finish 2022/05/21 05:19:24 INFO : b/potato: Deleted --- PASS: TestSyncIgnoreErrors (7.39s) === RUN TestSyncAfterChangingModtimeOnly run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:19:27 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:19:27 DEBUG : empty space: Modification times differ by -95456h54m52.624456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499 +0000 UTC 2022/05/21 05:19:27 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/05/21 05:19:27 NOTICE: empty space: Skipped update modification time as --dry-run is set (size 1) 2022/05/21 05:19:27 DEBUG : empty space: Unchanged skipping 2022/05/21 05:19:27 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:19:27 DEBUG : Waiting for deletions to finish 2022/05/21 05:19:27 INFO : There was nothing to transfer 2022/05/21 05:19:27 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:19:27 DEBUG : empty space: Modification times differ by -95456h54m52.624456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499 +0000 UTC 2022/05/21 05:19:27 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/05/21 05:19:29 INFO : empty space: Updated modification time in destination 2022/05/21 05:19:29 DEBUG : empty space: Unchanged skipping 2022/05/21 05:19:29 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:19:29 DEBUG : Waiting for deletions to finish 2022/05/21 05:19:29 INFO : There was nothing to transfer --- PASS: TestSyncAfterChangingModtimeOnly (4.55s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:19:31 DEBUG : empty space: Modification times differ by -95456h54m52.624456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499 +0000 UTC 2022/05/21 05:19:31 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:19:31 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/05/21 05:19:31 DEBUG : empty space: Unchanged skipping 2022/05/21 05:19:31 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:19:31 DEBUG : Waiting for deletions to finish 2022/05/21 05:19:31 INFO : There was nothing to transfer --- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (1.87s) === RUN TestSyncDoesntUpdateModtime run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:19:33 DEBUG : foo: Modification times differ by -95456h54m52.624456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499 +0000 UTC 2022/05/21 05:19:33 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:19:33 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 (Local file system at /tmp/rclone2849254064) 2022/05/21 05:19:33 DEBUG : foo: sha1 = 62cdb7020ff920e5aa642c3d4066950dd1f01f4d (B2 bucket rclone-test-basolug0menateb8qudarej7) 2022/05/21 05:19:33 DEBUG : foo: sha1 differ 2022/05/21 05:19:33 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:19:34 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 OK 2022/05/21 05:19:34 INFO : foo: Copied (replaced existing) 2022/05/21 05:19:34 DEBUG : Waiting for deletions to finish --- PASS: TestSyncDoesntUpdateModtime (2.81s) === RUN TestSyncAfterAddingAFile run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:19:36 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:19:36 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/21 05:19:36 DEBUG : empty space: Unchanged skipping 2022/05/21 05:19:36 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:19:37 DEBUG : potato: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/05/21 05:19:37 INFO : potato: Copied (new) 2022/05/21 05:19:37 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterAddingAFile (4.56s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:19:40 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:19:40 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2022/05/21 05:19:40 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:19:43 DEBUG : potato: sha1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f OK 2022/05/21 05:19:43 INFO : potato: Copied (replaced existing) 2022/05/21 05:19:43 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingFilesSizeOnly (4.84s) === RUN TestSyncAfterChangingContentsOnly run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:19:48 DEBUG : potato: Modification times differ by 119h59m59.876543211s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2011-12-30 12:59:59 +0000 UTC 2022/05/21 05:19:48 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:19:48 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f (Local file system at /tmp/rclone2849254064) 2022/05/21 05:19:48 DEBUG : potato: sha1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f (B2 bucket rclone-test-basolug0menateb8qudarej7) 2022/05/21 05:19:48 DEBUG : potato: sha1 differ 2022/05/21 05:19:48 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:19:48 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f OK 2022/05/21 05:19:48 INFO : potato: Copied (replaced existing) 2022/05/21 05:19:48 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingContentsOnly (11.04s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:19:58 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2022/05/21 05:19:58 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:19:58 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/21 05:19:58 DEBUG : empty space: Unchanged skipping 2022/05/21 05:19:58 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:19:58 DEBUG : Waiting for deletions to finish 2022/05/21 05:19:58 NOTICE: potato: Skipped delete as --dry-run is set (size 21) --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (5.20s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:20:03 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:20:03 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/21 05:20:03 DEBUG : empty space: Unchanged skipping 2022/05/21 05:20:03 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:20:04 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/05/21 05:20:04 INFO : potato2: Copied (new) 2022/05/21 05:20:04 DEBUG : Waiting for deletions to finish 2022/05/21 05:20:04 INFO : potato: Deleted --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (5.98s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:20:09 DEBUG : d: Making directory 2022/05/21 05:20:09 DEBUG : d/e: Making directory fstest.go:251: Filtering empty directory "d" fstest.go:251: Filtering empty directory "d/e" 2022/05/21 05:20:09 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/21 05:20:09 DEBUG : c/non empty space: Unchanged skipping 2022/05/21 05:20:09 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:20:09 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:20:10 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/05/21 05:20:10 INFO : a/potato2: Copied (new) 2022/05/21 05:20:10 DEBUG : Waiting for deletions to finish 2022/05/21 05:20:10 INFO : b/potato: Deleted --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (5.56s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:20:13 DEBUG : d: Making directory fstest.go:251: Filtering empty directory "d" 2022/05/21 05:20:14 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/21 05:20:14 DEBUG : c/non empty space: Unchanged skipping 2022/05/21 05:20:14 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:20:14 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:20:14 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/05/21 05:20:14 INFO : a/potato2: Copied (new) 2022/05/21 05:20:14 ERROR : B2 bucket rclone-test-basolug0menateb8qudarej7: not deleting files as there were IO errors 2022/05/21 05:20:14 ERROR : B2 bucket rclone-test-basolug0menateb8qudarej7: not deleting directories as there were IO errors fstest.go:251: Filtering empty directory "d" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (8.26s) === RUN TestSyncDeleteAfter --- PASS: TestSyncDeleteAfter (0.00s) === RUN TestSyncDeleteDuring run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:20:23 DEBUG : Waiting for deletions to finish 2022/05/21 05:20:23 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/21 05:20:23 DEBUG : empty space: Unchanged skipping 2022/05/21 05:20:23 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:20:23 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:20:23 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/05/21 05:20:23 INFO : potato2: Copied (new) 2022/05/21 05:20:24 INFO : potato: Deleted --- PASS: TestSyncDeleteDuring (7.92s) === RUN TestSyncDeleteBefore run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:20:28 DEBUG : potato: Clearing upload URL because of error: Post "https://pod-000-1101-11.backblaze.com/b2api/v1/b2_upload_file/af923de300ddeb5b8f080e1b/c001_v0001101_t0033": EOF 2022/05/21 05:20:28 DEBUG : pacer: low level retry 1/1 (error Post "https://pod-000-1101-11.backblaze.com/b2api/v1/b2_upload_file/af923de300ddeb5b8f080e1b/c001_v0001101_t0033": EOF) 2022/05/21 05:20:28 DEBUG : pacer: Rate limited, increasing sleep to 20ms run.go:283: Retry Put of "potato" to B2 bucket rclone-test-basolug0menateb8qudarej7: 1/10 (Post "https://pod-000-1101-11.backblaze.com/b2api/v1/b2_upload_file/af923de300ddeb5b8f080e1b/c001_v0001101_t0033": EOF) 2022/05/21 05:20:30 DEBUG : pacer: Reducing sleep to 10ms 2022/05/21 05:20:35 DEBUG : Waiting for deletions to finish 2022/05/21 05:20:35 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:20:35 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:20:38 INFO : potato: Deleted 2022/05/21 05:20:38 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/21 05:20:38 DEBUG : empty space: Unchanged skipping 2022/05/21 05:20:38 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:20:38 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:20:39 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/05/21 05:20:39 INFO : potato2: Copied (new) --- PASS: TestSyncDeleteBefore (13.84s) === RUN TestCopyDeleteBefore run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:20:45 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:20:45 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:20:46 DEBUG : potato2: sha1 = 810274f0df19dab60a894a562b7a8ff04c072623 OK 2022/05/21 05:20:46 INFO : potato2: Copied (new) --- PASS: TestCopyDeleteBefore (5.96s) === RUN TestSyncWithExclude run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:20:52 DEBUG : enormous: Excluded 2022/05/21 05:20:52 DEBUG : potato2: Excluded 2022/05/21 05:20:52 DEBUG : potato2: Excluded 2022/05/21 05:20:52 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/21 05:20:52 DEBUG : empty space: Unchanged skipping 2022/05/21 05:20:52 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:20:52 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:20:52 DEBUG : Waiting for deletions to finish 2022/05/21 05:20:52 INFO : There was nothing to transfer 2022/05/21 05:20:52 DEBUG : enormous: Excluded 2022/05/21 05:20:52 DEBUG : potato2: Excluded 2022/05/21 05:20:53 DEBUG : potato2: Excluded 2022/05/21 05:20:53 DEBUG : empty space: Size and modification time the same (differ by 456.789µs, within tolerance 1ms) 2022/05/21 05:20:53 DEBUG : empty space: Unchanged skipping 2022/05/21 05:20:53 DEBUG : Local file system at /tmp/rclone2849254064: Waiting for checks to finish 2022/05/21 05:20:53 DEBUG : Local file system at /tmp/rclone2849254064: Waiting for transfers to finish 2022/05/21 05:20:53 DEBUG : Waiting for deletions to finish 2022/05/21 05:20:53 INFO : There was nothing to transfer --- PASS: TestSyncWithExclude (8.09s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:20:59 DEBUG : enormous: Excluded 2022/05/21 05:20:59 DEBUG : potato2: Excluded 2022/05/21 05:21:00 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/21 05:21:00 DEBUG : empty space: Unchanged skipping 2022/05/21 05:21:00 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:21:00 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:21:00 DEBUG : Waiting for deletions to finish 2022/05/21 05:21:01 INFO : enormous: Deleted 2022/05/21 05:21:01 INFO : potato2: Deleted 2022/05/21 05:21:01 INFO : There was nothing to transfer 2022/05/21 05:21:01 DEBUG : Local file system at /tmp/rclone2849254064: Waiting for checks to finish 2022/05/21 05:21:01 DEBUG : empty space: Size and modification time the same (differ by 456.789µs, within tolerance 1ms) 2022/05/21 05:21:01 DEBUG : empty space: Unchanged skipping 2022/05/21 05:21:01 DEBUG : Local file system at /tmp/rclone2849254064: Waiting for transfers to finish 2022/05/21 05:21:01 DEBUG : Waiting for deletions to finish 2022/05/21 05:21:01 INFO : potato2: Deleted 2022/05/21 05:21:01 INFO : enormous: Deleted 2022/05/21 05:21:01 INFO : There was nothing to transfer --- PASS: TestSyncWithExcludeAndDeleteExcluded (5.78s) === RUN TestSyncWithUpdateOlder run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:21:11 DEBUG : four: Sizes differ (src 4 vs dst 8) 2022/05/21 05:21:11 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2022/05/21 05:21:11 DEBUG : one: Destination is newer than source, skipping 2022/05/21 05:21:11 DEBUG : three: Sizes identical 2022/05/21 05:21:11 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2022/05/21 05:21:11 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:21:11 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b (Local file system at /tmp/rclone2849254064) 2022/05/21 05:21:11 DEBUG : two: sha1 = b10e0da85e90399abfec36c7376b20aa4596461b (B2 bucket rclone-test-basolug0menateb8qudarej7) 2022/05/21 05:21:11 DEBUG : two: sha1 differ 2022/05/21 05:21:11 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:21:11 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2022/05/21 05:21:11 INFO : five: Copied (new) 2022/05/21 05:21:12 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2022/05/21 05:21:12 INFO : four: Copied (replaced existing) 2022/05/21 05:21:12 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2022/05/21 05:21:12 INFO : two: Copied (replaced existing) 2022/05/21 05:21:12 DEBUG : Waiting for deletions to finish 2022/05/21 05:21:13 DEBUG : one: Destination is newer than source, skipping 2022/05/21 05:21:13 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:21:13 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2022/05/21 05:21:13 DEBUG : five: Size and sha1 of src and dst objects identical 2022/05/21 05:21:13 DEBUG : five: Destination mod time is within 1s of source and files identical, skipping 2022/05/21 05:21:13 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2022/05/21 05:21:13 DEBUG : four: Size and sha1 of src and dst objects identical 2022/05/21 05:21:13 DEBUG : four: Destination mod time is within 1s of source and files identical, skipping 2022/05/21 05:21:13 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb (Local file system at /tmp/rclone2849254064) 2022/05/21 05:21:13 DEBUG : three: sha1 = 03731cad13f4cf7b59703c77529381cdec1632e5 (B2 bucket rclone-test-basolug0menateb8qudarej7) 2022/05/21 05:21:13 DEBUG : three: sha1 differ 2022/05/21 05:21:13 DEBUG : three: Destination mod time is within 1s of source but files differ, transferring 2022/05/21 05:21:13 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2022/05/21 05:21:13 DEBUG : two: Size and sha1 of src and dst objects identical 2022/05/21 05:21:13 DEBUG : two: Destination mod time is within 1s of source and files identical, skipping 2022/05/21 05:21:13 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:21:15 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/05/21 05:21:15 INFO : three: Copied (replaced existing) 2022/05/21 05:21:15 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithUpdateOlder (17.36s) === 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-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" sync_test.go:1058: Can track renames: true 2022/05/21 05:21:19 INFO : B2 bucket rclone-test-basolug0menateb8qudarej7: Making map for --track-renames 2022/05/21 05:21:19 INFO : B2 bucket rclone-test-basolug0menateb8qudarej7: Finished making map for --track-renames 2022/05/21 05:21:19 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:21:19 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for renames to finish 2022/05/21 05:21:19 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:21:20 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2022/05/21 05:21:20 INFO : yam: Copied (new) 2022/05/21 05:21:22 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2022/05/21 05:21:22 INFO : potato: Copied (new) 2022/05/21 05:21:22 DEBUG : Waiting for deletions to finish 2022/05/21 05:21:22 INFO : B2 bucket rclone-test-basolug0menateb8qudarej7: Making map for --track-renames 2022/05/21 05:21:22 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:21:22 DEBUG : potato: Unchanged skipping 2022/05/21 05:21:22 INFO : B2 bucket rclone-test-basolug0menateb8qudarej7: Finished making map for --track-renames 2022/05/21 05:21:22 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:21:22 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for renames to finish 2022/05/21 05:21:22 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:21:24 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2022/05/21 05:21:24 INFO : yam: Copied (server-side copy) to: yaml 2022/05/21 05:21:25 INFO : yam: Deleted 2022/05/21 05:21:25 INFO : yaml: Renamed from "yam" 2022/05/21 05:21:25 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:21:25 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenames (7.56s) === RUN TestParseRenamesStrategyModtime --- PASS: TestParseRenamesStrategyModtime (0.00s) === RUN TestRenamesStrategyModtime --- PASS: TestRenamesStrategyModtime (0.00s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" sync_test.go:1127: Can track renames: true 2022/05/21 05:21:27 INFO : B2 bucket rclone-test-basolug0menateb8qudarej7: Making map for --track-renames 2022/05/21 05:21:27 INFO : B2 bucket rclone-test-basolug0menateb8qudarej7: Finished making map for --track-renames 2022/05/21 05:21:27 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:21:27 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for renames to finish 2022/05/21 05:21:27 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:21:28 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2022/05/21 05:21:28 INFO : yam: Copied (new) 2022/05/21 05:21:29 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2022/05/21 05:21:29 INFO : potato: Copied (new) 2022/05/21 05:21:29 DEBUG : Waiting for deletions to finish 2022/05/21 05:21:30 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:21:30 DEBUG : potato: Unchanged skipping 2022/05/21 05:21:30 INFO : B2 bucket rclone-test-basolug0menateb8qudarej7: Making map for --track-renames 2022/05/21 05:21:30 INFO : B2 bucket rclone-test-basolug0menateb8qudarej7: Finished making map for --track-renames 2022/05/21 05:21:30 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:21:30 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for renames to finish 2022/05/21 05:21:30 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:21:32 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2022/05/21 05:21:32 INFO : yam: Copied (server-side copy) to: yaml 2022/05/21 05:21:35 INFO : yam: Deleted 2022/05/21 05:21:35 INFO : yaml: Renamed from "yam" 2022/05/21 05:21:35 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:21:35 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenamesStrategyModtime (13.57s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" sync_test.go:1163: Can track renames: true 2022/05/21 05:21:41 INFO : B2 bucket rclone-test-basolug0menateb8qudarej7: Making map for --track-renames 2022/05/21 05:21:41 INFO : B2 bucket rclone-test-basolug0menateb8qudarej7: Finished making map for --track-renames 2022/05/21 05:21:41 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:21:41 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for renames to finish 2022/05/21 05:21:41 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:21:42 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2022/05/21 05:21:42 INFO : potato: Copied (new) 2022/05/21 05:21:45 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2022/05/21 05:21:45 INFO : sub/yam: Copied (new) 2022/05/21 05:21:45 DEBUG : Waiting for deletions to finish 2022/05/21 05:21:45 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:21:45 DEBUG : potato: Unchanged skipping 2022/05/21 05:21:46 INFO : B2 bucket rclone-test-basolug0menateb8qudarej7: Making map for --track-renames 2022/05/21 05:21:46 INFO : B2 bucket rclone-test-basolug0menateb8qudarej7: Finished making map for --track-renames 2022/05/21 05:21:46 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:21:46 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for renames to finish 2022/05/21 05:21:46 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:21:47 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2022/05/21 05:21:47 INFO : sub/yam: Copied (server-side copy) to: yam 2022/05/21 05:21:47 INFO : sub/yam: Deleted 2022/05/21 05:21:47 INFO : yam: Renamed from "sub/yam" 2022/05/21 05:21:47 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:21:47 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenamesStrategyLeaf (11.76s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:21:52 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:21:52 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:21:53 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2022/05/21 05:21:53 INFO : nested/sub dir/file: Copied (new) 2022/05/21 05:21:53 INFO : nested/sub dir/file: Deleted 2022/05/21 05:21:56 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/05/21 05:21:56 INFO : sub dir/hello world: Copied (new) 2022/05/21 05:21:56 INFO : sub dir/hello world: Deleted 2022/05/21 05:21:56 INFO : sub dir: Removing directory 2022/05/21 05:21:56 INFO : nested/sub dir: Removing directory 2022/05/21 05:21:56 INFO : nested: Removing directory 2022/05/21 05:21:56 DEBUG : Local file system at /tmp/rclone2849254064: deleted 3 directories --- PASS: TestMoveWithDeleteEmptySrcDirs (13.83s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:22:06 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:22:06 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:22:07 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2022/05/21 05:22:07 INFO : nested/sub dir/file: Copied (new) 2022/05/21 05:22:07 INFO : nested/sub dir/file: Deleted 2022/05/21 05:22:10 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/05/21 05:22:10 INFO : sub dir/hello world: Copied (new) 2022/05/21 05:22:10 INFO : sub dir/hello world: Deleted --- PASS: TestMoveWithoutDeleteEmptySrcDirs (6.62s) === RUN TestMoveWithIgnoreExisting run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:22:13 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:22:13 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:22:14 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2022/05/21 05:22:14 INFO : existing: Copied (new) 2022/05/21 05:22:14 INFO : existing: Deleted 2022/05/21 05:22:28 DEBUG : existing-b: sha1 = 321f6b7e8bf7f29aab89c5e41a555b1b0baa41a9 OK 2022/05/21 05:22:28 INFO : existing-b: Copied (new) 2022/05/21 05:22:28 INFO : existing-b: Deleted 2022/05/21 05:22:28 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:22:28 DEBUG : existing: Destination exists, skipping 2022/05/21 05:22:28 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2022/05/21 05:22:28 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:22:28 INFO : There was nothing to transfer --- PASS: TestMoveWithIgnoreExisting (19.94s) === RUN TestServerSideMove run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:22:32 DEBUG : Creating backend with remote "TestB2:rclone-test-vegateh9lamujaq8marupop0" sync_test.go:1215: Server side move (if possible) B2 bucket rclone-test-basolug0menateb8qudarej7 -> B2 bucket rclone-test-vegateh9lamujaq8marupop0 2022/05/21 05:22:53 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ms) 2022/05/21 05:22:53 DEBUG : empty space: Unchanged skipping 2022/05/21 05:22:53 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2022/05/21 05:22:53 DEBUG : B2 bucket rclone-test-vegateh9lamujaq8marupop0: Waiting for checks to finish 2022/05/21 05:22:54 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/05/21 05:22:54 INFO : potato2: Copied (server-side copy) 2022/05/21 05:22:54 INFO : empty space: Deleted 2022/05/21 05:22:54 DEBUG : B2 bucket rclone-test-vegateh9lamujaq8marupop0: Waiting for transfers to finish 2022/05/21 05:22:54 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2022/05/21 05:22:54 INFO : potato3: Copied (server-side copy) 2022/05/21 05:22:54 INFO : potato2: Deleted 2022/05/21 05:22:55 INFO : potato3: Deleted 2022/05/21 05:22:55 DEBUG : Creating backend with remote "TestB2:rclone-test-husokop9hecipih4webanep7" 2022/05/21 05:22:56 DEBUG : B2 bucket rclone-test-husokop9hecipih4webanep7: Waiting for checks to finish 2022/05/21 05:22:56 DEBUG : B2 bucket rclone-test-husokop9hecipih4webanep7: Waiting for transfers to finish 2022/05/21 05:22:57 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2022/05/21 05:22:57 INFO : potato3: Copied (server-side copy) 2022/05/21 05:22:57 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/05/21 05:22:57 INFO : potato2: Copied (server-side copy) 2022/05/21 05:22:58 INFO : potato2: Deleted 2022/05/21 05:22:58 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/05/21 05:22:58 INFO : empty space: Copied (server-side copy) 2022/05/21 05:22:59 INFO : potato3: Deleted 2022/05/21 05:22:59 INFO : empty space: Deleted 2022/05/21 05:22:59 DEBUG : B2 bucket rclone-test-husokop9hecipih4webanep7: Purge remote 2022/05/21 05:23:00 DEBUG : empty space: Deleting (id "4_zbf229d53101deb5b8f080e1b_f115738f9b5f1cf85_d20220521_m052257_c001_v0001115_t0040_u01653110577265") 2022/05/21 05:23:00 DEBUG : potato2: Deleting (id "4_zbf229d53101deb5b8f080e1b_f107c7f17bc59394c_d20220521_m052257_c001_v0001091_t0013_u01653110577261") 2022/05/21 05:23:00 DEBUG : potato3: Deleting (id "4_zbf229d53101deb5b8f080e1b_f11710294a8f44f94_d20220521_m052257_c001_v0001150_t0049_u01653110577306") 2022/05/21 05:23:01 DEBUG : B2 bucket rclone-test-vegateh9lamujaq8marupop0: Purge remote 2022/05/21 05:23:01 DEBUG : empty space: Deleting (id "4_z4fc27de3101deb5b8f080e1b_f115dc296050e21a8_d20220521_m052258_c001_v0001144_t0023_u01653110578719") 2022/05/21 05:23:01 DEBUG : empty space: Deleting (id "4_z4fc27de3101deb5b8f080e1b_f118bbdfa3a450d25_d20220521_m052251_c001_v0001041_t0026_u01653110571695") 2022/05/21 05:23:01 DEBUG : potato2: Deleting (id "4_z4fc27de3101deb5b8f080e1b_f117459d83ef9686f_d20220521_m052257_c001_v0001093_t0012_u01653110577945") 2022/05/21 05:23:01 DEBUG : potato2: Deleting (id "4_z4fc27de3101deb5b8f080e1b_f110b35ebc155b533_d20220521_m052253_c001_v0001090_t0038_u01653110573729") 2022/05/21 05:23:01 DEBUG : potato3: Deleting (id "4_z4fc27de3101deb5b8f080e1b_f1070bd1ff2bd2475_d20220521_m052257_c001_v0001042_t0015_u01653110577729") 2022/05/21 05:23:01 DEBUG : potato3: Deleting (id "4_z4fc27de3101deb5b8f080e1b_f101e672e07d4d70b_d20220521_m052254_c001_v0001116_t0038_u01653110574099") 2022/05/21 05:23:01 DEBUG : potato3: Deleting (id "4_z4fc27de3101deb5b8f080e1b_f118bbdfa3a450d27_d20220521_m052252_c001_v0001041_t0044_u01653110572142") --- PASS: TestServerSideMove (30.15s) === RUN TestServerSideMoveWithFilter run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:23:03 DEBUG : Creating backend with remote "TestB2:rclone-test-revapux5jelixek5walajat3" sync_test.go:1215: Server side move (if possible) B2 bucket rclone-test-basolug0menateb8qudarej7 -> B2 bucket rclone-test-revapux5jelixek5walajat3 2022/05/21 05:23:15 DEBUG : empty space: Excluded 2022/05/21 05:23:15 DEBUG : empty space: Excluded 2022/05/21 05:23:15 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2022/05/21 05:23:15 DEBUG : B2 bucket rclone-test-revapux5jelixek5walajat3: Waiting for checks to finish 2022/05/21 05:23:15 DEBUG : B2 bucket rclone-test-revapux5jelixek5walajat3: Waiting for transfers to finish 2022/05/21 05:23:16 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2022/05/21 05:23:16 INFO : potato3: Copied (server-side copy) 2022/05/21 05:23:16 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/05/21 05:23:16 INFO : potato2: Copied (server-side copy) 2022/05/21 05:23:17 INFO : potato2: Deleted 2022/05/21 05:23:17 INFO : potato3: Deleted 2022/05/21 05:23:18 DEBUG : Creating backend with remote "TestB2:rclone-test-cukoxuz4hisuvam5weqihom0" 2022/05/21 05:23:18 DEBUG : empty space: Excluded 2022/05/21 05:23:18 DEBUG : B2 bucket rclone-test-cukoxuz4hisuvam5weqihom0: Waiting for checks to finish 2022/05/21 05:23:18 DEBUG : B2 bucket rclone-test-cukoxuz4hisuvam5weqihom0: Waiting for transfers to finish 2022/05/21 05:23:20 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2022/05/21 05:23:20 INFO : potato3: Copied (server-side copy) 2022/05/21 05:23:20 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/05/21 05:23:20 INFO : potato2: Copied (server-side copy) 2022/05/21 05:23:21 INFO : potato3: Deleted 2022/05/21 05:23:22 INFO : potato2: Deleted 2022/05/21 05:23:22 DEBUG : B2 bucket rclone-test-cukoxuz4hisuvam5weqihom0: Purge remote 2022/05/21 05:23:22 DEBUG : potato2: Deleting (id "4_z5f02edd3101deb5b8f080e1b_f119a067169b4aabe_d20220521_m052319_c001_v0001097_t0035_u01653110599814") 2022/05/21 05:23:22 DEBUG : potato3: Deleting (id "4_z5f02edd3101deb5b8f080e1b_f102e65b5a28ba99c_d20220521_m052319_c001_v0001134_t0017_u01653110599757") 2022/05/21 05:23:23 DEBUG : B2 bucket rclone-test-revapux5jelixek5walajat3: Purge remote 2022/05/21 05:23:24 DEBUG : empty space: Deleting (id "4_z9f92dd63101deb5b8f080e1b_f116514183c2a5a6e_d20220521_m052314_c001_v0001130_t0051_u01653110594441") 2022/05/21 05:23:24 DEBUG : potato2: Deleting (id "4_z9f92dd63101deb5b8f080e1b_f1068b39e308ac56f_d20220521_m052320_c001_v0001039_t0057_u01653110600213") 2022/05/21 05:23:24 DEBUG : potato2: Deleting (id "4_z9f92dd63101deb5b8f080e1b_f1076c4451ec206fe_d20220521_m052316_c001_v0001003_t0043_u01653110596039") 2022/05/21 05:23:24 DEBUG : potato3: Deleting (id "4_z9f92dd63101deb5b8f080e1b_f10002e101feefcad_d20220521_m052320_c001_v0001041_t0021_u01653110600148") 2022/05/21 05:23:24 DEBUG : potato3: Deleting (id "4_z9f92dd63101deb5b8f080e1b_f101a853029173457_d20220521_m052315_c001_v0001103_t0043_u01653110595964") 2022/05/21 05:23:24 DEBUG : potato3: Deleting (id "4_z9f92dd63101deb5b8f080e1b_f116514183c2a5a72_d20220521_m052314_c001_v0001130_t0044_u01653110594812") --- PASS: TestServerSideMoveWithFilter (23.37s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:23:26 DEBUG : Creating backend with remote "TestB2:rclone-test-fofamat9tebawev5finalaw8" 2022/05/21 05:23:32 DEBUG : tomatoDir: Making directory sync_test.go:1215: Server side move (if possible) B2 bucket rclone-test-basolug0menateb8qudarej7 -> B2 bucket rclone-test-fofamat9tebawev5finalaw8 2022/05/21 05:23:37 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ms) 2022/05/21 05:23:37 DEBUG : empty space: Unchanged skipping 2022/05/21 05:23:37 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2022/05/21 05:23:37 DEBUG : B2 bucket rclone-test-fofamat9tebawev5finalaw8: Waiting for checks to finish 2022/05/21 05:23:38 INFO : empty space: Deleted 2022/05/21 05:23:38 DEBUG : B2 bucket rclone-test-fofamat9tebawev5finalaw8: Waiting for transfers to finish 2022/05/21 05:23:38 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/05/21 05:23:38 INFO : potato2: Copied (server-side copy) 2022/05/21 05:23:40 INFO : potato2: Deleted 2022/05/21 05:23:43 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2022/05/21 05:23:43 INFO : potato3: Copied (server-side copy) 2022/05/21 05:23:44 INFO : potato3: Deleted 2022/05/21 05:23:44 DEBUG : Creating backend with remote "TestB2:rclone-test-xujosor4yehacuv8tedikaf5" 2022/05/21 05:23:45 DEBUG : tomatoDir: Making directory 2022/05/21 05:23:45 DEBUG : B2 bucket rclone-test-xujosor4yehacuv8tedikaf5: Waiting for checks to finish 2022/05/21 05:23:45 DEBUG : B2 bucket rclone-test-xujosor4yehacuv8tedikaf5: Waiting for transfers to finish 2022/05/21 05:23:47 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/05/21 05:23:47 INFO : empty space: Copied (server-side copy) 2022/05/21 05:23:48 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/05/21 05:23:48 INFO : potato2: Copied (server-side copy) 2022/05/21 05:23:48 INFO : empty space: Deleted 2022/05/21 05:23:49 INFO : potato2: Deleted 2022/05/21 05:23:49 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2022/05/21 05:23:49 INFO : potato3: Copied (server-side copy) 2022/05/21 05:23:50 INFO : potato3: Deleted 2022/05/21 05:23:50 DEBUG : B2 bucket rclone-test-xujosor4yehacuv8tedikaf5: Purge remote 2022/05/21 05:23:50 DEBUG : empty space: Deleting (id "4_zaf925d63102deb5b8f080e1b_f1053cf75383965b8_d20220521_m052346_c001_v0001101_t0046_u01653110626701") 2022/05/21 05:23:50 DEBUG : potato2: Deleting (id "4_zaf925d63102deb5b8f080e1b_f1070ef7cfdeafc0e_d20220521_m052346_c001_v0001103_t0002_u01653110626686") 2022/05/21 05:23:50 DEBUG : potato3: Deleting (id "4_zaf925d63102deb5b8f080e1b_f102cc3291711bf05_d20220521_m052347_c001_v0001109_t0041_u01653110627129") 2022/05/21 05:23:51 DEBUG : B2 bucket rclone-test-fofamat9tebawev5finalaw8: Purge remote 2022/05/21 05:23:52 DEBUG : empty space: Deleting (id "4_z0fc22d33102deb5b8f080e1b_f10330213f1bbc2c4_d20220521_m052347_c001_v0001106_t0044_u01653110627320") 2022/05/21 05:23:52 DEBUG : empty space: Deleting (id "4_z0fc22d33102deb5b8f080e1b_f1185d34e8955c954_d20220521_m052333_c001_v0001106_t0004_u01653110613885") 2022/05/21 05:23:52 DEBUG : potato2: Deleting (id "4_z0fc22d33102deb5b8f080e1b_f11792aad1dc19815_d20220521_m052348_c001_v0001157_t0051_u01653110628816") 2022/05/21 05:23:52 DEBUG : potato2: Deleting (id "4_z0fc22d33102deb5b8f080e1b_f117918c06af2e756_d20220521_m052337_c001_v0001105_t0025_u01653110617401") 2022/05/21 05:23:52 DEBUG : potato3: Deleting (id "4_z0fc22d33102deb5b8f080e1b_f105edb7a1e51e30c_d20220521_m052349_c001_v0001130_t0021_u01653110629975") 2022/05/21 05:23:52 DEBUG : potato3: Deleting (id "4_z0fc22d33102deb5b8f080e1b_f10879bb6701c957c_d20220521_m052337_c001_v0001109_t0011_u01653110617787") 2022/05/21 05:23:52 DEBUG : potato3: Deleting (id "4_z0fc22d33102deb5b8f080e1b_f1185d34e8955c97f_d20220521_m052335_c001_v0001106_t0023_u01653110615688") --- PASS: TestServerSideMoveDeleteEmptySourceDirs (27.21s) === RUN TestServerSideMoveOverlap run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:23:53 DEBUG : Creating backend with remote "TestB2:rclone-test-basolug0menateb8qudarej7/rclone-move-test" 2022/05/21 05:23:54 DEBUG : Couldn't decode error response: EOF --- PASS: TestServerSideMoveOverlap (4.16s) === RUN TestSyncOverlap run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:23:57 DEBUG : Creating backend with remote "TestB2:rclone-test-basolug0menateb8qudarej7/rclone-sync-test" 2022/05/21 05:23:58 DEBUG : Couldn't decode error response: EOF --- PASS: TestSyncOverlap (0.80s) === RUN TestSyncCompareDest run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:23:58 DEBUG : Creating backend with remote "TestB2:rclone-test-basolug0menateb8qudarej7/dst" 2022/05/21 05:23:59 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:23:59 DEBUG : Creating backend with remote "TestB2:rclone-test-basolug0menateb8qudarej7/CompareDest" 2022/05/21 05:23:59 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:24:00 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:24:00 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for checks to finish 2022/05/21 05:24:00 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for transfers to finish 2022/05/21 05:24:01 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/05/21 05:24:01 INFO : one: Copied (new) 2022/05/21 05:24:01 DEBUG : Waiting for deletions to finish 2022/05/21 05:24:02 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for checks to finish 2022/05/21 05:24:02 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:24:02 DEBUG : one: Sizes differ (src 5 vs dst 3) 2022/05/21 05:24:02 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for transfers to finish 2022/05/21 05:24:02 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2022/05/21 05:24:02 INFO : one: Copied (replaced existing) 2022/05/21 05:24:02 DEBUG : Waiting for deletions to finish 2022/05/21 05:24:09 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for checks to finish 2022/05/21 05:24:10 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/21 05:24:10 DEBUG : one: Destination found in --compare-dest, skipping 2022/05/21 05:24:10 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for transfers to finish 2022/05/21 05:24:10 DEBUG : Waiting for deletions to finish 2022/05/21 05:24:10 INFO : There was nothing to transfer 2022/05/21 05:24:11 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/21 05:24:11 DEBUG : two: Destination found in --compare-dest, skipping 2022/05/21 05:24:11 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for checks to finish 2022/05/21 05:24:12 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/21 05:24:12 DEBUG : one: Destination found in --compare-dest, skipping 2022/05/21 05:24:12 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for transfers to finish 2022/05/21 05:24:12 DEBUG : Waiting for deletions to finish 2022/05/21 05:24:12 INFO : There was nothing to transfer 2022/05/21 05:24:12 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/21 05:24:12 DEBUG : two: Destination found in --compare-dest, skipping 2022/05/21 05:24:12 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for checks to finish 2022/05/21 05:24:12 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/21 05:24:12 DEBUG : one: Destination found in --compare-dest, skipping 2022/05/21 05:24:12 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for transfers to finish 2022/05/21 05:24:12 DEBUG : Waiting for deletions to finish 2022/05/21 05:24:12 INFO : There was nothing to transfer 2022/05/21 05:24:13 DEBUG : two: Modification times differ by -119h59m59.877s: 2011-12-30 12:59:59 +0000 UTC, 2011-12-25 12:59:59.123 +0000 UTC 2022/05/21 05:24:13 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2022/05/21 05:24:13 DEBUG : two: Destination found in --compare-dest, skipping 2022/05/21 05:24:13 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for checks to finish 2022/05/21 05:24:13 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/21 05:24:13 DEBUG : one: Destination found in --compare-dest, skipping 2022/05/21 05:24:13 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for transfers to finish 2022/05/21 05:24:13 DEBUG : Waiting for deletions to finish 2022/05/21 05:24:13 INFO : There was nothing to transfer 2022/05/21 05:24:14 DEBUG : two: Sizes differ (src 5 vs dst 3) 2022/05/21 05:24:14 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for checks to finish 2022/05/21 05:24:14 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/21 05:24:14 DEBUG : one: Destination found in --compare-dest, skipping 2022/05/21 05:24:14 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for transfers to finish 2022/05/21 05:24:15 DEBUG : two: sha1 = a4be8877ad88f3109a6411985a1f359e10e2d930 OK 2022/05/21 05:24:15 INFO : two: Copied (new) 2022/05/21 05:24:15 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (23.27s) === RUN TestSyncMultipleCompareDest run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:24:24 DEBUG : Creating backend with remote "TestB2:rclone-test-basolug0menateb8qudarej7/dest" 2022/05/21 05:24:25 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:24:25 DEBUG : Creating backend with remote "TestB2:rclone-test-basolug0menateb8qudarej7/pre-dest1" 2022/05/21 05:24:26 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:24:26 DEBUG : Creating backend with remote "TestB2:rclone-test-basolug0menateb8qudarej7/pre-dest2" 2022/05/21 05:24:26 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:24:27 DEBUG : 1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:24:27 DEBUG : 1: Destination found in --compare-dest, skipping 2022/05/21 05:24:27 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:24:27 DEBUG : 2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:24:27 DEBUG : 2: Destination found in --compare-dest, skipping 2022/05/21 05:24:27 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:24:28 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:24:28 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dest: Waiting for checks to finish 2022/05/21 05:24:28 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dest: Waiting for transfers to finish 2022/05/21 05:24:29 DEBUG : 3: sha1 = 77de68daecd823babbb58edb1c8e14d7106e83bb OK 2022/05/21 05:24:29 INFO : 3: Copied (new) 2022/05/21 05:24:29 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (11.92s) === RUN TestSyncCopyDest run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:24:33 DEBUG : Creating backend with remote "TestB2:rclone-test-basolug0menateb8qudarej7/dst" 2022/05/21 05:24:35 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:24:35 DEBUG : Creating backend with remote "TestB2:rclone-test-basolug0menateb8qudarej7/CopyDest" 2022/05/21 05:24:35 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:24:36 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:24:36 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for checks to finish 2022/05/21 05:24:36 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for transfers to finish 2022/05/21 05:24:37 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/05/21 05:24:37 INFO : one: Copied (new) 2022/05/21 05:24:37 DEBUG : Waiting for deletions to finish 2022/05/21 05:24:38 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for checks to finish 2022/05/21 05:24:38 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:24:38 DEBUG : one: Sizes differ (src 5 vs dst 3) 2022/05/21 05:24:38 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for transfers to finish 2022/05/21 05:24:39 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2022/05/21 05:24:39 INFO : one: Copied (replaced existing) 2022/05/21 05:24:39 DEBUG : Waiting for deletions to finish 2022/05/21 05:24:42 DEBUG : Creating backend with remote "TestB2:rclone-test-basolug0menateb8qudarej7/BackupDir" 2022/05/21 05:24:42 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:24:43 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for checks to finish 2022/05/21 05:24:43 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/21 05:24:43 DEBUG : one: Sizes differ (src 5 vs dst 3) 2022/05/21 05:24:43 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:24:47 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/05/21 05:24:47 INFO : one: Copied (server-side copy) 2022/05/21 05:24:49 INFO : one: Deleted 2022/05/21 05:24:50 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2022/05/21 05:24:50 INFO : one: Copied (server-side copy) 2022/05/21 05:24:50 DEBUG : one: Destination found in --copy-dest, using server-side copy 2022/05/21 05:24:50 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for transfers to finish 2022/05/21 05:24:50 DEBUG : Waiting for deletions to finish 2022/05/21 05:24:52 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/21 05:24:55 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2022/05/21 05:24:55 INFO : two: Copied (server-side copy) 2022/05/21 05:24:55 DEBUG : two: Destination found in --copy-dest, using server-side copy 2022/05/21 05:24:55 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for checks to finish 2022/05/21 05:24:55 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/21 05:24:55 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/21 05:24:55 DEBUG : one: Unchanged skipping 2022/05/21 05:24:55 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for transfers to finish 2022/05/21 05:24:55 DEBUG : Waiting for deletions to finish 2022/05/21 05:24:55 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for checks to finish 2022/05/21 05:24:56 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/21 05:24:56 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/21 05:24:56 DEBUG : one: Unchanged skipping 2022/05/21 05:24:56 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/21 05:24:56 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/21 05:24:56 DEBUG : two: Unchanged skipping 2022/05/21 05:24:56 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for transfers to finish 2022/05/21 05:24:56 DEBUG : Waiting for deletions to finish 2022/05/21 05:24:56 INFO : There was nothing to transfer 2022/05/21 05:25:18 DEBUG : three: Sizes differ (src 7 vs dst 5) 2022/05/21 05:25:18 DEBUG : three: Destination not found in --copy-dest 2022/05/21 05:25:18 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for checks to finish 2022/05/21 05:25:18 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/21 05:25:18 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/21 05:25:18 DEBUG : two: Unchanged skipping 2022/05/21 05:25:19 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/21 05:25:19 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/21 05:25:19 DEBUG : one: Unchanged skipping 2022/05/21 05:25:19 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for transfers to finish 2022/05/21 05:25:20 DEBUG : three: sha1 = 370e613335f3cf2f19b2a2d35a86402f55c659f8 OK 2022/05/21 05:25:20 INFO : three: Copied (new) 2022/05/21 05:25:20 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCopyDest (54.24s) === RUN TestSyncBackupDir run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:25:40 DEBUG : Creating backend with remote "TestB2:rclone-test-basolug0menateb8qudarej7/dst" 2022/05/21 05:25:41 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:25:41 DEBUG : Creating backend with remote "TestB2:rclone-test-basolug0menateb8qudarej7/backup" 2022/05/21 05:25:42 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:25:42 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/05/21 05:25:42 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for checks to finish 2022/05/21 05:25:42 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:25:42 DEBUG : two: Unchanged skipping 2022/05/21 05:25:42 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:25:44 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/05/21 05:25:44 INFO : one: Copied (server-side copy) 2022/05/21 05:25:45 INFO : one: Deleted 2022/05/21 05:25:45 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for transfers to finish 2022/05/21 05:25:48 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/05/21 05:25:48 INFO : one: Copied (new) 2022/05/21 05:25:48 DEBUG : Waiting for deletions to finish 2022/05/21 05:25:48 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:25:49 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/05/21 05:25:49 INFO : three.txt: Copied (server-side copy) 2022/05/21 05:25:51 INFO : three.txt: Deleted 2022/05/21 05:25:51 INFO : three.txt: Moved into backup dir 2022/05/21 05:25:54 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/05/21 05:25:54 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for checks to finish 2022/05/21 05:25:54 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:25:54 DEBUG : two: Unchanged skipping 2022/05/21 05:26:06 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/05/21 05:26:06 INFO : one: Copied (server-side copy) 2022/05/21 05:26:07 INFO : one: Deleted 2022/05/21 05:26:07 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for transfers to finish 2022/05/21 05:26:09 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2022/05/21 05:26:09 INFO : one: Copied (new) 2022/05/21 05:26:09 DEBUG : Waiting for deletions to finish 2022/05/21 05:26:10 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/05/21 05:26:10 INFO : three.txt: Copied (server-side copy) 2022/05/21 05:26:11 INFO : three.txt: Deleted 2022/05/21 05:26:11 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (47.11s) === RUN TestSyncBackupDirWithSuffix run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:26:25 DEBUG : Creating backend with remote "TestB2:rclone-test-basolug0menateb8qudarej7/dst" 2022/05/21 05:26:25 DEBUG : Config file has changed externaly - reloading 2022/05/21 05:26:27 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:26:27 DEBUG : Creating backend with remote "TestB2:rclone-test-basolug0menateb8qudarej7/backup" 2022/05/21 05:26:27 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:26:28 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/05/21 05:26:28 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:26:28 DEBUG : two: Unchanged skipping 2022/05/21 05:26:28 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for checks to finish 2022/05/21 05:26:28 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:26:30 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/05/21 05:26:30 INFO : one: Copied (server-side copy) to: one.bak 2022/05/21 05:26:31 INFO : one: Deleted 2022/05/21 05:26:31 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for transfers to finish 2022/05/21 05:26:33 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/05/21 05:26:33 INFO : one: Copied (new) 2022/05/21 05:26:33 DEBUG : Waiting for deletions to finish 2022/05/21 05:26:34 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:26:35 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/05/21 05:26:35 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/05/21 05:26:37 INFO : three.txt: Deleted 2022/05/21 05:26:37 INFO : three.txt: Moved into backup dir 2022/05/21 05:26:38 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/05/21 05:26:38 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:26:38 DEBUG : two: Unchanged skipping 2022/05/21 05:26:38 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for checks to finish 2022/05/21 05:26:39 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/05/21 05:26:39 INFO : one: Copied (server-side copy) to: one.bak 2022/05/21 05:26:40 INFO : one: Deleted 2022/05/21 05:26:40 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for transfers to finish 2022/05/21 05:26:42 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2022/05/21 05:26:42 INFO : one: Copied (new) 2022/05/21 05:26:42 DEBUG : Waiting for deletions to finish 2022/05/21 05:26:43 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/05/21 05:26:43 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/05/21 05:26:43 INFO : three.txt: Deleted 2022/05/21 05:26:43 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (32.10s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:26:58 DEBUG : Creating backend with remote "TestB2:rclone-test-basolug0menateb8qudarej7/dst" 2022/05/21 05:26:59 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:26:59 DEBUG : Creating backend with remote "TestB2:rclone-test-basolug0menateb8qudarej7/backup" 2022/05/21 05:27:00 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:27:00 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/05/21 05:27:00 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:27:00 DEBUG : two: Unchanged skipping 2022/05/21 05:27:00 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for checks to finish 2022/05/21 05:27:00 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:27:03 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/05/21 05:27:03 INFO : one: Copied (server-side copy) to: one-2019-01-01 2022/05/21 05:27:04 INFO : one: Deleted 2022/05/21 05:27:04 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for transfers to finish 2022/05/21 05:27:07 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/05/21 05:27:07 INFO : one: Copied (new) 2022/05/21 05:27:07 DEBUG : Waiting for deletions to finish 2022/05/21 05:27:07 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:27:08 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/05/21 05:27:08 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2022/05/21 05:27:09 INFO : three.txt: Deleted 2022/05/21 05:27:09 INFO : three.txt: Moved into backup dir 2022/05/21 05:27:11 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/05/21 05:27:11 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for checks to finish 2022/05/21 05:27:11 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:27:11 DEBUG : two: Unchanged skipping 2022/05/21 05:27:12 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/05/21 05:27:12 INFO : one: Copied (server-side copy) to: one-2019-01-01 2022/05/21 05:27:13 INFO : one: Deleted 2022/05/21 05:27:13 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for transfers to finish 2022/05/21 05:27:15 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2022/05/21 05:27:15 INFO : one: Copied (new) 2022/05/21 05:27:15 DEBUG : Waiting for deletions to finish 2022/05/21 05:27:16 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/05/21 05:27:16 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2022/05/21 05:27:16 INFO : three.txt: Deleted 2022/05/21 05:27:16 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (35.18s) === RUN TestSyncBackupDirSuffixOnly run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:27:29 DEBUG : Creating backend with remote "TestB2:rclone-test-basolug0menateb8qudarej7/dst" 2022/05/21 05:27:29 DEBUG : Config file has changed externaly - reloading 2022/05/21 05:27:30 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:27:31 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for checks to finish 2022/05/21 05:27:31 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:27:31 DEBUG : two: Unchanged skipping 2022/05/21 05:27:31 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/05/21 05:27:31 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:27:32 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/05/21 05:27:32 INFO : one: Copied (server-side copy) to: one.bak 2022/05/21 05:27:33 INFO : one: Deleted 2022/05/21 05:27:33 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for transfers to finish 2022/05/21 05:27:35 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/05/21 05:27:35 INFO : one: Copied (new) 2022/05/21 05:27:35 DEBUG : Waiting for deletions to finish 2022/05/21 05:27:35 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:27:36 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/05/21 05:27:36 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/05/21 05:27:38 INFO : three.txt: Deleted 2022/05/21 05:27:38 INFO : three.txt: Moved into backup dir 2022/05/21 05:27:40 DEBUG : one.bak: Excluded 2022/05/21 05:27:40 DEBUG : three.txt.bak: Excluded 2022/05/21 05:27:40 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/05/21 05:27:40 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:27:40 DEBUG : two: Unchanged skipping 2022/05/21 05:27:40 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for checks to finish 2022/05/21 05:27:41 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/05/21 05:27:41 INFO : one: Copied (server-side copy) to: one.bak 2022/05/21 05:27:42 INFO : one: Deleted 2022/05/21 05:27:42 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7 path dst: Waiting for transfers to finish 2022/05/21 05:27:44 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2022/05/21 05:27:44 INFO : one: Copied (new) 2022/05/21 05:27:44 DEBUG : Waiting for deletions to finish 2022/05/21 05:27:44 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/05/21 05:27:44 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/05/21 05:27:45 INFO : three.txt: Deleted 2022/05/21 05:27:45 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (27.07s) === RUN TestSyncSuffix run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:27:55 DEBUG : Creating backend with remote "TestB2:rclone-test-basolug0menateb8qudarej7/dst" 2022/05/21 05:27:55 DEBUG : Config file has changed externaly - reloading 2022/05/21 05:27:56 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:27:57 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/05/21 05:27:57 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:28:02 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/05/21 05:28:02 INFO : one: Copied (server-side copy) to: one.bak 2022/05/21 05:28:04 INFO : one: Deleted 2022/05/21 05:28:05 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/05/21 05:28:05 INFO : one: Copied (new) 2022/05/21 05:28:05 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:28:05 DEBUG : two: Unchanged skipping 2022/05/21 05:28:05 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2022/05/21 05:28:06 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:28:07 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/05/21 05:28:07 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/05/21 05:28:08 INFO : three.txt: Deleted 2022/05/21 05:28:10 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/05/21 05:28:10 INFO : three.txt: Copied (new) 2022/05/21 05:28:10 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/05/21 05:28:11 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/05/21 05:28:11 INFO : one: Copied (server-side copy) to: one.bak 2022/05/21 05:28:12 INFO : one: Deleted 2022/05/21 05:28:13 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2022/05/21 05:28:13 INFO : one: Copied (new) 2022/05/21 05:28:13 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:28:13 DEBUG : two: Unchanged skipping 2022/05/21 05:28:14 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2022/05/21 05:28:15 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/05/21 05:28:15 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/05/21 05:28:15 INFO : three.txt: Deleted 2022/05/21 05:28:18 DEBUG : three.txt: sha1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK 2022/05/21 05:28:18 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (33.93s) === RUN TestSyncSuffixKeepExtension run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:28:27 DEBUG : Creating backend with remote "TestB2:rclone-test-basolug0menateb8qudarej7/dst" 2022/05/21 05:28:28 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:28:28 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/05/21 05:28:29 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:28:30 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/05/21 05:28:30 INFO : one: Copied (server-side copy) to: one-2019-01-01 2022/05/21 05:28:31 INFO : one: Deleted 2022/05/21 05:28:33 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/05/21 05:28:33 INFO : one: Copied (new) 2022/05/21 05:28:33 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:28:33 DEBUG : two: Unchanged skipping 2022/05/21 05:28:33 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2022/05/21 05:28:33 DEBUG : Couldn't decode error response: EOF 2022/05/21 05:28:36 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/05/21 05:28:36 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2022/05/21 05:28:36 INFO : three.txt: Deleted 2022/05/21 05:28:38 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/05/21 05:28:38 INFO : three.txt: Copied (new) 2022/05/21 05:28:39 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/05/21 05:28:40 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/05/21 05:28:40 INFO : one: Copied (server-side copy) to: one-2019-01-01 2022/05/21 05:28:41 INFO : one: Deleted 2022/05/21 05:28:42 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2022/05/21 05:28:42 INFO : one: Copied (new) 2022/05/21 05:28:42 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:28:42 DEBUG : two: Unchanged skipping 2022/05/21 05:28:43 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2022/05/21 05:28:44 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/05/21 05:28:44 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2022/05/21 05:28:47 INFO : three.txt: Deleted 2022/05/21 05:28:47 DEBUG : three.txt: Clearing upload URL because of error: Post "https://pod-000-1115-10.backblaze.com/b2api/v1/b2_upload_file/af923de300ddeb5b8f080e1b/c001_v0001115_t0045": EOF 2022/05/21 05:28:47 DEBUG : pacer: low level retry 1/1 (error Post "https://pod-000-1115-10.backblaze.com/b2api/v1/b2_upload_file/af923de300ddeb5b8f080e1b/c001_v0001115_t0045": EOF) 2022/05/21 05:28:47 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2022/05/21 05:28:47 DEBUG : three.txt: Received error: Post "https://pod-000-1115-10.backblaze.com/b2api/v1/b2_upload_file/af923de300ddeb5b8f080e1b/c001_v0001115_t0045": EOF - low level retry 1/10 2022/05/21 05:28:47 DEBUG : pacer: Reducing sleep to 10ms 2022/05/21 05:28:51 DEBUG : three.txt: sha1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK 2022/05/21 05:28:51 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (34.76s) === RUN TestSyncUTFNorm run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:29:03 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2022/05/21 05:29:03 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:29:03 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:29:03 DEBUG : Testêé: sha1 = a54d88e06612d820bc3be72877c74f257b561b19 OK 2022/05/21 05:29:03 INFO : Testêé: Copied (replaced existing) to: Testêé 2022/05/21 05:29:03 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (6.64s) === RUN TestSyncImmutable run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:29:05 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:29:05 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:29:06 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2022/05/21 05:29:06 INFO : existing: Copied (new) 2022/05/21 05:29:06 DEBUG : Waiting for deletions to finish 2022/05/21 05:29:06 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:29:06 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2022/05/21 05:29:06 ERROR : existing: Source and destination exist but do not match: immutable file modified 2022/05/21 05:29:06 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:29:06 ERROR : B2 bucket rclone-test-basolug0menateb8qudarej7: not deleting files as there were IO errors 2022/05/21 05:29:06 ERROR : B2 bucket rclone-test-basolug0menateb8qudarej7: not deleting directories as there were IO errors --- PASS: TestSyncImmutable (4.89s) === RUN TestSyncIgnoreCase run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:29:15 DEBUG : existing: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:29:15 DEBUG : existing: Unchanged skipping 2022/05/21 05:29:15 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:29:15 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:29:15 DEBUG : Waiting for deletions to finish 2022/05/21 05:29:15 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (7.77s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" sync_test.go:1989: This test only runs on local === RUN TestMaxTransfer/Soft run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" sync_test.go:1989: This test only runs on local === RUN TestMaxTransfer/Cautious run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" sync_test.go:1989: This test only runs on local --- PASS: TestMaxTransfer (1.12s) --- SKIP: TestMaxTransfer/Hard (0.39s) --- SKIP: TestMaxTransfer/Soft (0.37s) --- SKIP: TestMaxTransfer/Cautious (0.37s) === RUN TestSyncConcurrentDelete run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:31:24 DEBUG : both1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:31:24 DEBUG : both1: Unchanged skipping 2022/05/21 05:31:24 DEBUG : both10: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:31:24 DEBUG : both10: Unchanged skipping 2022/05/21 05:31:24 DEBUG : both11: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:31:24 DEBUG : both11: Unchanged skipping 2022/05/21 05:31:24 DEBUG : both12: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:31:24 DEBUG : both12: Unchanged skipping 2022/05/21 05:31:24 DEBUG : both13: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:31:24 DEBUG : both13: Unchanged skipping 2022/05/21 05:31:24 DEBUG : both14: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:31:24 DEBUG : both14: Unchanged skipping 2022/05/21 05:31:24 DEBUG : both15: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:31:24 DEBUG : both15: Unchanged skipping 2022/05/21 05:31:24 DEBUG : both16: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:31:24 DEBUG : both16: Unchanged skipping 2022/05/21 05:31:24 DEBUG : both17: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:31:24 DEBUG : both17: Unchanged skipping 2022/05/21 05:31:24 DEBUG : both18: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:31:24 DEBUG : both18: Unchanged skipping 2022/05/21 05:31:24 DEBUG : both19: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:31:24 DEBUG : both19: Unchanged skipping 2022/05/21 05:31:24 DEBUG : both2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:31:24 DEBUG : both2: Unchanged skipping 2022/05/21 05:31:24 DEBUG : both3: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:31:24 DEBUG : both3: Unchanged skipping 2022/05/21 05:31:24 DEBUG : both4: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:31:24 DEBUG : both4: Unchanged skipping 2022/05/21 05:31:24 DEBUG : both5: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:31:24 DEBUG : both5: Unchanged skipping 2022/05/21 05:31:24 DEBUG : both6: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:31:24 DEBUG : both6: Unchanged skipping 2022/05/21 05:31:24 DEBUG : both7: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:31:24 DEBUG : both7: Unchanged skipping 2022/05/21 05:31:24 DEBUG : both8: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:31:24 DEBUG : both8: Unchanged skipping 2022/05/21 05:31:24 DEBUG : both9: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:31:24 DEBUG : both9: Unchanged skipping 2022/05/21 05:31:24 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:31:24 DEBUG : both0: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:31:24 DEBUG : both0: Unchanged skipping 2022/05/21 05:31:24 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:31:24 DEBUG : Waiting for deletions to finish 2022/05/21 05:31:24 INFO : only8: Deleted 2022/05/21 05:31:25 INFO : only1: Deleted 2022/05/21 05:31:26 INFO : only11: Deleted 2022/05/21 05:31:26 INFO : only7: Deleted 2022/05/21 05:31:26 INFO : only6: Deleted 2022/05/21 05:31:27 INFO : only13: Deleted 2022/05/21 05:31:27 INFO : only10: Deleted 2022/05/21 05:31:27 INFO : only18: Deleted 2022/05/21 05:31:28 INFO : only4: Deleted 2022/05/21 05:31:28 INFO : only2: Deleted 2022/05/21 05:31:29 INFO : only9: Deleted 2022/05/21 05:31:30 INFO : only14: Deleted 2022/05/21 05:31:30 INFO : only17: Deleted 2022/05/21 05:31:31 INFO : only19: Deleted 2022/05/21 05:31:31 INFO : only0: Deleted 2022/05/21 05:31:31 INFO : only12: Deleted 2022/05/21 05:31:32 INFO : only15: Deleted 2022/05/21 05:31:32 INFO : only5: Deleted 2022/05/21 05:31:32 INFO : only3: Deleted 2022/05/21 05:31:33 INFO : only16: Deleted 2022/05/21 05:31:33 INFO : There was nothing to transfer --- PASS: TestSyncConcurrentDelete (161.63s) === RUN TestSyncConcurrentTruncate run.go:181: Remote "B2 bucket rclone-test-basolug0menateb8qudarej7", Local "Local file system at /tmp/rclone2849254064", Modify Window "1ms" 2022/05/21 05:32:53 DEBUG : both15: Clearing upload URL because of error: Post "https://pod-000-1040-03.backblaze.com/b2api/v1/b2_upload_file/af923de300ddeb5b8f080e1b/c001_v0001040_t0048": EOF 2022/05/21 05:32:53 DEBUG : pacer: low level retry 1/1 (error Post "https://pod-000-1040-03.backblaze.com/b2api/v1/b2_upload_file/af923de300ddeb5b8f080e1b/c001_v0001040_t0048": EOF) 2022/05/21 05:32:53 DEBUG : pacer: Rate limited, increasing sleep to 20ms run.go:283: Retry Put of "both15" to B2 bucket rclone-test-basolug0menateb8qudarej7: 1/10 (Post "https://pod-000-1040-03.backblaze.com/b2api/v1/b2_upload_file/af923de300ddeb5b8f080e1b/c001_v0001040_t0048": EOF) 2022/05/21 05:32:57 DEBUG : pacer: Reducing sleep to 10ms 2022/05/21 05:33:08 DEBUG : both1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:33:08 DEBUG : both0: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:33:08 DEBUG : both0: Unchanged skipping 2022/05/21 05:33:08 DEBUG : both11: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:33:08 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for checks to finish 2022/05/21 05:33:08 DEBUG : both11: Unchanged skipping 2022/05/21 05:33:08 DEBUG : both13: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:33:08 DEBUG : both13: Unchanged skipping 2022/05/21 05:33:08 DEBUG : both14: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:33:08 DEBUG : both14: Unchanged skipping 2022/05/21 05:33:08 DEBUG : both15: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:33:08 DEBUG : both15: Unchanged skipping 2022/05/21 05:33:08 DEBUG : both16: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:33:08 DEBUG : both16: Unchanged skipping 2022/05/21 05:33:08 DEBUG : both17: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:33:08 DEBUG : both17: Unchanged skipping 2022/05/21 05:33:08 DEBUG : both18: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:33:08 DEBUG : both18: Unchanged skipping 2022/05/21 05:33:08 DEBUG : both19: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:33:08 DEBUG : both19: Unchanged skipping 2022/05/21 05:33:08 DEBUG : both2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:33:08 DEBUG : both2: Unchanged skipping 2022/05/21 05:33:08 DEBUG : both3: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:33:08 DEBUG : both3: Unchanged skipping 2022/05/21 05:33:08 DEBUG : both4: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:33:08 DEBUG : both4: Unchanged skipping 2022/05/21 05:33:08 DEBUG : both5: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:33:08 DEBUG : both5: Unchanged skipping 2022/05/21 05:33:08 DEBUG : both6: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:33:08 DEBUG : both6: Unchanged skipping 2022/05/21 05:33:08 DEBUG : both12: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:33:08 DEBUG : both7: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:33:08 DEBUG : both7: Unchanged skipping 2022/05/21 05:33:08 DEBUG : both1: Unchanged skipping 2022/05/21 05:33:08 DEBUG : both8: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:33:08 DEBUG : both8: Unchanged skipping 2022/05/21 05:33:08 DEBUG : both9: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:33:08 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2022/05/21 05:33:08 DEBUG : both12: Unchanged skipping 2022/05/21 05:33:08 DEBUG : both10: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/21 05:33:08 DEBUG : both10: Unchanged skipping 2022/05/21 05:33:08 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2022/05/21 05:33:08 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2022/05/21 05:33:08 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2022/05/21 05:33:08 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2022/05/21 05:33:08 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2022/05/21 05:33:08 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2022/05/21 05:33:08 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2022/05/21 05:33:08 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2022/05/21 05:33:08 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2022/05/21 05:33:08 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2022/05/21 05:33:08 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2022/05/21 05:33:08 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2022/05/21 05:33:08 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2022/05/21 05:33:08 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2022/05/21 05:33:08 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2022/05/21 05:33:08 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2022/05/21 05:33:08 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2022/05/21 05:33:08 DEBUG : both9: Unchanged skipping 2022/05/21 05:33:08 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2022/05/21 05:33:08 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2022/05/21 05:33:08 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Waiting for transfers to finish 2022/05/21 05:33:09 DEBUG : only11: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/21 05:33:09 INFO : only11: Copied (replaced existing) 2022/05/21 05:33:09 DEBUG : only0: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/21 05:33:09 INFO : only0: Copied (replaced existing) 2022/05/21 05:33:10 DEBUG : only15: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/21 05:33:10 INFO : only15: Copied (replaced existing) 2022/05/21 05:33:10 DEBUG : only13: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/21 05:33:10 INFO : only13: Copied (replaced existing) 2022/05/21 05:33:10 DEBUG : only16: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/21 05:33:10 INFO : only16: Copied (replaced existing) 2022/05/21 05:33:10 DEBUG : only17: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/21 05:33:10 INFO : only17: Copied (replaced existing) 2022/05/21 05:33:10 DEBUG : only12: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/21 05:33:10 INFO : only12: Copied (replaced existing) 2022/05/21 05:33:11 DEBUG : only14: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/21 05:33:11 INFO : only14: Copied (replaced existing) 2022/05/21 05:33:11 DEBUG : only18: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/21 05:33:11 INFO : only18: Copied (replaced existing) 2022/05/21 05:33:11 DEBUG : only2: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/21 05:33:11 INFO : only2: Copied (replaced existing) 2022/05/21 05:33:11 DEBUG : only3: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/21 05:33:11 INFO : only3: Copied (replaced existing) 2022/05/21 05:33:11 DEBUG : only19: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/21 05:33:11 INFO : only19: Copied (replaced existing) 2022/05/21 05:33:12 DEBUG : only7: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/21 05:33:12 INFO : only7: Copied (replaced existing) 2022/05/21 05:33:13 DEBUG : only5: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/21 05:33:13 INFO : only5: Copied (replaced existing) 2022/05/21 05:33:13 DEBUG : only8: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/21 05:33:13 INFO : only8: Copied (replaced existing) 2022/05/21 05:33:13 DEBUG : only6: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/21 05:33:13 INFO : only6: Copied (replaced existing) 2022/05/21 05:33:13 DEBUG : only9: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/21 05:33:13 INFO : only9: Copied (replaced existing) 2022/05/21 05:33:14 DEBUG : only10: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/21 05:33:14 INFO : only10: Copied (replaced existing) 2022/05/21 05:33:14 DEBUG : only4: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/21 05:33:14 INFO : only4: Copied (replaced existing) 2022/05/21 05:33:16 DEBUG : only1: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/21 05:33:16 INFO : only1: Copied (replaced existing) 2022/05/21 05:33:16 DEBUG : Waiting for deletions to finish --- PASS: TestSyncConcurrentTruncate (135.88s) PASS 2022/05/21 05:34:16 DEBUG : B2 bucket rclone-test-basolug0menateb8qudarej7: Purge remote 2022/05/21 05:34:16 DEBUG : BackupDir/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f111e981f926e446d_d20220521_m052521_c001_v0001109_t0048_u01653110721086") 2022/05/21 05:34:16 DEBUG : BackupDir/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f110c2a513077c486_d20220521_m052444_c001_v0001117_t0012_u01653110684377") 2022/05/21 05:34:16 DEBUG : CompareDest/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f119c0006fbc902aa_d20220521_m052416_c001_v0001021_t0021_u01653110656414") 2022/05/21 05:34:16 DEBUG : CompareDest/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8a9017_d20220521_m052408_c001_v0001102_t0051_u01653110648149") 2022/05/21 05:34:16 DEBUG : CompareDest/two: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f118bbdfa3a450dad_d20220521_m052417_c001_v0001041_t0010_u01653110657081") 2022/05/21 05:34:16 DEBUG : CompareDest/two: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2aa6d6_d20220521_m052410_c001_v0001102_t0057_u01653110650745") 2022/05/21 05:34:16 DEBUG : CopyDest/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a677c448e850f_d20220521_m052522_c001_v0001098_t0012_u01653110722508") 2022/05/21 05:34:16 DEBUG : CopyDest/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b18507_d20220521_m052441_c001_v0001040_t0014_u01653110681562") 2022/05/21 05:34:16 DEBUG : CopyDest/three: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f10828efc0e46e91d_d20220521_m052523_c001_v0001004_t0032_u01653110723057") 2022/05/21 05:34:16 DEBUG : CopyDest/three: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2aa9d8_d20220521_m052457_c001_v0001102_t0010_u01653110697007") 2022/05/21 05:34:17 DEBUG : CopyDest/two: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f114a50bad5149cbe_d20220521_m052524_c001_v0001115_t0021_u01653110724513") 2022/05/21 05:34:17 DEBUG : CopyDest/two: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8a92d1_d20220521_m052450_c001_v0001102_t0047_u01653110690905") 2022/05/21 05:34:17 DEBUG : EXISTING: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f107fee78c8b56719_d20220521_m052916_c001_v0001023_t0000_u01653110956202") 2022/05/21 05:34:17 DEBUG : EXISTING: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8aa3ac_d20220521_m052911_c001_v0001102_t0015_u01653110950233") 2022/05/21 05:34:17 DEBUG : Testêé: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f106aa90dc667c183_d20220521_m052904_c001_v0001098_t0002_u01653110944411") 2022/05/21 05:34:17 DEBUG : Testêé: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2ab93a_d20220521_m052903_c001_v0001102_t0011_u01653110943451") 2022/05/21 05:34:17 DEBUG : Testêé: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8aa2c1_d20220521_m052858_c001_v0001102_t0006_u01653110938688") 2022/05/21 05:34:17 DEBUG : a/potato2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f11823f11b535a960_d20220521_m052015_c001_v0001115_t0042_u01653110415089") 2022/05/21 05:34:17 DEBUG : a/potato2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffb35d_d20220521_m052014_c001_v0001101_t0024_u01653110414041") 2022/05/21 05:34:17 DEBUG : a/potato2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103a57f61fa32b41_d20220521_m052011_c001_v0001011_t0001_u01653110411397") 2022/05/21 05:34:17 DEBUG : a/potato2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffb314_d20220521_m052009_c001_v0001101_t0031_u01653110409711") 2022/05/21 05:34:17 DEBUG : a/potato2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1014553603b376d6_d20220521_m051924_c001_v0001165_t0005_u01653110364734") 2022/05/21 05:34:17 DEBUG : a/potato2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffb053_d20220521_m051921_c001_v0001101_t0023_u01653110361911") 2022/05/21 05:34:18 DEBUG : b/potato: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f10970a949d98c9cc_d20220521_m052016_c001_v0001103_t0035_u01653110416620") 2022/05/21 05:34:18 DEBUG : b/potato: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffb346_d20220521_m052012_c001_v0001101_t0035_u01653110412580") 2022/05/21 05:34:18 DEBUG : b/potato: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f113016ef38a49d4e_d20220521_m052010_c001_v0001161_t0057_u01653110410259") 2022/05/21 05:34:18 DEBUG : b/potato: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffb2ec_d20220521_m052007_c001_v0001101_t0039_u01653110407024") 2022/05/21 05:34:18 DEBUG : b/potato: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1198f95e6729e69a_d20220521_m051923_c001_v0001098_t0041_u01653110363573") 2022/05/21 05:34:18 DEBUG : b/potato: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffb036_d20220521_m051918_c001_v0001101_t0023_u01653110358784") 2022/05/21 05:34:18 DEBUG : backup/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f115dc296050e28df_d20220521_m052611_c001_v0001144_t0014_u01653110771890") 2022/05/21 05:34:18 DEBUG : backup/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f119117c15f9a5b79_d20220521_m052554_c001_v0001102_t0006_u01653110754809") 2022/05/21 05:34:18 DEBUG : backup/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f10336551cd951ae7_d20220521_m052543_c001_v0001146_t0048_u01653110743710") 2022/05/21 05:34:18 DEBUG : backup/one-2019-01-01: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f118bbdfa3a450ee2_d20220521_m052717_c001_v0001041_t0037_u01653110837204") 2022/05/21 05:34:18 DEBUG : backup/one-2019-01-01: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1007ba6ddc64c92b_d20220521_m052711_c001_v0001157_t0055_u01653110831593") 2022/05/21 05:34:18 DEBUG : backup/one-2019-01-01: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1015f0a12f47ba70_d20220521_m052701_c001_v0001104_t0040_u01653110821672") 2022/05/21 05:34:18 DEBUG : backup/one.bak: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f109f2efeff4b2004_d20220521_m052644_c001_v0001098_t0023_u01653110804261") 2022/05/21 05:34:18 DEBUG : backup/one.bak: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f104a1341798796c8_d20220521_m052639_c001_v0001144_t0034_u01653110799020") 2022/05/21 05:34:18 DEBUG : backup/one.bak: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f114b14c0c493fc2d_d20220521_m052629_c001_v0001109_t0059_u01653110789160") 2022/05/21 05:34:18 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f119b07c0c384a82a_d20220521_m052718_c001_v0001116_t0014_u01653110838565") 2022/05/21 05:34:19 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f113bc458d5677830_d20220521_m052715_c001_v0001137_t0052_u01653110835828") 2022/05/21 05:34:19 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f101a91b381d21052_d20220521_m052708_c001_v0001144_t0052_u01653110828021") 2022/05/21 05:34:19 DEBUG : backup/three.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f112fc69646ba1b0b_d20220521_m052612_c001_v0001157_t0029_u01653110772972") 2022/05/21 05:34:19 DEBUG : backup/three.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1110015a9d425a29_d20220521_m052609_c001_v0001153_t0004_u01653110769964") 2022/05/21 05:34:19 DEBUG : backup/three.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1012473cf30027e0_d20220521_m052549_c001_v0001098_t0045_u01653110749214") 2022/05/21 05:34:19 DEBUG : backup/three.txt.bak: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1023cc6bdcd2eca4_d20220521_m052644_c001_v0001105_t0049_u01653110804726") 2022/05/21 05:34:19 DEBUG : backup/three.txt.bak: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f112f8989b40c8bda_d20220521_m052642_c001_v0001106_t0022_u01653110802437") 2022/05/21 05:34:19 DEBUG : backup/three.txt.bak: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1098f876ff0f4c3d_d20220521_m052634_c001_v0001128_t0010_u01653110794704") 2022/05/21 05:34:19 DEBUG : both0: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f114d0e13b19dead1_d20220521_m053317_c001_v0001117_t0024_u01653111197786") 2022/05/21 05:34:19 DEBUG : both0: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b1885c_d20220521_m053200_c001_v0001040_t0018_u01653111120737") 2022/05/21 05:34:19 DEBUG : both0: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1131c41642482dc4_d20220521_m053133_c001_v0001120_t0010_u01653111093537") 2022/05/21 05:34:19 DEBUG : both0: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2aba23_d20220521_m052919_c001_v0001102_t0015_u01653110959127") 2022/05/21 05:34:19 DEBUG : both1: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f105b24f6bfdc7aed_d20220521_m053319_c001_v0001039_t0042_u01653111199442") 2022/05/21 05:34:19 DEBUG : both1: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2ac4e4_d20220521_m053203_c001_v0001102_t0032_u01653111123547") 2022/05/21 05:34:20 DEBUG : both1: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1123e3855c42dea4_d20220521_m053135_c001_v0001150_t0058_u01653111095535") 2022/05/21 05:34:20 DEBUG : both1: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8aa470_d20220521_m052921_c001_v0001102_t0014_u01653110961317") 2022/05/21 05:34:20 DEBUG : both10: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f10999a72e648d30a_d20220521_m053320_c001_v0001102_t0056_u01653111200249") 2022/05/21 05:34:20 DEBUG : both10: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2ac6e8_d20220521_m053232_c001_v0001102_t0008_u01653111152623") 2022/05/21 05:34:20 DEBUG : both10: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f105587aa5cb9e2b7_d20220521_m053136_c001_v0001136_t0002_u01653111096216") 2022/05/21 05:34:20 DEBUG : both10: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8aa8e0_d20220521_m053032_c001_v0001102_t0016_u01653111032298") 2022/05/21 05:34:20 DEBUG : both11: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1172e1ce286e0904_d20220521_m053320_c001_v0001097_t0003_u01653111200901") 2022/05/21 05:34:20 DEBUG : both11: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8ab0b7_d20220521_m053236_c001_v0001102_t0012_u01653111156296") 2022/05/21 05:34:20 DEBUG : both11: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f113a34e6bf73f051_d20220521_m053138_c001_v0001106_t0051_u01653111097034") 2022/05/21 05:34:20 DEBUG : both11: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b187c8_d20220521_m053034_c001_v0001040_t0040_u01653111034911") 2022/05/21 05:34:20 DEBUG : both12: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1128fdc33efa3183_d20220521_m053321_c001_v0001115_t0000_u01653111201467") 2022/05/21 05:34:20 DEBUG : both12: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b188b1_d20220521_m053238_c001_v0001040_t0022_u01653111158193") 2022/05/21 05:34:20 DEBUG : both12: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1117231bbd4a2013_d20220521_m053139_c001_v0001115_t0029_u01653111099308") 2022/05/21 05:34:20 DEBUG : both12: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2abf49_d20220521_m053038_c001_v0001102_t0057_u01653111038683") 2022/05/21 05:34:20 DEBUG : both13: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1143f8df7d545411_d20220521_m053322_c001_v0001100_t0054_u01653111202763") 2022/05/21 05:34:20 DEBUG : both13: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2ac761_d20220521_m053239_c001_v0001102_t0054_u01653111159594") 2022/05/21 05:34:20 DEBUG : both13: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1050ebdda6aef3ec_d20220521_m053140_c001_v0001144_t0038_u01653111100807") 2022/05/21 05:34:20 DEBUG : both13: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8aa9d3_d20220521_m053047_c001_v0001102_t0019_u01653111047959") 2022/05/21 05:34:21 DEBUG : both14: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1185d34e8955f1b3_d20220521_m053323_c001_v0001106_t0023_u01653111203790") 2022/05/21 05:34:21 DEBUG : both14: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8ab18b_d20220521_m053251_c001_v0001102_t0034_u01653111169230") 2022/05/21 05:34:21 DEBUG : both14: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1108771741634f9b_d20220521_m053142_c001_v0001115_t0035_u01653111102012") 2022/05/21 05:34:21 DEBUG : both14: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b187e7_d20220521_m053055_c001_v0001040_t0032_u01653111055928") 2022/05/21 05:34:21 DEBUG : both15: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f10531890eb9a5179_d20220521_m053324_c001_v0001106_t0041_u01653111204948") 2022/05/21 05:34:21 DEBUG : both15: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8ab1f5_d20220521_m053255_c001_v0001102_t0017_u01653111175873") 2022/05/21 05:34:21 DEBUG : both15: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f101be60ae254310e_d20220521_m053143_c001_v0001150_t0006_u01653111103288") 2022/05/21 05:34:21 DEBUG : both15: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2ac078_d20220521_m053058_c001_v0001102_t0012_u01653111058254") 2022/05/21 05:34:21 DEBUG : both16: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f105328e6d65026b1_d20220521_m053325_c001_v0001109_t0039_u01653111205949") 2022/05/21 05:34:21 DEBUG : both16: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8ab217_d20220521_m053257_c001_v0001102_t0013_u01653111177896") 2022/05/21 05:34:21 DEBUG : both16: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f10336551cd9522fe_d20220521_m053144_c001_v0001146_t0036_u01653111104064") 2022/05/21 05:34:21 DEBUG : both16: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8aaac4_d20220521_m053102_c001_v0001102_t0021_u01653111062214") 2022/05/21 05:34:21 DEBUG : both17: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f10576fc7a00766b9_d20220521_m053327_c001_v0001102_t0017_u01653111207249") 2022/05/21 05:34:21 DEBUG : both17: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8ab23e_d20220521_m053300_c001_v0001102_t0024_u01653111180323") 2022/05/21 05:34:21 DEBUG : both17: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1085b55c9a3c092c_d20220521_m053147_c001_v0001029_t0014_u01653111107075") 2022/05/21 05:34:21 DEBUG : both17: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b187f6_d20220521_m053104_c001_v0001040_t0043_u01653111064845") 2022/05/21 05:34:22 DEBUG : both18: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1006b28f02ed87dc_d20220521_m053328_c001_v0001102_t0024_u01653111208167") 2022/05/21 05:34:22 DEBUG : both18: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8ab24b_d20220521_m053301_c001_v0001102_t0028_u01653111181313") 2022/05/21 05:34:22 DEBUG : both18: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f107782df7657c403_d20220521_m053148_c001_v0001098_t0026_u01653111108886") 2022/05/21 05:34:22 DEBUG : both18: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2ac18f_d20220521_m053114_c001_v0001102_t0002_u01653111074824") 2022/05/21 05:34:22 DEBUG : both19: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f11644c5819dfcab3_d20220521_m053331_c001_v0001040_t0042_u01653111211529") 2022/05/21 05:34:22 DEBUG : both19: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8ab25e_d20220521_m053302_c001_v0001102_t0021_u01653111182446") 2022/05/21 05:34:22 DEBUG : both19: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1088ee8d097f6cfc_d20220521_m053149_c001_v0001120_t0009_u01653111109461") 2022/05/21 05:34:22 DEBUG : both19: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8aac14_d20220521_m053122_c001_v0001102_t0051_u01653111082489") 2022/05/21 05:34:22 DEBUG : both2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f10879bb6701cb6a2_d20220521_m053332_c001_v0001109_t0049_u01653111212289") 2022/05/21 05:34:22 DEBUG : both2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8aaedc_d20220521_m053206_c001_v0001102_t0044_u01653111126216") 2022/05/21 05:34:22 DEBUG : both2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f106d92d332f5df70_d20220521_m053150_c001_v0001146_t0045_u01653111110680") 2022/05/21 05:34:22 DEBUG : both2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b18724_d20220521_m052923_c001_v0001040_t0035_u01653110963497") 2022/05/21 05:34:22 DEBUG : both3: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f101dbab0d98bc658_d20220521_m053333_c001_v0001115_t0040_u01653111213619") 2022/05/21 05:34:22 DEBUG : both3: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b18875_d20220521_m053207_c001_v0001040_t0005_u01653111127828") 2022/05/21 05:34:22 DEBUG : both3: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f114a0280a48409f6_d20220521_m053151_c001_v0001103_t0013_u01653111111137") 2022/05/21 05:34:22 DEBUG : both3: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2aba87_d20220521_m052925_c001_v0001102_t0024_u01653110965311") 2022/05/21 05:34:22 DEBUG : both4: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f10161629a16a4389_d20220521_m053335_c001_v0001117_t0040_u01653111215302") 2022/05/21 05:34:23 DEBUG : both4: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2ac560_d20220521_m053211_c001_v0001102_t0032_u01653111131690") 2022/05/21 05:34:23 DEBUG : both4: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1087aa84089d2731_d20220521_m053153_c001_v0001103_t0009_u01653111113409") 2022/05/21 05:34:23 DEBUG : both4: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8aa515_d20220521_m052932_c001_v0001102_t0039_u01653110972734") 2022/05/21 05:34:23 DEBUG : both5: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f109a07d05953040c_d20220521_m053336_c001_v0001033_t0036_u01653111216287") 2022/05/21 05:34:23 DEBUG : both5: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8aaf67_d20220521_m053215_c001_v0001102_t0015_u01653111135265") 2022/05/21 05:34:23 DEBUG : both5: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f118963816ca99f0c_d20220521_m053154_c001_v0001161_t0004_u01653111114959") 2022/05/21 05:34:23 DEBUG : both5: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b18745_d20220521_m052933_c001_v0001040_t0054_u01653110973887") 2022/05/21 05:34:23 DEBUG : both6: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f101a91b381d21df2_d20220521_m053337_c001_v0001144_t0011_u01653111217683") 2022/05/21 05:34:23 DEBUG : both6: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b1888b_d20220521_m053218_c001_v0001040_t0036_u01653111138987") 2022/05/21 05:34:23 DEBUG : both6: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1007786deac484ca_d20220521_m053155_c001_v0001103_t0055_u01653111115596") 2022/05/21 05:34:23 DEBUG : both6: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2abb70_d20220521_m052938_c001_v0001102_t0049_u01653110978671") 2022/05/21 05:34:23 DEBUG : both7: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112eb4ef91cf29a_d20220521_m053338_c001_v0001137_t0046_u01653111218756") 2022/05/21 05:34:23 DEBUG : both7: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2ac63a_d20220521_m053223_c001_v0001102_t0034_u01653111143454") 2022/05/21 05:34:23 DEBUG : both7: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1056cbaabf715d7a_d20220521_m053156_c001_v0001100_t0014_u01653111116295") 2022/05/21 05:34:23 DEBUG : both7: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8aa5b2_d20220521_m052942_c001_v0001102_t0041_u01653110982781") 2022/05/21 05:34:24 DEBUG : both8: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f119117de553534c8_d20220521_m053339_c001_v0001115_t0029_u01653111219533") 2022/05/21 05:34:24 DEBUG : both8: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8ab00c_d20220521_m053226_c001_v0001102_t0039_u01653111146263") 2022/05/21 05:34:24 DEBUG : both8: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102cc3291711dce6_d20220521_m053157_c001_v0001109_t0044_u01653111117434") 2022/05/21 05:34:24 DEBUG : both8: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b187b0_d20220521_m053024_c001_v0001040_t0024_u01653111024221") 2022/05/21 05:34:24 DEBUG : both9: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1198f95e672a067d_d20220521_m053341_c001_v0001098_t0057_u01653111220678") 2022/05/21 05:34:24 DEBUG : both9: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b188a1_d20220521_m053228_c001_v0001040_t0012_u01653111148313") 2022/05/21 05:34:24 DEBUG : both9: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f11919d2f684ab1dd_d20220521_m053159_c001_v0001146_t0053_u01653111119599") 2022/05/21 05:34:24 DEBUG : both9: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2abe56_d20220521_m053026_c001_v0001102_t0048_u01653111026484") 2022/05/21 05:34:24 DEBUG : c/non empty space: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1097c5b010efebf4_d20220521_m052019_c001_v0001115_t0012_u01653110419857") 2022/05/21 05:34:24 DEBUG : c/non empty space: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffb34f_d20220521_m052013_c001_v0001101_t0046_u01653110413191") 2022/05/21 05:34:24 DEBUG : c/non empty space: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1008d5c4a834f857_d20220521_m052012_c001_v0001134_t0002_u01653110412054") 2022/05/21 05:34:24 DEBUG : c/non empty space: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffb2fc_d20220521_m052007_c001_v0001101_t0054_u01653110407888") 2022/05/21 05:34:24 DEBUG : c/non empty space: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1157f7c6f924765a_d20220521_m051924_c001_v0001116_t0026_u01653110364985") 2022/05/21 05:34:24 DEBUG : c/non empty space: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffb043_d20220521_m051920_c001_v0001101_t0014_u01653110360497") 2022/05/21 05:34:24 DEBUG : check sum: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1069bf9da63eee57_d20220521_m051858_c001_v0001106_t0043_u01653110338154") 2022/05/21 05:34:25 DEBUG : check sum: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffaeec_d20220521_m051856_c001_v0001101_t0020_u01653110336418") 2022/05/21 05:34:25 DEBUG : dest/3: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f110814fc166d5bb8_d20220521_m052430_c001_v0001144_t0024_u01653110670368") 2022/05/21 05:34:25 DEBUG : dest/3: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1050ebdda6aee084_d20220521_m052428_c001_v0001144_t0033_u01653110668688") 2022/05/21 05:34:25 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f100764ea6bab76da_d20220521_m052851_c001_v0001117_t0016_u01653110931809") 2022/05/21 05:34:25 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f110877174163476f_d20220521_m052841_c001_v0001115_t0004_u01653110921279") 2022/05/21 05:34:25 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f11379f59d3210fb3_d20220521_m052840_c001_v0001128_t0018_u01653110920836") 2022/05/21 05:34:25 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1108771741634701_d20220521_m052831_c001_v0001115_t0051_u01653110911924") 2022/05/21 05:34:25 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f106711fbf7a56ccd_d20220521_m052831_c001_v0001134_t0006_u01653110911055") 2022/05/21 05:34:25 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8aa090_d20220521_m052823_c001_v0001102_t0007_u01653110903941") 2022/05/21 05:34:25 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1037d36bc53a151c_d20220521_m052818_c001_v0001104_t0014_u01653110898484") 2022/05/21 05:34:25 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1061fb59f8140970_d20220521_m052812_c001_v0001091_t0008_u01653110892209") 2022/05/21 05:34:25 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f106298d7219f06cc_d20220521_m052811_c001_v0001022_t0014_u01653110891714") 2022/05/21 05:34:25 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1061fb59f8140962_d20220521_m052804_c001_v0001091_t0039_u01653110884914") 2022/05/21 05:34:25 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1144f35d85d60fe0_d20220521_m052803_c001_v0001044_t0056_u01653110883092") 2022/05/21 05:34:25 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8a9e80_d20220521_m052750_c001_v0001102_t0031_u01653110870012") 2022/05/21 05:34:25 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8a9e41_d20220521_m052745_c001_v0001102_t0008_u01653110865995") 2022/05/21 05:34:25 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f115912e3f406d7ad_d20220521_m052742_c001_v0001104_t0033_u01653110862601") 2022/05/21 05:34:26 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f112d3c59d2fd7cb8_d20220521_m052741_c001_v0001113_t0029_u01653110861528") 2022/05/21 05:34:26 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f115912e3f406d712_d20220521_m052733_c001_v0001104_t0015_u01653110853722") 2022/05/21 05:34:26 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f11059b8bb2de70e5_d20220521_m052732_c001_v0001099_t0044_u01653110852551") 2022/05/21 05:34:26 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b18631_d20220521_m052722_c001_v0001040_t0054_u01653110842926") 2022/05/21 05:34:26 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f10356eaf1d4ba073_d20220521_m052719_c001_v0001113_t0007_u01653110839633") 2022/05/21 05:34:26 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1051e0cc8a06da8a_d20220521_m052713_c001_v0001103_t0011_u01653110833559") 2022/05/21 05:34:26 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1158101af5e8d259_d20220521_m052712_c001_v0001101_t0020_u01653110832165") 2022/05/21 05:34:26 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1051e0cc8a06d9f0_d20220521_m052704_c001_v0001103_t0050_u01653110824615") 2022/05/21 05:34:26 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103c5fb1392bbceb_d20220521_m052703_c001_v0001161_t0000_u01653110823733") 2022/05/21 05:34:26 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2ab0a0_d20220521_m052647_c001_v0001102_t0051_u01653110807744") 2022/05/21 05:34:26 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f118bb0b97f4e255f_d20220521_m052645_c001_v0001144_t0040_u01653110805614") 2022/05/21 05:34:26 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f11419893dead9a02_d20220521_m052640_c001_v0001120_t0048_u01653110800827") 2022/05/21 05:34:26 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f116b4377c68d19bc_d20220521_m052639_c001_v0001097_t0009_u01653110799910") 2022/05/21 05:34:26 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f11419893dead99c4_d20220521_m052632_c001_v0001120_t0028_u01653110792595") 2022/05/21 05:34:26 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1037d36bc53a0ebf_d20220521_m052630_c001_v0001104_t0031_u01653110790260") 2022/05/21 05:34:26 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8a982e_d20220521_m052615_c001_v0001102_t0017_u01653110775645") 2022/05/21 05:34:26 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103a5641e9388df6_d20220521_m052613_c001_v0001100_t0045_u01653110773879") 2022/05/21 05:34:27 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f111bbb53667c7252_d20220521_m052607_c001_v0001104_t0056_u01653110767446") 2022/05/21 05:34:27 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f111722ff929c50d0_d20220521_m052606_c001_v0001100_t0018_u01653110766524") 2022/05/21 05:34:27 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f111bbb53667c710b_d20220521_m052546_c001_v0001104_t0024_u01653110746299") 2022/05/21 05:34:27 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f11445a0d7171f027_d20220521_m052544_c001_v0001099_t0009_u01653110744363") 2022/05/21 05:34:27 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b1855c_d20220521_m052528_c001_v0001040_t0049_u01653110728541") 2022/05/21 05:34:27 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f11224a589a3a20c6_d20220521_m052525_c001_v0001161_t0052_u01653110725496") 2022/05/21 05:34:27 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1190bf46ef1b0576_d20220521_m052449_c001_v0001017_t0028_u01653110689803") 2022/05/21 05:34:27 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f100af4dd53cacba4_d20220521_m052448_c001_v0001099_t0035_u01653110687556") 2022/05/21 05:34:27 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2aa8a1_d20220521_m052440_c001_v0001102_t0019_u01653110680308") 2022/05/21 05:34:27 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1014020012be01b1_d20220521_m052438_c001_v0001120_t0007_u01653110678440") 2022/05/21 05:34:27 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1014020012be01af_d20220521_m052436_c001_v0001120_t0041_u01653110676653") 2022/05/21 05:34:27 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1081f02ba2b8b201_d20220521_m052419_c001_v0001038_t0057_u01653110659592") 2022/05/21 05:34:27 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b184c9_d20220521_m052403_c001_v0001040_t0049_u01653110643594") 2022/05/21 05:34:27 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f11177f5b9a0bdcb4_d20220521_m052402_c001_v0001099_t0017_u01653110642416") 2022/05/21 05:34:28 DEBUG : dst/one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f11177f5b9a0bdca4_d20220521_m052400_c001_v0001099_t0020_u01653110640670") 2022/05/21 05:34:28 DEBUG : dst/one-2019-01-01: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1015c6456607b145_d20220521_m052853_c001_v0001099_t0002_u01653110933429") 2022/05/21 05:34:28 DEBUG : dst/one-2019-01-01: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1117231bbd4a156b_d20220521_m052839_c001_v0001115_t0001_u01653110919546") 2022/05/21 05:34:28 DEBUG : dst/one-2019-01-01: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f11716a8ec12e92f8_d20220521_m052829_c001_v0001131_t0024_u01653110909990") 2022/05/21 05:34:28 DEBUG : dst/one.bak: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1163440a7965d978_d20220521_m052819_c001_v0001015_t0040_u01653110899853") 2022/05/21 05:34:28 DEBUG : dst/one.bak: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f115125a0160a0a61_d20220521_m052810_c001_v0001093_t0059_u01653110890991") 2022/05/21 05:34:28 DEBUG : dst/one.bak: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f116c8609f54fecbc_d20220521_m052758_c001_v0001101_t0030_u01653110878132") 2022/05/21 05:34:28 DEBUG : dst/one.bak: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103b594fe540ef09_d20220521_m052746_c001_v0001131_t0055_u01653110866832") 2022/05/21 05:34:28 DEBUG : dst/one.bak: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1132aa24b757b105_d20220521_m052740_c001_v0001099_t0049_u01653110860574") 2022/05/21 05:34:28 DEBUG : dst/one.bak: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1012f85b5d7fd403_d20220521_m052731_c001_v0001100_t0059_u01653110851760") 2022/05/21 05:34:28 DEBUG : dst/three: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f104baba3bf9d32d9_d20220521_m052526_c001_v0001100_t0057_u01653110726333") 2022/05/21 05:34:28 DEBUG : dst/three: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1014020012be027a_d20220521_m052519_c001_v0001120_t0024_u01653110719225") 2022/05/21 05:34:28 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103521d67e8322e7_d20220521_m052854_c001_v0001037_t0004_u01653110934942") 2022/05/21 05:34:28 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f110b7449abf4b705_d20220521_m052843_c001_v0001145_t0011_u01653110923388") 2022/05/21 05:34:28 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1028e298ed9e99ff_d20220521_m052833_c001_v0001103_t0058_u01653110913703") 2022/05/21 05:34:28 DEBUG : dst/three.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f10356eaf1d4ba21b_d20220521_m052856_c001_v0001113_t0023_u01653110936491") 2022/05/21 05:34:29 DEBUG : dst/three.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f104d26009ef31a43_d20220521_m052848_c001_v0001102_t0012_u01653110928333") 2022/05/21 05:34:29 DEBUG : dst/three.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f10784a5455641fd5_d20220521_m052844_c001_v0001106_t0008_u01653110924441") 2022/05/21 05:34:29 DEBUG : dst/three.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f110877174163473d_d20220521_m052836_c001_v0001115_t0026_u01653110916968") 2022/05/21 05:34:29 DEBUG : dst/three.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f116c8609f54fee53_d20220521_m052836_c001_v0001101_t0018_u01653110916216") 2022/05/21 05:34:29 DEBUG : dst/three.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b186c8_d20220521_m052825_c001_v0001040_t0052_u01653110905860") 2022/05/21 05:34:29 DEBUG : dst/three.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f115d3959894a3229_d20220521_m052820_c001_v0001109_t0051_u01653110900865") 2022/05/21 05:34:29 DEBUG : dst/three.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1061fb59f8140977_d20220521_m052815_c001_v0001091_t0015_u01653110895625") 2022/05/21 05:34:29 DEBUG : dst/three.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103a5641e9389481_d20220521_m052815_c001_v0001100_t0039_u01653110895202") 2022/05/21 05:34:29 DEBUG : dst/three.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1061fb59f814096a_d20220521_m052808_c001_v0001091_t0011_u01653110888471") 2022/05/21 05:34:29 DEBUG : dst/three.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f110ecb6f606e115c_d20220521_m052807_c001_v0001105_t0022_u01653110887285") 2022/05/21 05:34:29 DEBUG : dst/three.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b18684_d20220521_m052754_c001_v0001040_t0042_u01653110874077") 2022/05/21 05:34:29 DEBUG : dst/three.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1070ef7cfdeb08a6_d20220521_m052745_c001_v0001103_t0022_u01653110865063") 2022/05/21 05:34:29 DEBUG : dst/three.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b18660_d20220521_m052739_c001_v0001040_t0047_u01653110859372") 2022/05/21 05:34:29 DEBUG : dst/three.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f10600d3fce9622a3_d20220521_m052736_c001_v0001144_t0055_u01653110856379") 2022/05/21 05:34:29 DEBUG : dst/three.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2ab323_d20220521_m052727_c001_v0001102_t0052_u01653110847250") 2022/05/21 05:34:29 DEBUG : dst/three.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f10026a74029c9fca_d20220521_m052716_c001_v0001146_t0007_u01653110836436") 2022/05/21 05:34:30 DEBUG : dst/three.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2ab21c_d20220521_m052710_c001_v0001102_t0028_u01653110830528") 2022/05/21 05:34:30 DEBUG : dst/three.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f10784a545564193d_d20220521_m052708_c001_v0001106_t0036_u01653110828821") 2022/05/21 05:34:30 DEBUG : dst/three.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8a9a9c_d20220521_m052651_c001_v0001102_t0038_u01653110811088") 2022/05/21 05:34:30 DEBUG : dst/three.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103ea49dbf6e3903_d20220521_m052643_c001_v0001130_t0012_u01653110803373") 2022/05/21 05:34:30 DEBUG : dst/three.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8a99a2_d20220521_m052637_c001_v0001102_t0006_u01653110797732") 2022/05/21 05:34:30 DEBUG : dst/three.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1114f32f5b8913f2_d20220521_m052635_c001_v0001017_t0007_u01653110795359") 2022/05/21 05:34:30 DEBUG : dst/three.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b185cb_d20220521_m052624_c001_v0001040_t0009_u01653110784749") 2022/05/21 05:34:30 DEBUG : dst/three.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1157561408345656_d20220521_m052610_c001_v0001103_t0043_u01653110770867") 2022/05/21 05:34:30 DEBUG : dst/three.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b1858d_d20220521_m052551_c001_v0001040_t0032_u01653110751845") 2022/05/21 05:34:30 DEBUG : dst/three.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1187a080eca09e05_d20220521_m052549_c001_v0001103_t0045_u01653110749623") 2022/05/21 05:34:30 DEBUG : dst/three.txt: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2aac01_d20220521_m052535_c001_v0001102_t0011_u01653110735007") 2022/05/21 05:34:30 DEBUG : dst/three.txt.bak: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f11945facb19015cd_d20220521_m052822_c001_v0001137_t0051_u01653110902078") 2022/05/21 05:34:30 DEBUG : dst/three.txt.bak: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f108a7c1dd7f2198f_d20220521_m052814_c001_v0001040_t0010_u01653110894333") 2022/05/21 05:34:30 DEBUG : dst/three.txt.bak: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1068b39e308ac8b9_d20220521_m052806_c001_v0001039_t0054_u01653110886231") 2022/05/21 05:34:30 DEBUG : dst/three.txt.bak: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f112fee2f4ff17899_d20220521_m052747_c001_v0001101_t0009_u01653110867259") 2022/05/21 05:34:30 DEBUG : dst/three.txt.bak: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f119117c15f9a61f0_d20220521_m052744_c001_v0001102_t0006_u01653110864386") 2022/05/21 05:34:30 DEBUG : dst/three.txt.bak: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1008347df6a6f1e1_d20220521_m052735_c001_v0001015_t0013_u01653110855909") 2022/05/21 05:34:31 DEBUG : dst/two: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f111722ff929c58f9_d20220521_m052857_c001_v0001100_t0002_u01653110937278") 2022/05/21 05:34:31 DEBUG : dst/two: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2ab6de_d20220521_m052824_c001_v0001102_t0027_u01653110904968") 2022/05/21 05:34:31 DEBUG : dst/two: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f116617e4523e5bb4_d20220521_m052822_c001_v0001117_t0054_u01653110902808") 2022/05/21 05:34:31 DEBUG : dst/two: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2ab4e2_d20220521_m052753_c001_v0001102_t0011_u01653110873178") 2022/05/21 05:34:31 DEBUG : dst/two: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1074d534dcd7fe87_d20220521_m052748_c001_v0001161_t0012_u01653110868016") 2022/05/21 05:34:31 DEBUG : dst/two: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8a9cb3_d20220521_m052724_c001_v0001102_t0040_u01653110844139") 2022/05/21 05:34:31 DEBUG : dst/two: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f11486d491401ade2_d20220521_m052721_c001_v0001042_t0055_u01653110841116") 2022/05/21 05:34:31 DEBUG : dst/two: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b185ee_d20220521_m052649_c001_v0001040_t0040_u01653110809930") 2022/05/21 05:34:31 DEBUG : dst/two: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1179e6cff4ba824c_d20220521_m052646_c001_v0001146_t0046_u01653110806791") 2022/05/21 05:34:31 DEBUG : dst/two: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2aaef9_d20220521_m052623_c001_v0001102_t0011_u01653110783752") 2022/05/21 05:34:31 DEBUG : dst/two: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f119b07c0c384a67a_d20220521_m052614_c001_v0001116_t0015_u01653110774428") 2022/05/21 05:34:31 DEBUG : dst/two: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8a954f_d20220521_m052531_c001_v0001102_t0011_u01653110730841") 2022/05/21 05:34:31 DEBUG : dst/two: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1011d3606b5abe91_d20220521_m052527_c001_v0001037_t0035_u01653110727028") 2022/05/21 05:34:31 DEBUG : dst/two: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1129f6392c6c42db_d20220521_m052452_c001_v0001104_t0033_u01653110692385") 2022/05/21 05:34:31 DEBUG : dst/two: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f118bb0b97f4e20ca_d20220521_m052420_c001_v0001144_t0024_u01653110660542") 2022/05/21 05:34:31 DEBUG : dst/two: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f11177f5b9a0bdd29_d20220521_m052414_c001_v0001099_t0046_u01653110654743") 2022/05/21 05:34:32 DEBUG : empty space: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f118bb9ba6d39a6e9_d20220521_m052337_c001_v0001157_t0055_u01653110617353") 2022/05/21 05:34:32 DEBUG : empty space: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b18490_d20220521_m052328_c001_v0001040_t0005_u01653110608913") 2022/05/21 05:34:32 DEBUG : empty space: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f10026a74029c9c2a_d20220521_m052325_c001_v0001146_t0028_u01653110605986") 2022/05/21 05:34:32 DEBUG : empty space: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b18473_d20220521_m052309_c001_v0001040_t0054_u01653110589252") 2022/05/21 05:34:32 DEBUG : empty space: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f114b14c0c493eeae_d20220521_m052253_c001_v0001109_t0031_u01653110573601") 2022/05/21 05:34:32 DEBUG : empty space: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b18429_d20220521_m052237_c001_v0001040_t0006_u01653110557180") 2022/05/21 05:34:32 DEBUG : empty space: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1184e820fe45c27e_d20220521_m052102_c001_v0001153_t0023_u01653110462055") 2022/05/21 05:34:32 DEBUG : empty space: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b1836a_d20220521_m052057_c001_v0001040_t0040_u01653110457236") 2022/05/21 05:34:32 DEBUG : empty space: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1132aa24b7579e7d_d20220521_m052053_c001_v0001099_t0058_u01653110453281") 2022/05/21 05:34:32 DEBUG : empty space: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b1834f_d20220521_m052051_c001_v0001040_t0059_u01653110451582") 2022/05/21 05:34:32 DEBUG : empty space: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1117231bbd49f959_d20220521_m052040_c001_v0001115_t0007_u01653110440372") 2022/05/21 05:34:32 DEBUG : empty space: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b1831c_d20220521_m052033_c001_v0001040_t0003_u01653110433511") 2022/05/21 05:34:32 DEBUG : empty space: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f118c901b5c0830d1_d20220521_m052024_c001_v0001104_t0030_u01653110424664") 2022/05/21 05:34:32 DEBUG : empty space: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffb3bd_d20220521_m052021_c001_v0001101_t0008_u01653110421973") 2022/05/21 05:34:32 DEBUG : empty space: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102c93ebcaf3e5ff_d20220521_m052005_c001_v0001115_t0028_u01653110405310") 2022/05/21 05:34:33 DEBUG : empty space: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffb29a_d20220521_m052001_c001_v0001101_t0052_u01653110401699") 2022/05/21 05:34:33 DEBUG : empty space: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f117fee0cf8b0d4c7_d20220521_m051958_c001_v0001044_t0010_u01653110398796") 2022/05/21 05:34:33 DEBUG : empty space: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffb267_d20220521_m051957_c001_v0001101_t0023_u01653110397491") 2022/05/21 05:34:33 DEBUG : empty space: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f109409d41aabbc69_d20220521_m051937_c001_v0001165_t0043_u01653110377650") 2022/05/21 05:34:33 DEBUG : empty space: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffb121_d20220521_m051935_c001_v0001101_t0041_u01653110375414") 2022/05/21 05:34:33 DEBUG : empty space: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1042d996518d8a81_d20220521_m051931_c001_v0001099_t0019_u01653110371918") 2022/05/21 05:34:33 DEBUG : empty space: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffb0e9_d20220521_m051930_c001_v0001101_t0006_u01653110370726") 2022/05/21 05:34:33 DEBUG : empty space: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103920c2ec0c1672_d20220521_m051929_c001_v0001099_t0058_u01653110369563") 2022/05/21 05:34:33 DEBUG : empty space: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1015c645660794d8_d20220521_m051928_c001_v0001099_t0034_u01653110368312") 2022/05/21 05:34:33 DEBUG : empty space: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffb097_d20220521_m051926_c001_v0001101_t0058_u01653110366177") 2022/05/21 05:34:33 DEBUG : enormous: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103a57f61fa32b82_d20220521_m052100_c001_v0001011_t0032_u01653110460200") 2022/05/21 05:34:33 DEBUG : enormous: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b18370_d20220521_m052058_c001_v0001040_t0032_u01653110458877") 2022/05/21 05:34:33 DEBUG : existing: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f106cc344aa9ec311_d20220521_m052908_c001_v0001109_t0022_u01653110947091") 2022/05/21 05:34:33 DEBUG : existing: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b18708_d20220521_m052905_c001_v0001040_t0001_u01653110945680") 2022/05/21 05:34:33 DEBUG : existing: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1183e47056dc1846_d20220521_m052229_c001_v0001105_t0017_u01653110549383") 2022/05/21 05:34:33 DEBUG : existing: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b183fe_d20220521_m052213_c001_v0001040_t0008_u01653110533642") 2022/05/21 05:34:34 DEBUG : existing: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f11445a0d7171dc7f_d20220521_m051917_c001_v0001099_t0020_u01653110357904") 2022/05/21 05:34:34 DEBUG : existing: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffb01c_d20220521_m051916_c001_v0001101_t0031_u01653110356313") 2022/05/21 05:34:34 DEBUG : existing: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f118bb9ba6d399c44_d20220521_m051915_c001_v0001157_t0034_u01653110355206") 2022/05/21 05:34:34 DEBUG : existing: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffafee_d20220521_m051913_c001_v0001101_t0002_u01653110353334") 2022/05/21 05:34:34 DEBUG : existing: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffafe4_d20220521_m051912_c001_v0001101_t0016_u01653110352198") 2022/05/21 05:34:34 DEBUG : existing-b: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1027d6999603102a_d20220521_m052230_c001_v0001011_t0000_u01653110550636") 2022/05/21 05:34:34 DEBUG : existing-b: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8a885d_d20220521_m052213_c001_v0001102_t0012_u01653110533665") 2022/05/21 05:34:34 DEBUG : five: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f117799eb0ea22164_d20220521_m052115_c001_v0001161_t0000_u01653110475496") 2022/05/21 05:34:34 DEBUG : five: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b1838c_d20220521_m052111_c001_v0001040_t0038_u01653110471576") 2022/05/21 05:34:34 DEBUG : foo: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1157f7c6f924769d_d20220521_m051934_c001_v0001116_t0021_u01653110374492") 2022/05/21 05:34:34 DEBUG : foo: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffb10e_d20220521_m051933_c001_v0001101_t0040_u01653110373515") 2022/05/21 05:34:34 DEBUG : foo: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffb101_d20220521_m051932_c001_v0001101_t0031_u01653110372599") 2022/05/21 05:34:34 DEBUG : four: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f108951d402e03e45_d20220521_m052116_c001_v0001099_t0005_u01653110476438") 2022/05/21 05:34:34 DEBUG : four: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2a9b65_d20220521_m052112_c001_v0001102_t0042_u01653110472315") 2022/05/21 05:34:34 DEBUG : four: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b18386_d20220521_m052109_c001_v0001040_t0054_u01653110469827") 2022/05/21 05:34:34 DEBUG : hello world2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f106cc344aa9e9d00_d20220521_m051827_c001_v0001109_t0027_u01653110307332") 2022/05/21 05:34:34 DEBUG : hello world2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffad1d_d20220521_m051826_c001_v0001101_t0059_u01653110306179") 2022/05/21 05:34:35 DEBUG : ignore-size: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1196ef4c8c297ef8_d20220521_m051908_c001_v0001104_t0056_u01653110348155") 2022/05/21 05:34:35 DEBUG : ignore-size: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffaf9d_d20220521_m051906_c001_v0001101_t0024_u01653110346827") 2022/05/21 05:34:35 DEBUG : nested/sub dir/file: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f112fee2f4ff168f1_d20220521_m052210_c001_v0001101_t0020_u01653110530524") 2022/05/21 05:34:35 DEBUG : nested/sub dir/file: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8a87d2_d20220521_m052207_c001_v0001102_t0051_u01653110527084") 2022/05/21 05:34:35 DEBUG : nested/sub dir/file: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f106d9d64bffd4766_d20220521_m052157_c001_v0001042_t0013_u01653110517427") 2022/05/21 05:34:35 DEBUG : nested/sub dir/file: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2a9e4d_d20220521_m052153_c001_v0001102_t0034_u01653110513221") 2022/05/21 05:34:35 DEBUG : one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1189000a5a2a178d_d20220521_m052117_c001_v0001009_t0029_u01653110477029") 2022/05/21 05:34:35 DEBUG : one: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b18376_d20220521_m052102_c001_v0001040_t0003_u01653110462435") 2022/05/21 05:34:35 DEBUG : only0: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f10189191b9461e29_d20220521_m053342_c001_v0001043_t0011_u01653111222134") 2022/05/21 05:34:35 DEBUG : only0: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8ab2c0_d20220521_m053308_c001_v0001102_t0028_u01653111188640") 2022/05/21 05:34:35 DEBUG : only0: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8aae9b_d20220521_m053202_c001_v0001102_t0016_u01653111122260") 2022/05/21 05:34:35 DEBUG : only0: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1007786deac48342_d20220521_m053130_c001_v0001103_t0006_u01653111090971") 2022/05/21 05:34:35 DEBUG : only0: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b1871e_d20220521_m052920_c001_v0001040_t0018_u01653110960157") 2022/05/21 05:34:35 DEBUG : only1: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f104877eeb61636eb_d20220521_m053342_c001_v0001157_t0000_u01653111222562") 2022/05/21 05:34:35 DEBUG : only1: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2ac9c1_d20220521_m053313_c001_v0001102_t0011_u01653111193883") 2022/05/21 05:34:35 DEBUG : only1: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b18868_d20220521_m053204_c001_v0001040_t0019_u01653111124766") 2022/05/21 05:34:35 DEBUG : only1: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f109e4453ccbf81b4_d20220521_m053124_c001_v0001043_t0033_u01653111084973") 2022/05/21 05:34:36 DEBUG : only1: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2aba54_d20220521_m052922_c001_v0001102_t0016_u01653110962408") 2022/05/21 05:34:36 DEBUG : only10: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102bff864dc6065a_d20220521_m053343_c001_v0001106_t0001_u01653111223021") 2022/05/21 05:34:36 DEBUG : only10: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f106410f167d858d7_d20220521_m053313_c001_v0001018_t0018_u01653111193557") 2022/05/21 05:34:36 DEBUG : only10: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b188ad_d20220521_m053235_c001_v0001040_t0028_u01653111155461") 2022/05/21 05:34:36 DEBUG : only10: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f101dbab0d98bbf93_d20220521_m053126_c001_v0001115_t0040_u01653111086609") 2022/05/21 05:34:36 DEBUG : only10: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2abefe_d20220521_m053034_c001_v0001102_t0031_u01653111034107") 2022/05/21 05:34:36 DEBUG : only11: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f112604840376941c_d20220521_m053344_c001_v0001144_t0053_u01653111224581") 2022/05/21 05:34:36 DEBUG : only11: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2ac953_d20220521_m053308_c001_v0001102_t0014_u01653111188651") 2022/05/21 05:34:36 DEBUG : only11: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2ac736_d20220521_m053236_c001_v0001102_t0012_u01653111156639") 2022/05/21 05:34:36 DEBUG : only11: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1001562cc264da42_d20220521_m053124_c001_v0001120_t0053_u01653111084958") 2022/05/21 05:34:36 DEBUG : only11: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8aa942_d20220521_m053037_c001_v0001102_t0012_u01653111037641") 2022/05/21 05:34:36 DEBUG : only12: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f10576fc7a0076865_d20220521_m053348_c001_v0001102_t0057_u01653111228265") 2022/05/21 05:34:36 DEBUG : only12: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1051e0cc8a06ecff_d20220521_m053309_c001_v0001103_t0059_u01653111189177") 2022/05/21 05:34:36 DEBUG : only12: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8ab0e8_d20220521_m053238_c001_v0001102_t0007_u01653111158900") 2022/05/21 05:34:36 DEBUG : only12: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f116785a520919cc2_d20220521_m053131_c001_v0001150_t0059_u01653111091442") 2022/05/21 05:34:36 DEBUG : only12: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b187dc_d20220521_m053045_c001_v0001040_t0001_u01653111045068") 2022/05/21 05:34:37 DEBUG : only13: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1168c2446cbc0dc5_d20220521_m053353_c001_v0001105_t0048_u01653111233156") 2022/05/21 05:34:37 DEBUG : only13: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f106410f167d858cb_d20220521_m053309_c001_v0001018_t0037_u01653111189367") 2022/05/21 05:34:37 DEBUG : only13: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b188c7_d20220521_m053244_c001_v0001040_t0020_u01653111164851") 2022/05/21 05:34:37 DEBUG : only13: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1069bf9da63f240b_d20220521_m053126_c001_v0001106_t0021_u01653111086783") 2022/05/21 05:34:37 DEBUG : only13: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2ac008_d20220521_m053052_c001_v0001102_t0025_u01653111052308") 2022/05/21 05:34:37 DEBUG : only14: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f118f98e87700d431_d20220521_m053353_c001_v0001093_t0004_u01653111233847") 2022/05/21 05:34:37 DEBUG : only14: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2ac963_d20220521_m053309_c001_v0001102_t0051_u01653111189118") 2022/05/21 05:34:37 DEBUG : only14: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2ac83d_d20220521_m053253_c001_v0001102_t0043_u01653111173082") 2022/05/21 05:34:37 DEBUG : only14: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8aac3d_d20220521_m053125_c001_v0001102_t0036_u01653111085010") 2022/05/21 05:34:37 DEBUG : only14: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8aaa80_d20220521_m053057_c001_v0001102_t0047_u01653111057494") 2022/05/21 05:34:37 DEBUG : only15: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1146f50180a09c5c_d20220521_m053354_c001_v0001106_t0053_u01653111234602") 2022/05/21 05:34:37 DEBUG : only15: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8ab2d2_d20220521_m053309_c001_v0001102_t0012_u01653111189446") 2022/05/21 05:34:37 DEBUG : only15: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2ac886_d20220521_m053257_c001_v0001102_t0019_u01653111177221") 2022/05/21 05:34:37 DEBUG : only15: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1062c6f4dbd46fce_d20220521_m053131_c001_v0001130_t0032_u01653111091645") 2022/05/21 05:34:37 DEBUG : only15: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b187ed_d20220521_m053058_c001_v0001040_t0059_u01653111058805") 2022/05/21 05:34:37 DEBUG : only16: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1183b31705ba341e_d20220521_m053356_c001_v0001008_t0001_u01653111236009") 2022/05/21 05:34:37 DEBUG : only16: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8ab2e0_d20220521_m053310_c001_v0001102_t0012_u01653111190101") 2022/05/21 05:34:38 DEBUG : only16: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2ac8a8_d20220521_m053258_c001_v0001102_t0031_u01653111178641") 2022/05/21 05:34:38 DEBUG : only16: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f100a040faf820748_d20220521_m053132_c001_v0001115_t0010_u01653111092008") 2022/05/21 05:34:38 DEBUG : only16: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2ac0c6_d20220521_m053104_c001_v0001102_t0003_u01653111064194") 2022/05/21 05:34:38 DEBUG : only17: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f116b7cb1a4faefc2_d20220521_m053356_c001_v0001103_t0016_u01653111236714") 2022/05/21 05:34:38 DEBUG : only17: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f106410f167d858cd_d20220521_m053310_c001_v0001018_t0027_u01653111190129") 2022/05/21 05:34:38 DEBUG : only17: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2ac8c6_d20220521_m053300_c001_v0001102_t0035_u01653111180928") 2022/05/21 05:34:38 DEBUG : only17: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1036adb6cccfc747_d20220521_m053128_c001_v0001105_t0043_u01653111088977") 2022/05/21 05:34:38 DEBUG : only17: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8aab12_d20220521_m053106_c001_v0001102_t0053_u01653111066313") 2022/05/21 05:34:38 DEBUG : only18: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f111bc16a04cfc62f_d20220521_m053358_c001_v0001097_t0035_u01653111238854") 2022/05/21 05:34:38 DEBUG : only18: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8ab2e6_d20220521_m053310_c001_v0001102_t0047_u01653111190655") 2022/05/21 05:34:38 DEBUG : only18: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2ac8d9_d20220521_m053301_c001_v0001102_t0028_u01653111181760") 2022/05/21 05:34:38 DEBUG : only18: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f106cc344aa9ecb0b_d20220521_m053125_c001_v0001109_t0025_u01653111085115") 2022/05/21 05:34:38 DEBUG : only18: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b18812_d20220521_m053121_c001_v0001040_t0044_u01653111081250") 2022/05/21 05:34:38 DEBUG : only19: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f11919d2f684ab4f0_d20220521_m053359_c001_v0001146_t0056_u01653111239320") 2022/05/21 05:34:38 DEBUG : only19: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f106410f167d858cf_d20220521_m053310_c001_v0001018_t0007_u01653111190703") 2022/05/21 05:34:38 DEBUG : only19: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2ac914_d20220521_m053304_c001_v0001102_t0043_u01653111184554") 2022/05/21 05:34:38 DEBUG : only19: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f10790e5b3793462e_d20220521_m053130_c001_v0001000_t0020_u01653111089776") 2022/05/21 05:34:38 DEBUG : only19: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2ac1ff_d20220521_m053122_c001_v0001102_t0051_u01653111082891") 2022/05/21 05:34:39 DEBUG : only2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f101e9d031c0f6fdd_d20220521_m053359_c001_v0001102_t0011_u01653111239740") 2022/05/21 05:34:39 DEBUG : only2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1051e0cc8a06ed17_d20220521_m053310_c001_v0001103_t0046_u01653111190734") 2022/05/21 05:34:39 DEBUG : only2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2ac521_d20220521_m053207_c001_v0001102_t0007_u01653111127091") 2022/05/21 05:34:39 DEBUG : only2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112d263464b8ad6_d20220521_m053127_c001_v0001144_t0047_u01653111087691") 2022/05/21 05:34:39 DEBUG : only2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8aa49b_d20220521_m052924_c001_v0001102_t0032_u01653110964886") 2022/05/21 05:34:39 DEBUG : only3: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f107e9b54cbc9b617_d20220521_m053403_c001_v0001109_t0045_u01653111243510") 2022/05/21 05:34:39 DEBUG : only3: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2ac982_d20220521_m053311_c001_v0001102_t0020_u01653111191116") 2022/05/21 05:34:39 DEBUG : only3: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8aaf36_d20220521_m053210_c001_v0001102_t0006_u01653111130937") 2022/05/21 05:34:39 DEBUG : only3: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f113eb8d8ec3b0999_d20220521_m053130_c001_v0001102_t0024_u01653111090446") 2022/05/21 05:34:39 DEBUG : only3: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b18741_d20220521_m052930_c001_v0001040_t0034_u01653110970580") 2022/05/21 05:34:39 DEBUG : only4: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f10098a5b5691821e_d20220521_m053407_c001_v0001113_t0020_u01653111247633") 2022/05/21 05:34:39 DEBUG : only4: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8ab2ee_d20220521_m053311_c001_v0001102_t0005_u01653111191218") 2022/05/21 05:34:39 DEBUG : only4: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b18883_d20220521_m053212_c001_v0001040_t0026_u01653111132835") 2022/05/21 05:34:39 DEBUG : only4: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f11837f60f6b1c706_d20220521_m053127_c001_v0001116_t0037_u01653111087706") 2022/05/21 05:34:39 DEBUG : only4: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2abb28_d20220521_m052933_c001_v0001102_t0025_u01653110973399") 2022/05/21 05:34:39 DEBUG : only5: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f10423311e513cd94_d20220521_m053408_c001_v0001161_t0033_u01653111248479") 2022/05/21 05:34:40 DEBUG : only5: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1051e0cc8a06ed1f_d20220521_m053311_c001_v0001103_t0004_u01653111191588") 2022/05/21 05:34:40 DEBUG : only5: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2ac5ab_d20220521_m053215_c001_v0001102_t0026_u01653111135903") 2022/05/21 05:34:40 DEBUG : only5: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1048789780c63de7_d20220521_m053127_c001_v0001109_t0020_u01653111087853") 2022/05/21 05:34:40 DEBUG : only5: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8aa555_d20220521_m052936_c001_v0001102_t0005_u01653110976705") 2022/05/21 05:34:40 DEBUG : only6: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f101a59f8b19fb686_d20220521_m053409_c001_v0001109_t0030_u01653111249081") 2022/05/21 05:34:40 DEBUG : only6: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2ac988_d20220521_m053311_c001_v0001102_t0024_u01653111191704") 2022/05/21 05:34:40 DEBUG : only6: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8aafc0_d20220521_m053220_c001_v0001102_t0031_u01653111140191") 2022/05/21 05:34:40 DEBUG : only6: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f116a6f269630e131_d20220521_m053125_c001_v0001145_t0036_u01653111085849") 2022/05/21 05:34:40 DEBUG : only6: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b1874f_d20220521_m052940_c001_v0001040_t0033_u01653110980892") 2022/05/21 05:34:40 DEBUG : only7: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1081f02ba2b8b6b0_d20220521_m053412_c001_v0001038_t0058_u01653111252761") 2022/05/21 05:34:40 DEBUG : only7: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f106410f167d858d3_d20220521_m053311_c001_v0001018_t0043_u01653111191996") 2022/05/21 05:34:40 DEBUG : only7: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b18898_d20220521_m053224_c001_v0001040_t0012_u01653111144447") 2022/05/21 05:34:40 DEBUG : only7: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f117df42e379fd375_d20220521_m053126_c001_v0001165_t0027_u01653111086116") 2022/05/21 05:34:40 DEBUG : only7: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2abe24_d20220521_m053023_c001_v0001102_t0015_u01653111023357") 2022/05/21 05:34:40 DEBUG : only8: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f105d615a4f588a58_d20220521_m053414_c001_v0001038_t0011_u01653111254100") 2022/05/21 05:34:40 DEBUG : only8: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f106410f167d858d5_d20220521_m053312_c001_v0001018_t0040_u01653111192838") 2022/05/21 05:34:41 DEBUG : only8: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2ac67e_d20220521_m053227_c001_v0001102_t0023_u01653111147354") 2022/05/21 05:34:41 DEBUG : only8: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f117df42e379fd361_d20220521_m053124_c001_v0001165_t0044_u01653111084586") 2022/05/21 05:34:41 DEBUG : only8: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8aa873_d20220521_m053025_c001_v0001102_t0023_u01653111025201") 2022/05/21 05:34:41 DEBUG : only9: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1104ac70e40bdebd_d20220521_m053415_c001_v0001131_t0023_u01653111255552") 2022/05/21 05:34:41 DEBUG : only9: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1051e0cc8a06ed47_d20220521_m053313_c001_v0001103_t0056_u01653111193466") 2022/05/21 05:34:41 DEBUG : only9: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8ab03c_d20220521_m053228_c001_v0001102_t0034_u01653111148854") 2022/05/21 05:34:41 DEBUG : only9: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f11644aad159a7d3f_d20220521_m053128_c001_v0001100_t0056_u01653111088571") 2022/05/21 05:34:41 DEBUG : only9: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b187bb_d20220521_m053029_c001_v0001040_t0020_u01653111029395") 2022/05/21 05:34:41 DEBUG : potato: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f11059b8bb2de6047_d20220521_m052148_c001_v0001099_t0049_u01653110508371") 2022/05/21 05:34:41 DEBUG : potato: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2a9d9c_d20220521_m052141_c001_v0001102_t0032_u01653110501730") 2022/05/21 05:34:41 DEBUG : potato: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f108a6bab9f969ff9_d20220521_m052136_c001_v0001145_t0052_u01653110495999") 2022/05/21 05:34:41 DEBUG : potato: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b183ac_d20220521_m052127_c001_v0001040_t0025_u01653110487897") 2022/05/21 05:34:41 DEBUG : potato: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f104a792e39089c42_d20220521_m052125_c001_v0001033_t0034_u01653110485668") 2022/05/21 05:34:41 DEBUG : potato: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2a9bf8_d20220521_m052120_c001_v0001102_t0005_u01653110480312") 2022/05/21 05:34:41 DEBUG : potato: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1109ea4aa99805df_d20220521_m052046_c001_v0001103_t0019_u01653110446919") 2022/05/21 05:34:41 DEBUG : potato: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b18333_d20220521_m052042_c001_v0001040_t0015_u01653110442598") 2022/05/21 05:34:41 DEBUG : potato: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f10784a54556400c8_d20220521_m052035_c001_v0001106_t0033_u01653110435952") 2022/05/21 05:34:41 DEBUG : potato: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b18318_d20220521_m052031_c001_v0001040_t0015_u01653110431309") 2022/05/21 05:34:41 DEBUG : potato: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f11624c0e222f7bcc_d20220521_m052023_c001_v0001099_t0054_u01653110423355") 2022/05/21 05:34:42 DEBUG : potato: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffb3b1_d20220521_m052021_c001_v0001101_t0047_u01653110421194") 2022/05/21 05:34:42 DEBUG : potato: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f119b456b1ab6d778_d20220521_m052004_c001_v0001134_t0011_u01653110404351") 2022/05/21 05:34:42 DEBUG : potato: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffb298_d20220521_m052001_c001_v0001101_t0056_u01653110401043") 2022/05/21 05:34:42 DEBUG : potato: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f116b9acba779b53f_d20220521_m051959_c001_v0001109_t0012_u01653110399424") 2022/05/21 05:34:42 DEBUG : potato: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffb24b_d20220521_m051956_c001_v0001101_t0018_u01653110396183") 2022/05/21 05:34:42 DEBUG : potato: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f119117c15f9a4522_d20220521_m051949_c001_v0001102_t0037_u01653110389280") 2022/05/21 05:34:42 DEBUG : potato: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffb1d9_d20220521_m051948_c001_v0001101_t0021_u01653110388118") 2022/05/21 05:34:42 DEBUG : potato: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffb1af_d20220521_m051944_c001_v0001101_t0034_u01653110384808") 2022/05/21 05:34:42 DEBUG : potato: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f115dc296050e1bf8_d20220521_m051943_c001_v0001144_t0011_u01653110383546") 2022/05/21 05:34:42 DEBUG : potato: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffb176_d20220521_m051941_c001_v0001101_t0026_u01653110381076") 2022/05/21 05:34:42 DEBUG : potato: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffb166_d20220521_m051939_c001_v0001101_t0025_u01653110379971") 2022/05/21 05:34:42 DEBUG : potato: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f115d3959894a192b_d20220521_m051937_c001_v0001109_t0009_u01653110377929") 2022/05/21 05:34:42 DEBUG : potato: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffb137_d20220521_m051936_c001_v0001101_t0011_u01653110376779") 2022/05/21 05:34:42 DEBUG : potato2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1132aa24b757a6f9_d20220521_m052357_c001_v0001099_t0032_u01653110637028") 2022/05/21 05:34:42 DEBUG : potato2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2aa600_d20220521_m052355_c001_v0001102_t0019_u01653110635251") 2022/05/21 05:34:42 DEBUG : potato2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f112913e616732ddb_d20220521_m052338_c001_v0001103_t0026_u01653110618211") 2022/05/21 05:34:42 DEBUG : potato2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2aa478_d20220521_m052327_c001_v0001102_t0056_u01653110607516") 2022/05/21 05:34:43 DEBUG : potato2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f109abb4917937849_d20220521_m052316_c001_v0001134_t0020_u01653110596870") 2022/05/21 05:34:43 DEBUG : potato2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2aa2f0_d20220521_m052304_c001_v0001102_t0021_u01653110584119") 2022/05/21 05:34:43 DEBUG : potato2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f109371f11f87af6b_d20220521_m052254_c001_v0001157_t0006_u01653110574255") 2022/05/21 05:34:43 DEBUG : potato2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2aa0f7_d20220521_m052234_c001_v0001102_t0052_u01653110554021") 2022/05/21 05:34:43 DEBUG : potato2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f114a50bad5149143_d20220521_m052100_c001_v0001115_t0025_u01653110460559") 2022/05/21 05:34:43 DEBUG : potato2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b18368_d20220521_m052056_c001_v0001040_t0001_u01653110456647") 2022/05/21 05:34:43 DEBUG : potato2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1044866a3cb9f5cd_d20220521_m052054_c001_v0001103_t0031_u01653110454659") 2022/05/21 05:34:43 DEBUG : potato2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b18346_d20220521_m052048_c001_v0001040_t0011_u01653110448557") 2022/05/21 05:34:43 DEBUG : potato2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1143f8df7d542d9b_d20220521_m052047_c001_v0001100_t0014_u01653110447440") 2022/05/21 05:34:43 DEBUG : potato2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b1833c_d20220521_m052045_c001_v0001040_t0010_u01653110445091") 2022/05/21 05:34:43 DEBUG : potato2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f106ffcea1cdcc169_d20220521_m052041_c001_v0001100_t0021_u01653110441900") 2022/05/21 05:34:43 DEBUG : potato2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b1832b_d20220521_m052038_c001_v0001040_t0049_u01653110438524") 2022/05/21 05:34:43 DEBUG : potato2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103a20a07d583717_d20220521_m052028_c001_v0001093_t0008_u01653110428094") 2022/05/21 05:34:43 DEBUG : potato2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffb3c9_d20220521_m052023_c001_v0001101_t0024_u01653110423355") 2022/05/21 05:34:43 DEBUG : potato2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1171fd9178bca24c_d20220521_m052006_c001_v0001137_t0052_u01653110406347") 2022/05/21 05:34:43 DEBUG : potato2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffb2b1_d20220521_m052003_c001_v0001101_t0026_u01653110403698") 2022/05/21 05:34:44 DEBUG : potato2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f104928f19718887a_d20220521_m051833_c001_v0001029_t0038_u01653110313617") 2022/05/21 05:34:44 DEBUG : potato2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffad80_d20220521_m051832_c001_v0001101_t0006_u01653110311997") 2022/05/21 05:34:44 DEBUG : potato2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f112fee2f4ff15eee_d20220521_m051830_c001_v0001101_t0047_u01653110310173") 2022/05/21 05:34:44 DEBUG : potato2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffad3b_d20220521_m051828_c001_v0001101_t0036_u01653110308576") 2022/05/21 05:34:44 DEBUG : potato3: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1050ebdda6aede95_d20220521_m052343_c001_v0001144_t0019_u01653110623594") 2022/05/21 05:34:44 DEBUG : potato3: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8a8d86_d20220521_m052331_c001_v0001102_t0038_u01653110611394") 2022/05/21 05:34:44 DEBUG : potato3: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f10207ba126c5eb0c_d20220521_m052316_c001_v0001120_t0036_u01653110596582") 2022/05/21 05:34:44 DEBUG : potato3: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8a8c3a_d20220521_m052310_c001_v0001102_t0039_u01653110590929") 2022/05/21 05:34:44 DEBUG : potato3: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f105587aa5cb9db3a_d20220521_m052254_c001_v0001136_t0029_u01653110574863") 2022/05/21 05:34:44 DEBUG : potato3: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8a8a0a_d20220521_m052238_c001_v0001102_t0042_u01653110558189") 2022/05/21 05:34:44 DEBUG : pre-dest1/1: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f101e9d031c0f49f7_d20220521_m052431_c001_v0001102_t0038_u01653110671205") 2022/05/21 05:34:44 DEBUG : pre-dest1/1: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b184e0_d20220521_m052422_c001_v0001040_t0035_u01653110662374") 2022/05/21 05:34:44 DEBUG : pre-dest2/2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f11644aad159a66e3_d20220521_m052432_c001_v0001100_t0012_u01653110672994") 2022/05/21 05:34:44 DEBUG : pre-dest2/2: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8a90f5_d20220521_m052423_c001_v0001102_t0057_u01653110663443") 2022/05/21 05:34:44 DEBUG : sizeonly: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f104d26009ef2f4c8_d20220521_m051902_c001_v0001102_t0019_u01653110342890") 2022/05/21 05:34:44 DEBUG : sizeonly: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffaf4a_d20220521_m051900_c001_v0001101_t0040_u01653110340444") 2022/05/21 05:34:44 DEBUG : sub dir/hello world: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f106b4d6ec392fcdf_d20220521_m052211_c001_v0001115_t0008_u01653110531911") 2022/05/21 05:34:44 DEBUG : sub dir/hello world: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f102a30b47f2a9f41_d20220521_m052207_c001_v0001102_t0056_u01653110527058") 2022/05/21 05:34:45 DEBUG : sub dir/hello world: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f11370545e9e65e98_d20220521_m052158_c001_v0001101_t0048_u01653110518884") 2022/05/21 05:34:45 DEBUG : sub dir/hello world: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b183c7_d20220521_m052153_c001_v0001040_t0050_u01653110513208") 2022/05/21 05:34:45 DEBUG : sub dir/hello world: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1104ae50bf91427d_d20220521_m051855_c001_v0001098_t0009_u01653110335680") 2022/05/21 05:34:45 DEBUG : sub dir/hello world: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffaec9_d20220521_m051853_c001_v0001101_t0025_u01653110333740") 2022/05/21 05:34:45 DEBUG : sub dir/hello world: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103920c2ec0c14af_d20220521_m051852_c001_v0001099_t0037_u01653110332283") 2022/05/21 05:34:45 DEBUG : sub dir/hello world: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffae9d_d20220521_m051851_c001_v0001101_t0049_u01653110331176") 2022/05/21 05:34:45 DEBUG : sub dir/hello world: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f10826b114744f058_d20220521_m051849_c001_v0001116_t0010_u01653110329624") 2022/05/21 05:34:45 DEBUG : sub dir/hello world: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffae4f_d20220521_m051844_c001_v0001101_t0005_u01653110324997") 2022/05/21 05:34:45 DEBUG : sub dir/hello world: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f109d3dd706f89c84_d20220521_m051843_c001_v0001099_t0034_u01653110323592") 2022/05/21 05:34:45 DEBUG : sub dir/hello world: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffae23_d20220521_m051842_c001_v0001101_t0021_u01653110322756") 2022/05/21 05:34:45 DEBUG : sub dir/hello world: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1005b6d86111455f_d20220521_m051840_c001_v0001165_t0025_u01653110320650") 2022/05/21 05:34:45 DEBUG : sub dir/hello world: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffade6_d20220521_m051839_c001_v0001101_t0038_u01653110319919") 2022/05/21 05:34:45 DEBUG : sub dir/hello world: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1187a080eca08785_d20220521_m051837_c001_v0001103_t0001_u01653110317545") 2022/05/21 05:34:45 DEBUG : sub dir/hello world: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffadc2_d20220521_m051836_c001_v0001101_t0049_u01653110316458") 2022/05/21 05:34:45 DEBUG : sub dir/hello world: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1039e2d99b916c13_d20220521_m051825_c001_v0001145_t0057_u01653110305372") 2022/05/21 05:34:45 DEBUG : sub dir/hello world: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffad07_d20220521_m051824_c001_v0001101_t0051_u01653110304284") 2022/05/21 05:34:45 DEBUG : sub dir/hello world: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1171fd9178bca144_d20220521_m051823_c001_v0001137_t0057_u01653110303439") 2022/05/21 05:34:46 DEBUG : sub dir/hello world: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4fface8_d20220521_m051822_c001_v0001101_t0043_u01653110302301") 2022/05/21 05:34:46 DEBUG : sub dir/hello world: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8a787c_d20220521_m051818_c001_v0001102_t0023_u01653110298655") 2022/05/21 05:34:46 DEBUG : sub dir/hello world: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffaca8_d20220521_m051817_c001_v0001101_t0014_u01653110297769") 2022/05/21 05:34:46 DEBUG : sub dir/hello world: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1119e9bdeded58da_d20220521_m051815_c001_v0001038_t0024_u01653110295308") 2022/05/21 05:34:46 DEBUG : sub dir/hello world: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1112a25cb4ffac77_d20220521_m051814_c001_v0001101_t0006_u01653110294097") 2022/05/21 05:34:46 DEBUG : sub/yam: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f107daa94411726a5_d20220521_m052147_c001_v0001092_t0041_u01653110507496") 2022/05/21 05:34:46 DEBUG : sub/yam: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8a85f2_d20220521_m052141_c001_v0001102_t0043_u01653110501452") 2022/05/21 05:34:46 DEBUG : three: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f100ae8fd5f534c74_d20220521_m052117_c001_v0001098_t0005_u01653110477573") 2022/05/21 05:34:46 DEBUG : three: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b18394_d20220521_m052113_c001_v0001040_t0034_u01653110473284") 2022/05/21 05:34:46 DEBUG : three: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b18384_d20220521_m052106_c001_v0001040_t0003_u01653110466689") 2022/05/21 05:34:46 DEBUG : two: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f107caee08068d28d_d20220521_m052118_c001_v0001044_t0000_u01653110478502") 2022/05/21 05:34:46 DEBUG : two: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8a83cd_d20220521_m052112_c001_v0001102_t0057_u01653110472112") 2022/05/21 05:34:46 DEBUG : two: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103e0c2560b18380_d20220521_m052104_c001_v0001040_t0040_u01653110464779") 2022/05/21 05:34:46 DEBUG : yam: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1128c52ca712b397_d20220521_m052151_c001_v0001102_t0005_u01653110509812") 2022/05/21 05:34:46 DEBUG : yam: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f109e337760c1fee9_d20220521_m052146_c001_v0001029_t0025_u01653110506798") 2022/05/21 05:34:46 DEBUG : yam: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f112913e616732665_d20220521_m052132_c001_v0001103_t0047_u01653110492596") 2022/05/21 05:34:47 DEBUG : yam: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8a84f6_d20220521_m052127_c001_v0001102_t0007_u01653110487864") 2022/05/21 05:34:47 DEBUG : yam: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f11805df46bfc34ea_d20220521_m052124_c001_v0001117_t0046_u01653110484480") 2022/05/21 05:34:47 DEBUG : yam: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f103040b6cf8a8462_d20220521_m052120_c001_v0001102_t0052_u01653110480320") 2022/05/21 05:34:47 DEBUG : yaml: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f112f8989b40c7619_d20220521_m052138_c001_v0001106_t0044_u01653110497373") 2022/05/21 05:34:47 DEBUG : yaml: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f11353b36352b646d_d20220521_m052130_c001_v0001105_t0013_u01653110490903") 2022/05/21 05:34:47 DEBUG : yaml: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f118bd9edbcd26e49_d20220521_m052126_c001_v0001097_t0038_u01653110486411") 2022/05/21 05:34:47 DEBUG : yaml: Deleting (id "4_zaf923de300ddeb5b8f080e1b_f1126a5172b21bba5_d20220521_m052123_c001_v0001098_t0012_u01653110483122") "./sync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Finished OK in 16m37.619727553s (try 1/5)