"./sync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -fast-list" - Starting (try 1/5) 2022/05/18 05:04:46 DEBUG : Creating backend with remote "TestB2:rclone-test-soxixov9kucexuk5cotorex2" 2022/05/18 05:04:46 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2022/05/18 05:04:46 DEBUG : Creating backend with remote "/tmp/rclone665967096" === RUN TestPipe --- PASS: TestPipe (0.00s) === RUN TestPipeConcurrent --- PASS: TestPipeConcurrent (0.04s) === 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-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:04:48 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) 2022/05/18 05:04:48 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:04:48 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish --- PASS: TestCopyWithDryRun (1.68s) === RUN TestCopy run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:04:48 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:04:48 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:04:49 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/05/18 05:04:49 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopy (1.93s) === RUN TestCopyMissingDirectory run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:04:50 DEBUG : Creating backend with remote "/non-existing" 2022/05/18 05:04:50 ERROR : Local file system at /non-existing: error reading source root directory: directory not found 2022/05/18 05:04:50 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:04:50 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish --- PASS: TestCopyMissingDirectory (0.51s) === RUN TestCopyNoTraverse run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:04:51 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:04:51 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:04:51 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:04:51 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/05/18 05:04:51 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoTraverse (2.67s) === RUN TestCopyCheckFirst run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:04:53 INFO : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Running all checks before starting transfers 2022/05/18 05:04:53 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:04:53 INFO : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Checks finished, now starting transfers 2022/05/18 05:04:53 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:04:54 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/05/18 05:04:54 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyCheckFirst (1.69s) === RUN TestSyncNoTraverse run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:04:55 ERROR : Ignoring --no-traverse with sync 2022/05/18 05:04:55 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:04:55 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:04:55 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/05/18 05:04:55 INFO : sub dir/hello world: Copied (new) 2022/05/18 05:04:55 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoTraverse (2.28s) === RUN TestCopyWithDepth run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:04:57 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:04:57 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:04:58 DEBUG : hello world2: sha1 = c0bf117f9c93d02c894fe8ffd6e5cecf3545c209 OK 2022/05/18 05:04:58 INFO : hello world2: Copied (new) --- PASS: TestCopyWithDepth (2.60s) === RUN TestCopyWithFilesFrom run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:05:00 DEBUG : hello world2: Excluded 2022/05/18 05:05:00 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:05:00 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:05:00 DEBUG : potato2: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/05/18 05:05:00 INFO : potato2: Copied (new) --- PASS: TestCopyWithFilesFrom (4.51s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:05:05 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:05:05 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:05:05 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:05:05 DEBUG : potato2: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/05/18 05:05:05 INFO : potato2: Copied (new) --- PASS: TestCopyWithFilesFromAndNoTraverse (2.29s) === RUN TestCopyEmptyDirectories run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:05:07 DEBUG : sub dir2: Making directory 2022/05/18 05:05:07 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:05:07 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:05:07 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/05/18 05:05:07 INFO : sub dir/hello world: Copied (new) 2022/05/18 05:05:07 DEBUG : sub dir2: Making directory 2022/05/18 05:05:07 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: copied 1 directories fstest.go:251: Filtering empty directory "sub dir2" --- PASS: TestCopyEmptyDirectories (2.28s) === RUN TestMoveEmptyDirectories run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:05:09 DEBUG : sub dir2: Making directory 2022/05/18 05:05:09 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:05:09 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:05:09 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/05/18 05:05:09 INFO : sub dir/hello world: Copied (new) 2022/05/18 05:05:09 INFO : sub dir/hello world: Deleted 2022/05/18 05:05:09 DEBUG : sub dir: Making directory 2022/05/18 05:05:09 DEBUG : sub dir2: Making directory 2022/05/18 05:05:09 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: copied 2 directories fstest.go:251: Filtering empty directory "sub dir2" --- PASS: TestMoveEmptyDirectories (3.32s) === RUN TestSyncEmptyDirectories run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:05:12 DEBUG : sub dir2: Making directory 2022/05/18 05:05:12 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:05:12 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:05:13 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/05/18 05:05:13 INFO : sub dir/hello world: Copied (new) 2022/05/18 05:05:13 DEBUG : sub dir2: Making directory 2022/05/18 05:05:13 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: copied 1 directories 2022/05/18 05:05:13 DEBUG : Waiting for deletions to finish fstest.go:251: Filtering empty directory "sub dir2" --- PASS: TestSyncEmptyDirectories (2.28s) === RUN TestServerSideCopy run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:05:15 DEBUG : Creating backend with remote "TestB2:rclone-test-cilogit1qalocat2yineliz9" sync_test.go:275: Server side copy (if possible) B2 bucket rclone-test-soxixov9kucexuk5cotorex2 -> B2 bucket rclone-test-cilogit1qalocat2yineliz9 2022/05/18 05:05:16 DEBUG : B2 bucket rclone-test-cilogit1qalocat2yineliz9: Waiting for checks to finish 2022/05/18 05:05:16 DEBUG : B2 bucket rclone-test-cilogit1qalocat2yineliz9: Waiting for transfers to finish 2022/05/18 05:05:21 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/05/18 05:05:21 INFO : sub dir/hello world: Copied (server-side copy) 2022/05/18 05:05:21 DEBUG : B2 bucket rclone-test-cilogit1qalocat2yineliz9: Purge remote 2022/05/18 05:05:21 DEBUG : sub dir/hello world: Deleting (id "4_zbf725d5380eddb5b8f080e1b_f1099dc6793acb926_d20220518_m050519_c001_v0001144_t0056_u01652850319176") --- PASS: TestServerSideCopy (8.43s) === RUN TestCopyAfterDelete run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:05:24 ERROR : : error listing: directory not found 2022/05/18 05:05:24 DEBUG : Local file system at /tmp/rclone665967096: Making directory 2022/05/18 05:05:24 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:05:24 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish --- PASS: TestCopyAfterDelete (2.18s) === RUN TestCopyRedownload run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:05:26 DEBUG : Local file system at /tmp/rclone665967096: Waiting for checks to finish 2022/05/18 05:05:26 DEBUG : Local file system at /tmp/rclone665967096: Waiting for transfers to finish 2022/05/18 05:05:26 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/05/18 05:05:26 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyRedownload (2.33s) === RUN TestSyncBasedOnCheckSum run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:05:28 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:05:28 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:05:28 DEBUG : check sum: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/05/18 05:05:28 INFO : check sum: Copied (new) 2022/05/18 05:05:28 DEBUG : Waiting for deletions to finish 2022/05/18 05:05:28 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:05:28 DEBUG : check sum: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/05/18 05:05:28 DEBUG : check sum: Size and sha1 of src and dst objects identical 2022/05/18 05:05:28 DEBUG : check sum: Unchanged skipping 2022/05/18 05:05:28 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:05:28 DEBUG : Waiting for deletions to finish 2022/05/18 05:05:28 INFO : There was nothing to transfer --- PASS: TestSyncBasedOnCheckSum (3.43s) === RUN TestSyncSizeOnly run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:05:31 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:05:31 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:05:31 DEBUG : sizeonly: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2022/05/18 05:05:31 INFO : sizeonly: Copied (new) 2022/05/18 05:05:31 DEBUG : Waiting for deletions to finish 2022/05/18 05:05:32 DEBUG : sizeonly: Sizes identical 2022/05/18 05:05:32 DEBUG : sizeonly: Unchanged skipping 2022/05/18 05:05:32 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:05:32 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:05:32 DEBUG : Waiting for deletions to finish 2022/05/18 05:05:32 INFO : There was nothing to transfer --- PASS: TestSyncSizeOnly (2.39s) === RUN TestSyncIgnoreSize run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:05:33 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:05:33 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:05:34 DEBUG : ignore-size: sha1 = 4a756ca07e9487f482465a99e8286abc86ba4dc7 OK 2022/05/18 05:05:34 INFO : ignore-size: Copied (new) 2022/05/18 05:05:34 DEBUG : Waiting for deletions to finish 2022/05/18 05:05:34 DEBUG : ignore-size: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:05:34 DEBUG : ignore-size: Unchanged skipping 2022/05/18 05:05:34 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:05:34 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:05:34 DEBUG : Waiting for deletions to finish 2022/05/18 05:05:34 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreSize (2.72s) === RUN TestSyncIgnoreTimes run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:05:37 DEBUG : existing: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:05:37 DEBUG : existing: Unchanged skipping 2022/05/18 05:05:37 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:05:37 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:05:37 DEBUG : Waiting for deletions to finish 2022/05/18 05:05:37 INFO : There was nothing to transfer 2022/05/18 05:05:37 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2022/05/18 05:05:37 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:05:37 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:05:37 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2022/05/18 05:05:37 INFO : existing: Copied (replaced existing) 2022/05/18 05:05:37 DEBUG : Waiting for deletions to finish --- PASS: TestSyncIgnoreTimes (3.18s) === RUN TestSyncIgnoreExisting run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:05:39 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:05:39 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:05:40 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2022/05/18 05:05:40 INFO : existing: Copied (new) 2022/05/18 05:05:40 DEBUG : Waiting for deletions to finish 2022/05/18 05:05:40 DEBUG : existing: Destination exists, skipping 2022/05/18 05:05:40 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:05:40 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:05:40 DEBUG : Waiting for deletions to finish 2022/05/18 05:05:40 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreExisting (3.14s) === RUN TestSyncIgnoreErrors run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:05:43 DEBUG : d: Making directory fstest.go:251: Filtering empty directory "d" 2022/05/18 05:05:43 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:05:43 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/18 05:05:43 DEBUG : c/non empty space: Unchanged skipping 2022/05/18 05:05:43 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:05:44 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/05/18 05:05:44 INFO : a/potato2: Copied (new) 2022/05/18 05:05:44 DEBUG : Waiting for deletions to finish 2022/05/18 05:05:44 INFO : b/potato: Deleted --- PASS: TestSyncIgnoreErrors (4.82s) === RUN TestSyncAfterChangingModtimeOnly run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:05:48 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/18 05:05:48 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:05:48 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/05/18 05:05:48 NOTICE: empty space: Skipped update modification time as --dry-run is set (size 1) 2022/05/18 05:05:48 DEBUG : empty space: Unchanged skipping 2022/05/18 05:05:48 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:05:48 DEBUG : Waiting for deletions to finish 2022/05/18 05:05:48 INFO : There was nothing to transfer 2022/05/18 05:05:48 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/18 05:05:48 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:05:48 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/05/18 05:05:50 INFO : empty space: Updated modification time in destination 2022/05/18 05:05:50 DEBUG : empty space: Unchanged skipping 2022/05/18 05:05:50 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:05:50 DEBUG : Waiting for deletions to finish 2022/05/18 05:05:50 INFO : There was nothing to transfer --- PASS: TestSyncAfterChangingModtimeOnly (4.36s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:05:52 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/18 05:05:52 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:05:52 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/05/18 05:05:52 DEBUG : empty space: Unchanged skipping 2022/05/18 05:05:52 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:05:52 DEBUG : Waiting for deletions to finish 2022/05/18 05:05:52 INFO : There was nothing to transfer --- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (2.11s) === RUN TestSyncDoesntUpdateModtime run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:05:54 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:05:54 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/18 05:05:54 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 (Local file system at /tmp/rclone665967096) 2022/05/18 05:05:54 DEBUG : foo: sha1 = 62cdb7020ff920e5aa642c3d4066950dd1f01f4d (B2 bucket rclone-test-soxixov9kucexuk5cotorex2) 2022/05/18 05:05:54 DEBUG : foo: sha1 differ 2022/05/18 05:05:54 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:05:55 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 OK 2022/05/18 05:05:55 INFO : foo: Copied (replaced existing) 2022/05/18 05:05:55 DEBUG : Waiting for deletions to finish --- PASS: TestSyncDoesntUpdateModtime (2.51s) === RUN TestSyncAfterAddingAFile run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:05:57 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/18 05:05:57 DEBUG : empty space: Unchanged skipping 2022/05/18 05:05:57 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:05:57 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:05:57 DEBUG : potato: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/05/18 05:05:57 INFO : potato: Copied (new) 2022/05/18 05:05:57 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterAddingAFile (3.11s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:06:00 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2022/05/18 05:06:00 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:06:00 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:06:00 DEBUG : potato: sha1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f OK 2022/05/18 05:06:00 INFO : potato: Copied (replaced existing) 2022/05/18 05:06:00 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingFilesSizeOnly (2.51s) === RUN TestSyncAfterChangingContentsOnly run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:06:02 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/18 05:06:02 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:06:02 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f (Local file system at /tmp/rclone665967096) 2022/05/18 05:06:02 DEBUG : potato: sha1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f (B2 bucket rclone-test-soxixov9kucexuk5cotorex2) 2022/05/18 05:06:02 DEBUG : potato: sha1 differ 2022/05/18 05:06:02 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:06:03 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f OK 2022/05/18 05:06:03 INFO : potato: Copied (replaced existing) 2022/05/18 05:06:03 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingContentsOnly (4.22s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:06:07 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2022/05/18 05:06:07 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/18 05:06:07 DEBUG : empty space: Unchanged skipping 2022/05/18 05:06:07 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:06:07 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:06:07 DEBUG : Waiting for deletions to finish 2022/05/18 05:06:07 NOTICE: potato: Skipped delete as --dry-run is set (size 21) --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (2.96s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:06:10 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/18 05:06:10 DEBUG : empty space: Unchanged skipping 2022/05/18 05:06:10 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:06:10 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:06:10 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/05/18 05:06:10 INFO : potato2: Copied (new) 2022/05/18 05:06:10 DEBUG : Waiting for deletions to finish 2022/05/18 05:06:11 INFO : potato: Deleted --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (8.87s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:06:19 DEBUG : d: Making directory 2022/05/18 05:06:19 DEBUG : d/e: Making directory fstest.go:251: Filtering empty directory "d" fstest.go:251: Filtering empty directory "d/e" 2022/05/18 05:06:19 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/18 05:06:19 DEBUG : c/non empty space: Unchanged skipping 2022/05/18 05:06:19 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:06:19 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:06:20 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/05/18 05:06:20 INFO : a/potato2: Copied (new) 2022/05/18 05:06:20 DEBUG : Waiting for deletions to finish 2022/05/18 05:06:24 INFO : b/potato: Deleted --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (9.23s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:06:28 DEBUG : d: Making directory fstest.go:251: Filtering empty directory "d" 2022/05/18 05:06:29 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/18 05:06:29 DEBUG : c/non empty space: Unchanged skipping 2022/05/18 05:06:29 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:06:29 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:06:29 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/05/18 05:06:29 INFO : a/potato2: Copied (new) 2022/05/18 05:06:29 ERROR : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: not deleting files as there were IO errors 2022/05/18 05:06:29 ERROR : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: not deleting directories as there were IO errors fstest.go:251: Filtering empty directory "d" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (5.59s) === RUN TestSyncDeleteAfter --- PASS: TestSyncDeleteAfter (0.00s) === RUN TestSyncDeleteDuring run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:06:34 DEBUG : Waiting for deletions to finish 2022/05/18 05:06:34 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/18 05:06:34 DEBUG : empty space: Unchanged skipping 2022/05/18 05:06:34 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:06:34 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:06:34 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/05/18 05:06:34 INFO : potato2: Copied (new) 2022/05/18 05:06:35 INFO : potato: Deleted --- PASS: TestSyncDeleteDuring (5.14s) === RUN TestSyncDeleteBefore run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:06:39 DEBUG : Waiting for deletions to finish 2022/05/18 05:06:39 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:06:39 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:06:40 INFO : potato: Deleted 2022/05/18 05:06:40 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/18 05:06:40 DEBUG : empty space: Unchanged skipping 2022/05/18 05:06:40 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:06:40 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:06:40 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/05/18 05:06:40 INFO : potato2: Copied (new) --- PASS: TestSyncDeleteBefore (5.74s) === RUN TestCopyDeleteBefore run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:06:44 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:06:44 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:06:44 DEBUG : potato2: sha1 = 810274f0df19dab60a894a562b7a8ff04c072623 OK 2022/05/18 05:06:44 INFO : potato2: Copied (new) --- PASS: TestCopyDeleteBefore (2.84s) === RUN TestSyncWithExclude run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:06:47 DEBUG : enormous: Excluded 2022/05/18 05:06:47 DEBUG : potato2: Excluded 2022/05/18 05:06:47 DEBUG : potato2: Excluded from sync (and deletion) 2022/05/18 05:06:47 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/18 05:06:47 DEBUG : empty space: Unchanged skipping 2022/05/18 05:06:47 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:06:47 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:06:47 DEBUG : Waiting for deletions to finish 2022/05/18 05:06:47 INFO : There was nothing to transfer 2022/05/18 05:06:48 DEBUG : enormous: Excluded 2022/05/18 05:06:48 DEBUG : potato2: Excluded 2022/05/18 05:06:48 DEBUG : potato2: Excluded from sync (and deletion) 2022/05/18 05:06:48 DEBUG : empty space: Size and modification time the same (differ by 456.789µs, within tolerance 1ms) 2022/05/18 05:06:48 DEBUG : empty space: Unchanged skipping 2022/05/18 05:06:48 DEBUG : Local file system at /tmp/rclone665967096: Waiting for checks to finish 2022/05/18 05:06:48 DEBUG : Local file system at /tmp/rclone665967096: Waiting for transfers to finish 2022/05/18 05:06:48 DEBUG : Waiting for deletions to finish 2022/05/18 05:06:48 INFO : There was nothing to transfer --- PASS: TestSyncWithExclude (3.50s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:06:51 DEBUG : enormous: Excluded 2022/05/18 05:06:51 DEBUG : potato2: Excluded 2022/05/18 05:06:51 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/18 05:06:51 DEBUG : empty space: Unchanged skipping 2022/05/18 05:06:51 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:06:51 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:06:51 DEBUG : Waiting for deletions to finish 2022/05/18 05:06:53 INFO : enormous: Deleted 2022/05/18 05:06:54 INFO : potato2: Deleted 2022/05/18 05:06:54 INFO : There was nothing to transfer 2022/05/18 05:06:55 DEBUG : empty space: Size and modification time the same (differ by 456.789µs, within tolerance 1ms) 2022/05/18 05:06:55 DEBUG : empty space: Unchanged skipping 2022/05/18 05:06:55 DEBUG : Local file system at /tmp/rclone665967096: Waiting for checks to finish 2022/05/18 05:06:55 DEBUG : Local file system at /tmp/rclone665967096: Waiting for transfers to finish 2022/05/18 05:06:55 DEBUG : Waiting for deletions to finish 2022/05/18 05:06:55 INFO : enormous: Deleted 2022/05/18 05:06:55 INFO : potato2: Deleted 2022/05/18 05:06:55 INFO : There was nothing to transfer --- PASS: TestSyncWithExcludeAndDeleteExcluded (6.04s) === RUN TestSyncWithUpdateOlder run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:06:56 DEBUG : one: Clearing upload URL because of error: Post "https://pod-000-1150-06.backblaze.com/b2api/v1/b2_upload_file/0fb2ed3380dddb5b8f080e1b/c001_v0001150_t0048": EOF 2022/05/18 05:06:56 DEBUG : pacer: low level retry 1/1 (error Post "https://pod-000-1150-06.backblaze.com/b2api/v1/b2_upload_file/0fb2ed3380dddb5b8f080e1b/c001_v0001150_t0048": EOF) 2022/05/18 05:06:56 DEBUG : pacer: Rate limited, increasing sleep to 20ms run.go:283: Retry Put of "one" to B2 bucket rclone-test-soxixov9kucexuk5cotorex2: 1/10 (Post "https://pod-000-1150-06.backblaze.com/b2api/v1/b2_upload_file/0fb2ed3380dddb5b8f080e1b/c001_v0001150_t0048": EOF) 2022/05/18 05:06:58 DEBUG : pacer: Reducing sleep to 10ms 2022/05/18 05:07:01 DEBUG : four: Sizes differ (src 4 vs dst 8) 2022/05/18 05:07:01 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2022/05/18 05:07:01 DEBUG : one: Destination is newer than source, skipping 2022/05/18 05:07:01 DEBUG : three: Sizes identical 2022/05/18 05:07:01 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2022/05/18 05:07:01 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:07:01 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b (Local file system at /tmp/rclone665967096) 2022/05/18 05:07:01 DEBUG : two: sha1 = b10e0da85e90399abfec36c7376b20aa4596461b (B2 bucket rclone-test-soxixov9kucexuk5cotorex2) 2022/05/18 05:07:01 DEBUG : two: sha1 differ 2022/05/18 05:07:01 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:07:01 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2022/05/18 05:07:01 INFO : five: Copied (new) 2022/05/18 05:07:02 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2022/05/18 05:07:02 INFO : four: Copied (replaced existing) 2022/05/18 05:07:03 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2022/05/18 05:07:03 INFO : two: Copied (replaced existing) 2022/05/18 05:07:03 DEBUG : Waiting for deletions to finish 2022/05/18 05:07:03 DEBUG : one: Destination is newer than source, skipping 2022/05/18 05:07:03 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:07:03 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2022/05/18 05:07:03 DEBUG : two: Size and sha1 of src and dst objects identical 2022/05/18 05:07:03 DEBUG : two: Destination mod time is within 1s of source and files identical, skipping 2022/05/18 05:07:03 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2022/05/18 05:07:03 DEBUG : four: Size and sha1 of src and dst objects identical 2022/05/18 05:07:03 DEBUG : four: Destination mod time is within 1s of source and files identical, skipping 2022/05/18 05:07:03 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2022/05/18 05:07:03 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb (Local file system at /tmp/rclone665967096) 2022/05/18 05:07:03 DEBUG : five: Size and sha1 of src and dst objects identical 2022/05/18 05:07:03 DEBUG : three: sha1 = 03731cad13f4cf7b59703c77529381cdec1632e5 (B2 bucket rclone-test-soxixov9kucexuk5cotorex2) 2022/05/18 05:07:03 DEBUG : five: Destination mod time is within 1s of source and files identical, skipping 2022/05/18 05:07:03 DEBUG : three: sha1 differ 2022/05/18 05:07:03 DEBUG : three: Destination mod time is within 1s of source but files differ, transferring 2022/05/18 05:07:03 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:07:04 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/05/18 05:07:04 INFO : three: Copied (replaced existing) 2022/05/18 05:07:04 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithUpdateOlder (13.79s) === 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-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" sync_test.go:1058: Can track renames: true 2022/05/18 05:07:10 INFO : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Making map for --track-renames 2022/05/18 05:07:10 INFO : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Finished making map for --track-renames 2022/05/18 05:07:10 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:07:10 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for renames to finish 2022/05/18 05:07:10 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:07:11 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2022/05/18 05:07:11 INFO : potato: Copied (new) 2022/05/18 05:07:13 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2022/05/18 05:07:13 INFO : yam: Copied (new) 2022/05/18 05:07:13 DEBUG : Waiting for deletions to finish 2022/05/18 05:07:13 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:07:13 DEBUG : potato: Unchanged skipping 2022/05/18 05:07:13 INFO : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Making map for --track-renames 2022/05/18 05:07:13 INFO : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Finished making map for --track-renames 2022/05/18 05:07:13 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:07:13 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for renames to finish 2022/05/18 05:07:14 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:07:39 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2022/05/18 05:07:39 INFO : yam: Copied (server-side copy) to: yaml 2022/05/18 05:07:40 INFO : yam: Deleted 2022/05/18 05:07:40 INFO : yaml: Renamed from "yam" 2022/05/18 05:07:40 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:07:40 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenames (32.93s) === RUN TestParseRenamesStrategyModtime --- PASS: TestParseRenamesStrategyModtime (0.00s) === RUN TestRenamesStrategyModtime --- PASS: TestRenamesStrategyModtime (0.00s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" sync_test.go:1127: Can track renames: true 2022/05/18 05:07:43 INFO : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Making map for --track-renames 2022/05/18 05:07:43 INFO : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Finished making map for --track-renames 2022/05/18 05:07:43 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:07:43 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for renames to finish 2022/05/18 05:07:43 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:07:44 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2022/05/18 05:07:44 INFO : potato: Copied (new) 2022/05/18 05:07:44 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2022/05/18 05:07:44 INFO : yam: Copied (new) 2022/05/18 05:07:44 DEBUG : Waiting for deletions to finish 2022/05/18 05:07:44 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:07:44 DEBUG : potato: Unchanged skipping 2022/05/18 05:07:44 INFO : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Making map for --track-renames 2022/05/18 05:07:44 INFO : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Finished making map for --track-renames 2022/05/18 05:07:44 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:07:44 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for renames to finish 2022/05/18 05:07:45 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:07:48 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2022/05/18 05:07:48 INFO : yam: Copied (server-side copy) to: yaml 2022/05/18 05:07:49 INFO : yam: Deleted 2022/05/18 05:07:49 INFO : yaml: Renamed from "yam" 2022/05/18 05:07:49 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:07:49 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenamesStrategyModtime (9.10s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" sync_test.go:1163: Can track renames: true 2022/05/18 05:07:52 INFO : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Making map for --track-renames 2022/05/18 05:07:52 INFO : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Finished making map for --track-renames 2022/05/18 05:07:52 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:07:52 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for renames to finish 2022/05/18 05:07:52 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:07:53 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2022/05/18 05:07:53 INFO : sub/yam: Copied (new) 2022/05/18 05:07:54 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2022/05/18 05:07:54 INFO : potato: Copied (new) 2022/05/18 05:07:54 DEBUG : Waiting for deletions to finish 2022/05/18 05:07:54 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:07:54 DEBUG : potato: Unchanged skipping 2022/05/18 05:07:54 INFO : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Making map for --track-renames 2022/05/18 05:07:54 INFO : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Finished making map for --track-renames 2022/05/18 05:07:54 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:07:54 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for renames to finish 2022/05/18 05:07:54 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:07:58 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2022/05/18 05:07:58 INFO : sub/yam: Copied (server-side copy) to: yam 2022/05/18 05:07:58 INFO : sub/yam: Deleted 2022/05/18 05:07:58 INFO : yam: Renamed from "sub/yam" 2022/05/18 05:07:58 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:07:58 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenamesStrategyLeaf (9.49s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:08:01 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:08:01 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:08:02 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2022/05/18 05:08:02 INFO : nested/sub dir/file: Copied (new) 2022/05/18 05:08:02 INFO : nested/sub dir/file: Deleted 2022/05/18 05:08:03 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/05/18 05:08:03 INFO : sub dir/hello world: Copied (new) 2022/05/18 05:08:03 INFO : sub dir/hello world: Deleted 2022/05/18 05:08:03 INFO : sub dir: Removing directory 2022/05/18 05:08:03 INFO : nested/sub dir: Removing directory 2022/05/18 05:08:03 INFO : nested: Removing directory 2022/05/18 05:08:03 DEBUG : Local file system at /tmp/rclone665967096: deleted 3 directories --- PASS: TestMoveWithDeleteEmptySrcDirs (4.00s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:08:05 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:08:05 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:08:06 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2022/05/18 05:08:06 INFO : nested/sub dir/file: Copied (new) 2022/05/18 05:08:06 INFO : nested/sub dir/file: Deleted 2022/05/18 05:08:07 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/05/18 05:08:07 INFO : sub dir/hello world: Copied (new) 2022/05/18 05:08:07 INFO : sub dir/hello world: Deleted --- PASS: TestMoveWithoutDeleteEmptySrcDirs (3.61s) === RUN TestMoveWithIgnoreExisting run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:08:09 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:08:09 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:08:09 DEBUG : existing-b: sha1 = 321f6b7e8bf7f29aab89c5e41a555b1b0baa41a9 OK 2022/05/18 05:08:09 INFO : existing-b: Copied (new) 2022/05/18 05:08:09 INFO : existing-b: Deleted 2022/05/18 05:08:10 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2022/05/18 05:08:10 INFO : existing: Copied (new) 2022/05/18 05:08:10 INFO : existing: Deleted 2022/05/18 05:08:11 DEBUG : existing: Destination exists, skipping 2022/05/18 05:08:11 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2022/05/18 05:08:11 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:08:11 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:08:11 INFO : There was nothing to transfer --- PASS: TestMoveWithIgnoreExisting (4.92s) === RUN TestServerSideMove run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:08:14 DEBUG : Creating backend with remote "TestB2:rclone-test-jukuwus0viwotiq5vuyogig6" 2022/05/18 05:08:14 DEBUG : Config file has changed externaly - reloading sync_test.go:1215: Server side move (if possible) B2 bucket rclone-test-soxixov9kucexuk5cotorex2 -> B2 bucket rclone-test-jukuwus0viwotiq5vuyogig6 2022/05/18 05:08:20 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ms) 2022/05/18 05:08:20 DEBUG : empty space: Unchanged skipping 2022/05/18 05:08:20 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2022/05/18 05:08:20 DEBUG : B2 bucket rclone-test-jukuwus0viwotiq5vuyogig6: Waiting for checks to finish 2022/05/18 05:08:21 INFO : empty space: Deleted 2022/05/18 05:08:21 DEBUG : B2 bucket rclone-test-jukuwus0viwotiq5vuyogig6: Waiting for transfers to finish 2022/05/18 05:08:21 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2022/05/18 05:08:21 INFO : potato3: Copied (server-side copy) 2022/05/18 05:08:21 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/05/18 05:08:21 INFO : potato2: Copied (server-side copy) 2022/05/18 05:08:22 INFO : potato2: Deleted 2022/05/18 05:08:24 INFO : potato3: Deleted 2022/05/18 05:08:25 DEBUG : Creating backend with remote "TestB2:rclone-test-zitovoh3hacaluw5cuxorop7" 2022/05/18 05:08:25 DEBUG : B2 bucket rclone-test-zitovoh3hacaluw5cuxorop7: Waiting for checks to finish 2022/05/18 05:08:25 DEBUG : B2 bucket rclone-test-zitovoh3hacaluw5cuxorop7: Waiting for transfers to finish 2022/05/18 05:08:27 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2022/05/18 05:08:27 INFO : potato3: Copied (server-side copy) 2022/05/18 05:08:27 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/05/18 05:08:27 INFO : empty space: Copied (server-side copy) 2022/05/18 05:08:27 INFO : potato3: Deleted 2022/05/18 05:08:28 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/05/18 05:08:28 INFO : potato2: Copied (server-side copy) 2022/05/18 05:08:28 INFO : empty space: Deleted 2022/05/18 05:08:28 INFO : potato2: Deleted 2022/05/18 05:08:28 DEBUG : B2 bucket rclone-test-zitovoh3hacaluw5cuxorop7: Purge remote 2022/05/18 05:08:29 DEBUG : empty space: Deleting (id "4_z6fc23d93901ddb5b8f080e1b_f110fab45e03bb3e9_d20220518_m050826_c001_v0001102_t0022_u01652850506859") 2022/05/18 05:08:29 DEBUG : potato2: Deleting (id "4_z6fc23d93901ddb5b8f080e1b_f1063e6016e43f64c_d20220518_m050826_c001_v0001012_t0002_u01652850506867") 2022/05/18 05:08:29 DEBUG : potato3: Deleting (id "4_z6fc23d93901ddb5b8f080e1b_f1155e95138c1aec6_d20220518_m050826_c001_v0001100_t0029_u01652850506903") 2022/05/18 05:08:30 DEBUG : B2 bucket rclone-test-jukuwus0viwotiq5vuyogig6: Purge remote 2022/05/18 05:08:30 DEBUG : empty space: Deleting (id "4_zef621da3901ddb5b8f080e1b_f10802f9b3ebcb9e3_d20220518_m050827_c001_v0001115_t0058_u01652850507489") 2022/05/18 05:08:30 DEBUG : empty space: Deleting (id "4_zef621da3901ddb5b8f080e1b_f1187ae4b627ee37d_d20220518_m050819_c001_v0001134_t0012_u01652850499525") 2022/05/18 05:08:30 DEBUG : potato2: Deleting (id "4_zef621da3901ddb5b8f080e1b_f11541016a6dffe47_d20220518_m050828_c001_v0001128_t0031_u01652850508116") 2022/05/18 05:08:30 DEBUG : potato2: Deleting (id "4_zef621da3901ddb5b8f080e1b_f1045d0e751195025_d20220518_m050820_c001_v0001120_t0019_u01652850500870") 2022/05/18 05:08:30 DEBUG : potato3: Deleting (id "4_zef621da3901ddb5b8f080e1b_f118f98e876f66377_d20220518_m050827_c001_v0001093_t0019_u01652850507435") 2022/05/18 05:08:30 DEBUG : potato3: Deleting (id "4_zef621da3901ddb5b8f080e1b_f11517f0a67a5248f_d20220518_m050821_c001_v0001102_t0015_u01652850501230") 2022/05/18 05:08:30 DEBUG : potato3: Deleting (id "4_zef621da3901ddb5b8f080e1b_f1187ae4b627ee37f_d20220518_m050819_c001_v0001134_t0035_u01652850499964") --- PASS: TestServerSideMove (17.91s) === RUN TestServerSideMoveWithFilter run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:08:32 DEBUG : Creating backend with remote "TestB2:rclone-test-yamiric1heyagun8xavekin9" sync_test.go:1215: Server side move (if possible) B2 bucket rclone-test-soxixov9kucexuk5cotorex2 -> B2 bucket rclone-test-yamiric1heyagun8xavekin9 2022/05/18 05:08:39 DEBUG : empty space: Excluded from sync (and deletion) 2022/05/18 05:08:39 DEBUG : empty space: Excluded from sync (and deletion) 2022/05/18 05:08:39 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2022/05/18 05:08:39 DEBUG : B2 bucket rclone-test-yamiric1heyagun8xavekin9: Waiting for checks to finish 2022/05/18 05:08:39 DEBUG : B2 bucket rclone-test-yamiric1heyagun8xavekin9: Waiting for transfers to finish 2022/05/18 05:08:39 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/05/18 05:08:39 INFO : potato2: Copied (server-side copy) 2022/05/18 05:08:40 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2022/05/18 05:08:40 INFO : potato3: Copied (server-side copy) 2022/05/18 05:08:41 INFO : potato3: Deleted 2022/05/18 05:08:41 INFO : potato2: Deleted 2022/05/18 05:08:42 DEBUG : Creating backend with remote "TestB2:rclone-test-siwopoz1tawejav2nididuc8" 2022/05/18 05:08:42 DEBUG : empty space: Excluded from sync (and deletion) 2022/05/18 05:08:42 DEBUG : B2 bucket rclone-test-siwopoz1tawejav2nididuc8: Waiting for checks to finish 2022/05/18 05:08:42 DEBUG : B2 bucket rclone-test-siwopoz1tawejav2nididuc8: Waiting for transfers to finish 2022/05/18 05:08:44 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/05/18 05:08:44 INFO : potato2: Copied (server-side copy) 2022/05/18 05:08:44 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2022/05/18 05:08:44 INFO : potato3: Copied (server-side copy) 2022/05/18 05:08:45 INFO : potato3: Deleted 2022/05/18 05:08:46 INFO : potato2: Deleted 2022/05/18 05:08:46 DEBUG : B2 bucket rclone-test-siwopoz1tawejav2nididuc8: Purge remote 2022/05/18 05:08:47 DEBUG : potato2: Deleting (id "4_z4f927db3901ddb5b8f080e1b_f106298d7219bacb2_d20220518_m050843_c001_v0001022_t0045_u01652850523754") 2022/05/18 05:08:47 DEBUG : potato3: Deleting (id "4_z4f927db3901ddb5b8f080e1b_f1168c2446ca06faa_d20220518_m050843_c001_v0001105_t0030_u01652850523749") 2022/05/18 05:08:47 DEBUG : B2 bucket rclone-test-yamiric1heyagun8xavekin9: Purge remote 2022/05/18 05:08:48 DEBUG : empty space: Deleting (id "4_zefb26d33901ddb5b8f080e1b_f11813db585d78bbf_d20220518_m050838_c001_v0001131_t0041_u01652850518136") 2022/05/18 05:08:48 DEBUG : potato2: Deleting (id "4_zefb26d33901ddb5b8f080e1b_f11661d7cb587e11d_d20220518_m050844_c001_v0001104_t0033_u01652850524321") 2022/05/18 05:08:48 DEBUG : potato2: Deleting (id "4_zefb26d33901ddb5b8f080e1b_f1162d6157f07483e_d20220518_m050839_c001_v0001157_t0059_u01652850519380") 2022/05/18 05:08:48 DEBUG : potato3: Deleting (id "4_zefb26d33901ddb5b8f080e1b_f102cc32916dbd634_d20220518_m050844_c001_v0001109_t0020_u01652850524459") 2022/05/18 05:08:48 DEBUG : potato3: Deleting (id "4_zefb26d33901ddb5b8f080e1b_f1097c5b010bbb5a9_d20220518_m050839_c001_v0001115_t0036_u01652850519717") 2022/05/18 05:08:48 DEBUG : potato3: Deleting (id "4_zefb26d33901ddb5b8f080e1b_f11813db585d78bc5_d20220518_m050838_c001_v0001131_t0002_u01652850518590") --- PASS: TestServerSideMoveWithFilter (23.57s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:08:55 DEBUG : Creating backend with remote "TestB2:rclone-test-bejuqot7qezobas7vuriwid1" 2022/05/18 05:09:01 DEBUG : tomatoDir: Making directory sync_test.go:1215: Server side move (if possible) B2 bucket rclone-test-soxixov9kucexuk5cotorex2 -> B2 bucket rclone-test-bejuqot7qezobas7vuriwid1 2022/05/18 05:09:05 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ms) 2022/05/18 05:09:05 DEBUG : empty space: Unchanged skipping 2022/05/18 05:09:05 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2022/05/18 05:09:05 DEBUG : B2 bucket rclone-test-bejuqot7qezobas7vuriwid1: Waiting for checks to finish 2022/05/18 05:09:07 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2022/05/18 05:09:07 INFO : potato3: Copied (server-side copy) 2022/05/18 05:09:07 INFO : empty space: Deleted 2022/05/18 05:09:07 DEBUG : B2 bucket rclone-test-bejuqot7qezobas7vuriwid1: Waiting for transfers to finish 2022/05/18 05:09:08 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/05/18 05:09:08 INFO : potato2: Copied (server-side copy) 2022/05/18 05:09:08 INFO : potato3: Deleted 2022/05/18 05:09:08 INFO : potato2: Deleted 2022/05/18 05:09:09 DEBUG : Creating backend with remote "TestB2:rclone-test-coyikas4lutecat2yepuqov4" 2022/05/18 05:09:09 DEBUG : tomatoDir: Making directory 2022/05/18 05:09:09 DEBUG : B2 bucket rclone-test-coyikas4lutecat2yepuqov4: Waiting for checks to finish 2022/05/18 05:09:09 DEBUG : B2 bucket rclone-test-coyikas4lutecat2yepuqov4: Waiting for transfers to finish 2022/05/18 05:09:11 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/05/18 05:09:11 INFO : empty space: Copied (server-side copy) 2022/05/18 05:09:11 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2022/05/18 05:09:11 INFO : potato3: Copied (server-side copy) 2022/05/18 05:09:12 INFO : empty space: Deleted 2022/05/18 05:09:13 INFO : potato3: Deleted 2022/05/18 05:09:13 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/05/18 05:09:13 INFO : potato2: Copied (server-side copy) 2022/05/18 05:09:14 INFO : potato2: Deleted 2022/05/18 05:09:15 DEBUG : B2 bucket rclone-test-coyikas4lutecat2yepuqov4: Purge remote 2022/05/18 05:09:15 DEBUG : empty space: Deleting (id "4_z3fc2ed53901ddb5b8f080e1b_f10366a72640ac406_d20220518_m050910_c001_v0001165_t0042_u01652850550882") 2022/05/18 05:09:15 DEBUG : potato2: Deleting (id "4_z3fc2ed53901ddb5b8f080e1b_f117438d26819c87e_d20220518_m050910_c001_v0001103_t0027_u01652850550873") 2022/05/18 05:09:15 DEBUG : potato3: Deleting (id "4_z3fc2ed53901ddb5b8f080e1b_f1042d996516237d7_d20220518_m050910_c001_v0001099_t0012_u01652850550912") 2022/05/18 05:09:16 DEBUG : B2 bucket rclone-test-bejuqot7qezobas7vuriwid1: Purge remote 2022/05/18 05:09:16 DEBUG : empty space: Deleting (id "4_zff92cd43901ddb5b8f080e1b_f114a50bad4e06a2e_d20220518_m050911_c001_v0001115_t0020_u01652850551142") 2022/05/18 05:09:16 DEBUG : empty space: Deleting (id "4_zff92cd43901ddb5b8f080e1b_f1163483d4059c030_d20220518_m050903_c001_v0001032_t0026_u01652850543119") 2022/05/18 05:09:16 DEBUG : potato2: Deleting (id "4_zff92cd43901ddb5b8f080e1b_f108a6bab9f84410d_d20220518_m050913_c001_v0001145_t0004_u01652850553561") 2022/05/18 05:09:16 DEBUG : potato2: Deleting (id "4_zff92cd43901ddb5b8f080e1b_f10250046edef170f_d20220518_m050906_c001_v0001100_t0034_u01652850545988") 2022/05/18 05:09:16 DEBUG : potato3: Deleting (id "4_zff92cd43901ddb5b8f080e1b_f116343a95e61e304_d20220518_m050911_c001_v0001106_t0042_u01652850551811") 2022/05/18 05:09:16 DEBUG : potato3: Deleting (id "4_zff92cd43901ddb5b8f080e1b_f114b98ada287f62b_d20220518_m050906_c001_v0001098_t0035_u01652850546761") 2022/05/18 05:09:16 DEBUG : potato3: Deleting (id "4_zff92cd43901ddb5b8f080e1b_f1163483d4059c036_d20220518_m050903_c001_v0001032_t0011_u01652850543969") --- PASS: TestServerSideMoveDeleteEmptySourceDirs (22.62s) === RUN TestServerSideMoveOverlap run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:09:18 DEBUG : Creating backend with remote "TestB2:rclone-test-soxixov9kucexuk5cotorex2/rclone-move-test" 2022/05/18 05:09:18 DEBUG : Config file has changed externaly - reloading 2022/05/18 05:09:19 DEBUG : Couldn't decode error response: EOF --- PASS: TestServerSideMoveOverlap (6.33s) === RUN TestSyncOverlap run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:09:24 DEBUG : Creating backend with remote "TestB2:rclone-test-soxixov9kucexuk5cotorex2/rclone-sync-test" 2022/05/18 05:09:25 DEBUG : Couldn't decode error response: EOF --- PASS: TestSyncOverlap (1.44s) === RUN TestSyncCompareDest run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:09:26 DEBUG : Creating backend with remote "TestB2:rclone-test-soxixov9kucexuk5cotorex2/dst" 2022/05/18 05:09:26 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:09:26 DEBUG : Creating backend with remote "TestB2:rclone-test-soxixov9kucexuk5cotorex2/CompareDest" 2022/05/18 05:09:26 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:09:27 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:09:27 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for checks to finish 2022/05/18 05:09:27 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for transfers to finish 2022/05/18 05:09:29 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/05/18 05:09:29 INFO : one: Copied (new) 2022/05/18 05:09:29 DEBUG : Waiting for deletions to finish 2022/05/18 05:09:29 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for checks to finish 2022/05/18 05:09:29 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:09:29 DEBUG : one: Sizes differ (src 5 vs dst 3) 2022/05/18 05:09:29 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for transfers to finish 2022/05/18 05:09:31 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2022/05/18 05:09:31 INFO : one: Copied (replaced existing) 2022/05/18 05:09:31 DEBUG : Waiting for deletions to finish 2022/05/18 05:09:33 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for checks to finish 2022/05/18 05:09:33 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/18 05:09:33 DEBUG : one: Destination found in --compare-dest, skipping 2022/05/18 05:09:33 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for transfers to finish 2022/05/18 05:09:33 DEBUG : Waiting for deletions to finish 2022/05/18 05:09:33 INFO : There was nothing to transfer 2022/05/18 05:09:35 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/18 05:09:35 DEBUG : two: Destination found in --compare-dest, skipping 2022/05/18 05:09:35 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for checks to finish 2022/05/18 05:09:35 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/18 05:09:35 DEBUG : one: Destination found in --compare-dest, skipping 2022/05/18 05:09:35 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for transfers to finish 2022/05/18 05:09:35 DEBUG : Waiting for deletions to finish 2022/05/18 05:09:35 INFO : There was nothing to transfer 2022/05/18 05:09:36 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/18 05:09:36 DEBUG : two: Destination found in --compare-dest, skipping 2022/05/18 05:09:36 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for checks to finish 2022/05/18 05:09:36 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/18 05:09:36 DEBUG : one: Destination found in --compare-dest, skipping 2022/05/18 05:09:36 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for transfers to finish 2022/05/18 05:09:36 DEBUG : Waiting for deletions to finish 2022/05/18 05:09:36 INFO : There was nothing to transfer 2022/05/18 05:09:36 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/18 05:09:36 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2022/05/18 05:09:36 DEBUG : two: Destination found in --compare-dest, skipping 2022/05/18 05:09:36 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for checks to finish 2022/05/18 05:09:37 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/18 05:09:37 DEBUG : one: Destination found in --compare-dest, skipping 2022/05/18 05:09:37 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for transfers to finish 2022/05/18 05:09:37 DEBUG : Waiting for deletions to finish 2022/05/18 05:09:37 INFO : There was nothing to transfer 2022/05/18 05:09:37 DEBUG : two: Sizes differ (src 5 vs dst 3) 2022/05/18 05:09:37 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for checks to finish 2022/05/18 05:09:38 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/18 05:09:38 DEBUG : one: Destination found in --compare-dest, skipping 2022/05/18 05:09:38 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for transfers to finish 2022/05/18 05:09:39 DEBUG : two: sha1 = a4be8877ad88f3109a6411985a1f359e10e2d930 OK 2022/05/18 05:09:39 INFO : two: Copied (new) 2022/05/18 05:09:39 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (18.89s) === RUN TestSyncMultipleCompareDest run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:09:47 DEBUG : Creating backend with remote "TestB2:rclone-test-soxixov9kucexuk5cotorex2/dest" 2022/05/18 05:09:47 DEBUG : Config file has changed externaly - reloading 2022/05/18 05:09:48 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:09:48 DEBUG : Creating backend with remote "TestB2:rclone-test-soxixov9kucexuk5cotorex2/pre-dest1" 2022/05/18 05:09:49 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:09:49 DEBUG : Creating backend with remote "TestB2:rclone-test-soxixov9kucexuk5cotorex2/pre-dest2" 2022/05/18 05:09:49 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:09:50 DEBUG : 1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:09:50 DEBUG : 1: Destination found in --compare-dest, skipping 2022/05/18 05:09:50 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:09:50 DEBUG : 2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:09:50 DEBUG : 2: Destination found in --compare-dest, skipping 2022/05/18 05:09:50 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:09:50 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:09:50 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dest: Waiting for checks to finish 2022/05/18 05:09:50 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dest: Waiting for transfers to finish 2022/05/18 05:09:52 DEBUG : 3: sha1 = 77de68daecd823babbb58edb1c8e14d7106e83bb OK 2022/05/18 05:09:52 INFO : 3: Copied (new) 2022/05/18 05:09:52 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (10.07s) === RUN TestSyncCopyDest run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:09:55 DEBUG : Creating backend with remote "TestB2:rclone-test-soxixov9kucexuk5cotorex2/dst" 2022/05/18 05:09:55 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:09:55 DEBUG : Creating backend with remote "TestB2:rclone-test-soxixov9kucexuk5cotorex2/CopyDest" 2022/05/18 05:09:56 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:09:56 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:09:56 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for checks to finish 2022/05/18 05:09:56 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for transfers to finish 2022/05/18 05:09:58 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/05/18 05:09:58 INFO : one: Copied (new) 2022/05/18 05:09:58 DEBUG : Waiting for deletions to finish 2022/05/18 05:09:59 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for checks to finish 2022/05/18 05:09:59 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:09:59 DEBUG : one: Sizes differ (src 5 vs dst 3) 2022/05/18 05:09:59 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for transfers to finish 2022/05/18 05:10:00 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2022/05/18 05:10:00 INFO : one: Copied (replaced existing) 2022/05/18 05:10:00 DEBUG : Waiting for deletions to finish 2022/05/18 05:10:04 DEBUG : Creating backend with remote "TestB2:rclone-test-soxixov9kucexuk5cotorex2/BackupDir" 2022/05/18 05:10:05 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:10:06 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for checks to finish 2022/05/18 05:10:06 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/18 05:10:06 DEBUG : one: Sizes differ (src 5 vs dst 3) 2022/05/18 05:10:06 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:10:08 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/05/18 05:10:08 INFO : one: Copied (server-side copy) 2022/05/18 05:10:09 INFO : one: Deleted 2022/05/18 05:10:09 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2022/05/18 05:10:09 INFO : one: Copied (server-side copy) 2022/05/18 05:10:09 DEBUG : one: Destination found in --copy-dest, using server-side copy 2022/05/18 05:10:09 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for transfers to finish 2022/05/18 05:10:09 DEBUG : Waiting for deletions to finish 2022/05/18 05:10:12 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/18 05:10:12 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2022/05/18 05:10:12 INFO : two: Copied (server-side copy) 2022/05/18 05:10:12 DEBUG : two: Destination found in --copy-dest, using server-side copy 2022/05/18 05:10:12 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for checks to finish 2022/05/18 05:10:13 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/18 05:10:13 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/18 05:10:13 DEBUG : one: Unchanged skipping 2022/05/18 05:10:13 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for transfers to finish 2022/05/18 05:10:13 DEBUG : Waiting for deletions to finish 2022/05/18 05:10:13 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for checks to finish 2022/05/18 05:10:13 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/18 05:10:13 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/18 05:10:13 DEBUG : two: Unchanged skipping 2022/05/18 05:10:13 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/18 05:10:13 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/18 05:10:13 DEBUG : one: Unchanged skipping 2022/05/18 05:10:13 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for transfers to finish 2022/05/18 05:10:13 DEBUG : Waiting for deletions to finish 2022/05/18 05:10:13 INFO : There was nothing to transfer 2022/05/18 05:10:15 DEBUG : three: Sizes differ (src 7 vs dst 5) 2022/05/18 05:10:15 DEBUG : three: Destination not found in --copy-dest 2022/05/18 05:10:15 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for checks to finish 2022/05/18 05:10:16 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/18 05:10:16 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/18 05:10:16 DEBUG : one: Unchanged skipping 2022/05/18 05:10:16 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/18 05:10:16 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/05/18 05:10:16 DEBUG : two: Unchanged skipping 2022/05/18 05:10:16 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for transfers to finish 2022/05/18 05:10:18 DEBUG : three: sha1 = 370e613335f3cf2f19b2a2d35a86402f55c659f8 OK 2022/05/18 05:10:18 INFO : three: Copied (new) 2022/05/18 05:10:18 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCopyDest (30.75s) === RUN TestSyncBackupDir run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:10:29 DEBUG : Creating backend with remote "TestB2:rclone-test-soxixov9kucexuk5cotorex2/dst" 2022/05/18 05:10:29 DEBUG : Config file has changed externaly - reloading 2022/05/18 05:10:30 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:10:30 DEBUG : Creating backend with remote "TestB2:rclone-test-soxixov9kucexuk5cotorex2/backup" 2022/05/18 05:10:30 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:10:31 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/05/18 05:10:31 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:10:31 DEBUG : two: Unchanged skipping 2022/05/18 05:10:31 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for checks to finish 2022/05/18 05:10:31 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:10:32 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/05/18 05:10:32 INFO : one: Copied (server-side copy) 2022/05/18 05:10:33 INFO : one: Deleted 2022/05/18 05:10:33 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for transfers to finish 2022/05/18 05:10:34 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/05/18 05:10:34 INFO : one: Copied (new) 2022/05/18 05:10:34 DEBUG : Waiting for deletions to finish 2022/05/18 05:10:34 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:10:35 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/05/18 05:10:35 INFO : three.txt: Copied (server-side copy) 2022/05/18 05:10:36 INFO : three.txt: Deleted 2022/05/18 05:10:36 INFO : three.txt: Moved into backup dir 2022/05/18 05:10:38 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/05/18 05:10:38 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:10:38 DEBUG : two: Unchanged skipping 2022/05/18 05:10:38 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for checks to finish 2022/05/18 05:10:39 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/05/18 05:10:39 INFO : one: Copied (server-side copy) 2022/05/18 05:10:39 INFO : one: Deleted 2022/05/18 05:10:39 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for transfers to finish 2022/05/18 05:10:40 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2022/05/18 05:10:40 INFO : one: Copied (new) 2022/05/18 05:10:40 DEBUG : Waiting for deletions to finish 2022/05/18 05:10:41 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/05/18 05:10:41 INFO : three.txt: Copied (server-side copy) 2022/05/18 05:10:44 INFO : three.txt: Deleted 2022/05/18 05:10:44 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (24.17s) === RUN TestSyncBackupDirWithSuffix run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:10:54 DEBUG : Creating backend with remote "TestB2:rclone-test-soxixov9kucexuk5cotorex2/dst" 2022/05/18 05:10:55 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:10:55 DEBUG : Creating backend with remote "TestB2:rclone-test-soxixov9kucexuk5cotorex2/backup" 2022/05/18 05:10:55 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:10:55 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for checks to finish 2022/05/18 05:10:55 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/05/18 05:10:55 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:10:55 DEBUG : two: Unchanged skipping 2022/05/18 05:10:56 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:10:58 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/05/18 05:10:58 INFO : one: Copied (server-side copy) to: one.bak 2022/05/18 05:10:58 INFO : one: Deleted 2022/05/18 05:10:58 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for transfers to finish 2022/05/18 05:11:07 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/05/18 05:11:07 INFO : one: Copied (new) 2022/05/18 05:11:07 DEBUG : Waiting for deletions to finish 2022/05/18 05:11:07 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:11:10 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/05/18 05:11:10 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/05/18 05:11:15 INFO : three.txt: Deleted 2022/05/18 05:11:15 INFO : three.txt: Moved into backup dir 2022/05/18 05:11:16 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/05/18 05:11:16 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:11:16 DEBUG : two: Unchanged skipping 2022/05/18 05:11:16 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for checks to finish 2022/05/18 05:11:18 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/05/18 05:11:18 INFO : one: Copied (server-side copy) to: one.bak 2022/05/18 05:11:18 INFO : one: Deleted 2022/05/18 05:11:18 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for transfers to finish 2022/05/18 05:11:20 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2022/05/18 05:11:20 INFO : one: Copied (new) 2022/05/18 05:11:20 DEBUG : Waiting for deletions to finish 2022/05/18 05:11:22 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/05/18 05:11:22 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/05/18 05:11:23 INFO : three.txt: Deleted 2022/05/18 05:11:23 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (39.07s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:11:32 DEBUG : Creating backend with remote "TestB2:rclone-test-soxixov9kucexuk5cotorex2/dst" 2022/05/18 05:11:33 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:11:33 DEBUG : Creating backend with remote "TestB2:rclone-test-soxixov9kucexuk5cotorex2/backup" 2022/05/18 05:11:33 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:11:34 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/05/18 05:11:34 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:11:34 DEBUG : two: Unchanged skipping 2022/05/18 05:11:34 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for checks to finish 2022/05/18 05:11:34 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:11:36 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/05/18 05:11:36 INFO : one: Copied (server-side copy) to: one-2019-01-01 2022/05/18 05:11:37 INFO : one: Deleted 2022/05/18 05:11:37 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for transfers to finish 2022/05/18 05:11:38 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/05/18 05:11:38 INFO : one: Copied (new) 2022/05/18 05:11:38 DEBUG : Waiting for deletions to finish 2022/05/18 05:11:38 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:11:40 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/05/18 05:11:40 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2022/05/18 05:11:41 INFO : three.txt: Deleted 2022/05/18 05:11:41 INFO : three.txt: Moved into backup dir 2022/05/18 05:11:43 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/05/18 05:11:43 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:11:43 DEBUG : two: Unchanged skipping 2022/05/18 05:11:43 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for checks to finish 2022/05/18 05:11:44 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/05/18 05:11:44 INFO : one: Copied (server-side copy) to: one-2019-01-01 2022/05/18 05:11:45 INFO : one: Deleted 2022/05/18 05:11:45 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for transfers to finish 2022/05/18 05:11:47 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2022/05/18 05:11:47 INFO : one: Copied (new) 2022/05/18 05:11:47 DEBUG : Waiting for deletions to finish 2022/05/18 05:11:48 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/05/18 05:11:48 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2022/05/18 05:11:51 INFO : three.txt: Deleted 2022/05/18 05:11:51 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (26.44s) === RUN TestSyncBackupDirSuffixOnly run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:11:59 DEBUG : Creating backend with remote "TestB2:rclone-test-soxixov9kucexuk5cotorex2/dst" 2022/05/18 05:12:00 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:12:01 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/05/18 05:12:01 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for checks to finish 2022/05/18 05:12:01 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:12:01 DEBUG : two: Unchanged skipping 2022/05/18 05:12:01 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:12:01 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/05/18 05:12:01 INFO : one: Copied (server-side copy) to: one.bak 2022/05/18 05:12:02 INFO : one: Deleted 2022/05/18 05:12:02 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for transfers to finish 2022/05/18 05:12:03 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/05/18 05:12:03 INFO : one: Copied (new) 2022/05/18 05:12:03 DEBUG : Waiting for deletions to finish 2022/05/18 05:12:03 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:12:08 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/05/18 05:12:08 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/05/18 05:12:09 INFO : three.txt: Deleted 2022/05/18 05:12:09 INFO : three.txt: Moved into backup dir 2022/05/18 05:12:10 DEBUG : one.bak: Excluded from sync (and deletion) 2022/05/18 05:12:10 DEBUG : three.txt.bak: Excluded from sync (and deletion) 2022/05/18 05:12:10 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/05/18 05:12:10 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:12:10 DEBUG : two: Unchanged skipping 2022/05/18 05:12:10 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for checks to finish 2022/05/18 05:12:13 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/05/18 05:12:13 INFO : one: Copied (server-side copy) to: one.bak 2022/05/18 05:12:13 INFO : one: Deleted 2022/05/18 05:12:13 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2 path dst: Waiting for transfers to finish 2022/05/18 05:12:14 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2022/05/18 05:12:14 INFO : one: Copied (new) 2022/05/18 05:12:14 DEBUG : Waiting for deletions to finish 2022/05/18 05:12:15 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/05/18 05:12:15 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/05/18 05:12:17 INFO : three.txt: Deleted 2022/05/18 05:12:17 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (24.51s) === RUN TestSyncSuffix run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:12:23 DEBUG : Creating backend with remote "TestB2:rclone-test-soxixov9kucexuk5cotorex2/dst" 2022/05/18 05:12:24 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:12:24 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/05/18 05:12:25 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:12:26 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/05/18 05:12:26 INFO : one: Copied (server-side copy) to: one.bak 2022/05/18 05:12:27 INFO : one: Deleted 2022/05/18 05:12:28 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/05/18 05:12:28 INFO : one: Copied (new) 2022/05/18 05:12:28 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:12:28 DEBUG : two: Unchanged skipping 2022/05/18 05:12:28 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2022/05/18 05:12:29 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:12:29 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/05/18 05:12:29 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/05/18 05:12:30 INFO : three.txt: Deleted 2022/05/18 05:12:32 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/05/18 05:12:32 INFO : three.txt: Copied (new) 2022/05/18 05:12:33 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/05/18 05:12:35 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/05/18 05:12:35 INFO : one: Copied (server-side copy) to: one.bak 2022/05/18 05:12:37 INFO : one: Deleted 2022/05/18 05:12:37 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2022/05/18 05:12:37 INFO : one: Copied (new) 2022/05/18 05:12:38 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:12:38 DEBUG : two: Unchanged skipping 2022/05/18 05:12:38 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2022/05/18 05:12:38 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/05/18 05:12:38 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/05/18 05:12:39 INFO : three.txt: Deleted 2022/05/18 05:12:40 DEBUG : three.txt: sha1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK 2022/05/18 05:12:40 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (23.43s) === RUN TestSyncSuffixKeepExtension run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:12:49 DEBUG : Creating backend with remote "TestB2:rclone-test-soxixov9kucexuk5cotorex2/dst" 2022/05/18 05:12:49 DEBUG : Config file has changed externaly - reloading 2022/05/18 05:12:50 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:12:50 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/05/18 05:12:51 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:12:52 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/05/18 05:12:52 INFO : one: Copied (server-side copy) to: one-2019-01-01 2022/05/18 05:12:53 INFO : one: Deleted 2022/05/18 05:12:54 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/05/18 05:12:54 INFO : one: Copied (new) 2022/05/18 05:12:54 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:12:54 DEBUG : two: Unchanged skipping 2022/05/18 05:12:54 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2022/05/18 05:12:54 DEBUG : Couldn't decode error response: EOF 2022/05/18 05:12:55 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/05/18 05:12:55 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2022/05/18 05:12:55 INFO : three.txt: Deleted 2022/05/18 05:12:58 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/05/18 05:12:58 INFO : three.txt: Copied (new) 2022/05/18 05:12:58 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/05/18 05:12:59 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/05/18 05:12:59 INFO : one: Copied (server-side copy) to: one-2019-01-01 2022/05/18 05:13:00 INFO : one: Deleted 2022/05/18 05:13:00 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2022/05/18 05:13:00 INFO : one: Copied (new) 2022/05/18 05:13:01 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:13:01 DEBUG : two: Unchanged skipping 2022/05/18 05:13:01 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2022/05/18 05:13:02 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/05/18 05:13:02 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2022/05/18 05:13:02 INFO : three.txt: Deleted 2022/05/18 05:13:03 DEBUG : three.txt: sha1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK 2022/05/18 05:13:03 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (25.37s) === RUN TestSyncUTFNorm run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:13:09 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:13:09 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2022/05/18 05:13:09 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:13:12 DEBUG : Testêé: sha1 = a54d88e06612d820bc3be72877c74f257b561b19 OK 2022/05/18 05:13:12 INFO : Testêé: Copied (replaced existing) to: Testêé 2022/05/18 05:13:12 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (5.65s) === RUN TestSyncImmutable run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:13:14 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:13:14 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:13:15 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2022/05/18 05:13:15 INFO : existing: Copied (new) 2022/05/18 05:13:15 DEBUG : Waiting for deletions to finish 2022/05/18 05:13:16 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2022/05/18 05:13:16 ERROR : existing: Source and destination exist but do not match: immutable file modified 2022/05/18 05:13:16 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:13:16 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:13:16 ERROR : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: not deleting files as there were IO errors 2022/05/18 05:13:16 ERROR : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: not deleting directories as there were IO errors --- PASS: TestSyncImmutable (3.83s) === RUN TestSyncIgnoreCase run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:13:20 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:13:20 DEBUG : existing: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:13:20 DEBUG : existing: Unchanged skipping 2022/05/18 05:13:20 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:13:20 DEBUG : Waiting for deletions to finish 2022/05/18 05:13:20 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (2.98s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" sync_test.go:1989: This test only runs on local === RUN TestMaxTransfer/Soft run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" sync_test.go:1989: This test only runs on local === RUN TestMaxTransfer/Cautious run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" sync_test.go:1989: This test only runs on local --- PASS: TestMaxTransfer (1.07s) --- SKIP: TestMaxTransfer/Hard (0.35s) --- SKIP: TestMaxTransfer/Soft (0.36s) --- SKIP: TestMaxTransfer/Cautious (0.36s) === RUN TestSyncConcurrentDelete run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:14:05 DEBUG : both0: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:14:05 DEBUG : both0: Unchanged skipping 2022/05/18 05:14:05 DEBUG : both1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:14:05 DEBUG : both1: Unchanged skipping 2022/05/18 05:14:05 DEBUG : both10: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:14:05 DEBUG : both10: Unchanged skipping 2022/05/18 05:14:05 DEBUG : both11: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:14:05 DEBUG : both11: Unchanged skipping 2022/05/18 05:14:05 DEBUG : both12: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:14:05 DEBUG : both12: Unchanged skipping 2022/05/18 05:14:05 DEBUG : both13: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:14:05 DEBUG : both13: Unchanged skipping 2022/05/18 05:14:05 DEBUG : both14: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:14:05 DEBUG : both14: Unchanged skipping 2022/05/18 05:14:05 DEBUG : both15: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:14:05 DEBUG : both15: Unchanged skipping 2022/05/18 05:14:05 DEBUG : both16: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:14:05 DEBUG : both16: Unchanged skipping 2022/05/18 05:14:05 DEBUG : both17: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:14:05 DEBUG : both17: Unchanged skipping 2022/05/18 05:14:05 DEBUG : both18: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:14:05 DEBUG : both18: Unchanged skipping 2022/05/18 05:14:05 DEBUG : both19: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:14:05 DEBUG : both19: Unchanged skipping 2022/05/18 05:14:05 DEBUG : both2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:14:05 DEBUG : both2: Unchanged skipping 2022/05/18 05:14:05 DEBUG : both3: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:14:05 DEBUG : both3: Unchanged skipping 2022/05/18 05:14:05 DEBUG : both4: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:14:05 DEBUG : both4: Unchanged skipping 2022/05/18 05:14:05 DEBUG : both5: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:14:05 DEBUG : both5: Unchanged skipping 2022/05/18 05:14:05 DEBUG : both6: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:14:05 DEBUG : both6: Unchanged skipping 2022/05/18 05:14:05 DEBUG : both7: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:14:05 DEBUG : both7: Unchanged skipping 2022/05/18 05:14:05 DEBUG : both8: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:14:05 DEBUG : both8: Unchanged skipping 2022/05/18 05:14:05 DEBUG : both9: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:14:05 DEBUG : both9: Unchanged skipping 2022/05/18 05:14:05 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:14:05 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:14:05 DEBUG : Waiting for deletions to finish 2022/05/18 05:14:05 INFO : only6: Deleted 2022/05/18 05:14:06 INFO : only4: Deleted 2022/05/18 05:14:06 INFO : only8: Deleted 2022/05/18 05:14:06 INFO : only17: Deleted 2022/05/18 05:14:06 INFO : only2: Deleted 2022/05/18 05:14:07 INFO : only15: Deleted 2022/05/18 05:14:07 INFO : only10: Deleted 2022/05/18 05:14:07 INFO : only12: Deleted 2022/05/18 05:14:07 INFO : only18: Deleted 2022/05/18 05:14:08 INFO : only5: Deleted 2022/05/18 05:14:08 INFO : only1: Deleted 2022/05/18 05:14:08 INFO : only7: Deleted 2022/05/18 05:14:08 INFO : only13: Deleted 2022/05/18 05:14:09 INFO : only3: Deleted 2022/05/18 05:14:09 INFO : only0: Deleted 2022/05/18 05:14:09 INFO : only16: Deleted 2022/05/18 05:14:10 INFO : only11: Deleted 2022/05/18 05:14:10 INFO : only19: Deleted 2022/05/18 05:14:10 INFO : only9: Deleted 2022/05/18 05:14:10 INFO : only14: Deleted 2022/05/18 05:14:10 INFO : There was nothing to transfer --- PASS: TestSyncConcurrentDelete (67.61s) === RUN TestSyncConcurrentTruncate run.go:181: Remote "B2 bucket rclone-test-soxixov9kucexuk5cotorex2", Local "Local file system at /tmp/rclone665967096", Modify Window "1ms" 2022/05/18 05:15:17 DEBUG : both1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:15:17 DEBUG : both10: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:15:17 DEBUG : both10: Unchanged skipping 2022/05/18 05:15:17 DEBUG : both11: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:15:17 DEBUG : both11: Unchanged skipping 2022/05/18 05:15:17 DEBUG : both12: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:15:17 DEBUG : both13: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:15:17 DEBUG : both12: Unchanged skipping 2022/05/18 05:15:17 DEBUG : both13: Unchanged skipping 2022/05/18 05:15:17 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for checks to finish 2022/05/18 05:15:17 DEBUG : both14: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:15:17 DEBUG : both0: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:15:17 DEBUG : both14: Unchanged skipping 2022/05/18 05:15:17 DEBUG : both0: Unchanged skipping 2022/05/18 05:15:17 DEBUG : both16: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:15:17 DEBUG : both16: Unchanged skipping 2022/05/18 05:15:17 DEBUG : both17: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:15:17 DEBUG : both17: Unchanged skipping 2022/05/18 05:15:17 DEBUG : both18: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:15:17 DEBUG : both18: Unchanged skipping 2022/05/18 05:15:17 DEBUG : both19: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:15:17 DEBUG : both19: Unchanged skipping 2022/05/18 05:15:17 DEBUG : both2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:15:17 DEBUG : both3: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:15:17 DEBUG : both2: Unchanged skipping 2022/05/18 05:15:17 DEBUG : both3: Unchanged skipping 2022/05/18 05:15:17 DEBUG : both4: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:15:17 DEBUG : both5: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:15:17 DEBUG : both4: Unchanged skipping 2022/05/18 05:15:17 DEBUG : both5: Unchanged skipping 2022/05/18 05:15:17 DEBUG : both6: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:15:17 DEBUG : both7: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:15:17 DEBUG : both15: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:15:17 DEBUG : both7: Unchanged skipping 2022/05/18 05:15:17 DEBUG : both15: Unchanged skipping 2022/05/18 05:15:17 DEBUG : both8: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:15:17 DEBUG : both8: Unchanged skipping 2022/05/18 05:15:17 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2022/05/18 05:15:17 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2022/05/18 05:15:17 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2022/05/18 05:15:17 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2022/05/18 05:15:17 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2022/05/18 05:15:17 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2022/05/18 05:15:17 DEBUG : both6: Unchanged skipping 2022/05/18 05:15:17 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2022/05/18 05:15:17 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2022/05/18 05:15:17 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2022/05/18 05:15:17 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2022/05/18 05:15:17 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2022/05/18 05:15:17 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2022/05/18 05:15:17 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2022/05/18 05:15:17 DEBUG : both9: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/05/18 05:15:17 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2022/05/18 05:15:17 DEBUG : both9: Unchanged skipping 2022/05/18 05:15:17 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2022/05/18 05:15:17 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2022/05/18 05:15:17 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2022/05/18 05:15:17 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2022/05/18 05:15:17 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2022/05/18 05:15:17 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2022/05/18 05:15:17 DEBUG : both1: Unchanged skipping 2022/05/18 05:15:17 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Waiting for transfers to finish 2022/05/18 05:15:17 DEBUG : only11: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/18 05:15:17 INFO : only11: Copied (replaced existing) 2022/05/18 05:15:17 DEBUG : only0: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/18 05:15:17 INFO : only0: Copied (replaced existing) 2022/05/18 05:15:18 DEBUG : only12: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/18 05:15:18 INFO : only12: Copied (replaced existing) 2022/05/18 05:15:18 DEBUG : only13: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/18 05:15:18 INFO : only13: Copied (replaced existing) 2022/05/18 05:15:18 DEBUG : only1: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/18 05:15:18 INFO : only1: Copied (replaced existing) 2022/05/18 05:15:19 DEBUG : only15: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/18 05:15:19 INFO : only15: Copied (replaced existing) 2022/05/18 05:15:19 DEBUG : only16: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/18 05:15:19 INFO : only16: Copied (replaced existing) 2022/05/18 05:15:19 DEBUG : only10: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/18 05:15:19 INFO : only10: Copied (replaced existing) 2022/05/18 05:15:19 DEBUG : only17: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/18 05:15:19 INFO : only17: Copied (replaced existing) 2022/05/18 05:15:19 DEBUG : only18: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/18 05:15:19 INFO : only18: Copied (replaced existing) 2022/05/18 05:15:20 DEBUG : only19: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/18 05:15:20 INFO : only19: Copied (replaced existing) 2022/05/18 05:15:20 DEBUG : only3: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/18 05:15:20 INFO : only3: Copied (replaced existing) 2022/05/18 05:15:20 DEBUG : only4: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/18 05:15:20 INFO : only4: Copied (replaced existing) 2022/05/18 05:15:20 DEBUG : only6: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/18 05:15:20 INFO : only6: Copied (replaced existing) 2022/05/18 05:15:20 DEBUG : only14: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/18 05:15:20 INFO : only14: Copied (replaced existing) 2022/05/18 05:15:20 DEBUG : only7: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/18 05:15:20 INFO : only7: Copied (replaced existing) 2022/05/18 05:15:21 DEBUG : only8: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/18 05:15:21 INFO : only8: Copied (replaced existing) 2022/05/18 05:15:21 DEBUG : only9: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/18 05:15:21 INFO : only9: Copied (replaced existing) 2022/05/18 05:15:21 DEBUG : only5: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/18 05:15:21 INFO : only5: Copied (replaced existing) 2022/05/18 05:15:22 DEBUG : only2: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/05/18 05:15:22 INFO : only2: Copied (replaced existing) 2022/05/18 05:15:22 DEBUG : Waiting for deletions to finish --- PASS: TestSyncConcurrentTruncate (98.57s) PASS 2022/05/18 05:16:08 DEBUG : B2 bucket rclone-test-soxixov9kucexuk5cotorex2: Purge remote 2022/05/18 05:16:09 DEBUG : BackupDir/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f10070b77250b55b2_d20220518_m051019_c001_v0001144_t0040_u01652850619032") 2022/05/18 05:16:09 DEBUG : BackupDir/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f113567fa8e634216_d20220518_m051007_c001_v0001033_t0022_u01652850607314") 2022/05/18 05:16:09 DEBUG : CompareDest/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f109f2efeff27a1ea_d20220518_m050939_c001_v0001098_t0044_u01652850579727") 2022/05/18 05:16:09 DEBUG : CompareDest/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b527d_d20220518_m050932_c001_v0001100_t0013_u01652850572558") 2022/05/18 05:16:09 DEBUG : CompareDest/two: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112f8989b3d015e4_d20220518_m050940_c001_v0001106_t0055_u01652850580256") 2022/05/18 05:16:09 DEBUG : CompareDest/two: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1f5ec_d20220518_m050934_c001_v0001117_t0054_u01652850574204") 2022/05/18 05:16:09 DEBUG : CopyDest/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f109b55a946646116_d20220518_m051020_c001_v0001116_t0003_u01652850620125") 2022/05/18 05:16:09 DEBUG : CopyDest/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1b24_d20220518_m051004_c001_v0001128_t0030_u01652850604240") 2022/05/18 05:16:09 DEBUG : CopyDest/three: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f110e66fcd4cca450_d20220518_m051021_c001_v0001146_t0053_u01652850621198") 2022/05/18 05:16:09 DEBUG : CopyDest/three: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1f73f_d20220518_m051014_c001_v0001117_t0009_u01652850614459") 2022/05/18 05:16:09 DEBUG : CopyDest/two: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f104f365ee1c33e12_d20220518_m051022_c001_v0001005_t0012_u01652850622208") 2022/05/18 05:16:09 DEBUG : CopyDest/two: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b5444_d20220518_m051010_c001_v0001100_t0035_u01652850610292") 2022/05/18 05:16:09 DEBUG : EXISTING: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f11326b3c8fa80e2a_d20220518_m051320_c001_v0001131_t0015_u01652850800725") 2022/05/18 05:16:09 DEBUG : EXISTING: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b5dc3_d20220518_m051318_c001_v0001100_t0017_u01652850798677") 2022/05/18 05:16:09 DEBUG : Testêé: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1116a18c7a3b109f_d20220518_m051313_c001_v0001106_t0004_u01652850793165") 2022/05/18 05:16:09 DEBUG : Testêé: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1fd3c_d20220518_m051310_c001_v0001117_t0048_u01652850790286") 2022/05/18 05:16:09 DEBUG : Testêé: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b5d44_d20220518_m051309_c001_v0001100_t0024_u01652850789172") 2022/05/18 05:16:09 DEBUG : a/potato2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1efba_d20220518_m050630_c001_v0001117_t0004_u01652850390005") 2022/05/18 05:16:10 DEBUG : a/potato2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b269691_d20220518_m050629_c001_v0001150_t0002_u01652850389265") 2022/05/18 05:16:10 DEBUG : a/potato2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1199b53a80306dd1_d20220518_m050624_c001_v0001117_t0047_u01652850384667") 2022/05/18 05:16:10 DEBUG : a/potato2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b26966c_d20220518_m050620_c001_v0001150_t0026_u01652850380000") 2022/05/18 05:16:10 DEBUG : a/potato2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f115738f9b5bcd904_d20220518_m050545_c001_v0001115_t0024_u01652850345290") 2022/05/18 05:16:10 DEBUG : a/potato2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b2695cd_d20220518_m050544_c001_v0001150_t0004_u01652850344007") 2022/05/18 05:16:10 DEBUG : b/potato: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117df42e3775fccf_d20220518_m050631_c001_v0001165_t0024_u01652850391913") 2022/05/18 05:16:10 DEBUG : b/potato: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b269689_d20220518_m050627_c001_v0001150_t0012_u01652850387939") 2022/05/18 05:16:10 DEBUG : b/potato: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1041b6555a1a1d0f_d20220518_m050620_c001_v0001104_t0049_u01652850380366") 2022/05/18 05:16:10 DEBUG : b/potato: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b269660_d20220518_m050618_c001_v0001150_t0022_u01652850378686") 2022/05/18 05:16:10 DEBUG : b/potato: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1141a853f9f27222_d20220518_m050544_c001_v0001101_t0030_u01652850344468") 2022/05/18 05:16:10 DEBUG : b/potato: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b2695c9_d20220518_m050542_c001_v0001150_t0005_u01652850342872") 2022/05/18 05:16:10 DEBUG : backup/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117b9f2aee19c155_d20220518_m051044_c001_v0001109_t0004_u01652850644950") 2022/05/18 05:16:10 DEBUG : backup/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f101239d636994c82_d20220518_m051038_c001_v0001105_t0017_u01652850638371") 2022/05/18 05:16:10 DEBUG : backup/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f113129be9af8b1fd_d20220518_m051032_c001_v0001150_t0012_u01652850632332") 2022/05/18 05:16:10 DEBUG : backup/one-2019-01-01: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f102c0fb30f9294ae_d20220518_m051152_c001_v0001097_t0038_u01652850712059") 2022/05/18 05:16:10 DEBUG : backup/one-2019-01-01: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f103a301a178bcb78_d20220518_m051143_c001_v0001098_t0047_u01652850703929") 2022/05/18 05:16:10 DEBUG : backup/one-2019-01-01: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1063cd346c13b665_d20220518_m051135_c001_v0001099_t0012_u01652850695386") 2022/05/18 05:16:11 DEBUG : backup/one.bak: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f11703bb0b4392174_d20220518_m051123_c001_v0001098_t0015_u01652850683915") 2022/05/18 05:16:11 DEBUG : backup/one.bak: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1117231bbd13d3b2_d20220518_m051117_c001_v0001115_t0035_u01652850677146") 2022/05/18 05:16:11 DEBUG : backup/one.bak: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f113753efed3f4e9d_d20220518_m051057_c001_v0001102_t0014_u01652850657027") 2022/05/18 05:16:11 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f10007dc63152b818_d20220518_m051152_c001_v0001109_t0017_u01652850712504") 2022/05/18 05:16:11 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1054d284b1931c47_d20220518_m051147_c001_v0001011_t0024_u01652850707354") 2022/05/18 05:16:11 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f11662db2fb082f65_d20220518_m051139_c001_v0001040_t0011_u01652850699034") 2022/05/18 05:16:11 DEBUG : backup/three.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f11517f0a67a52e1f_d20220518_m051047_c001_v0001102_t0013_u01652850647632") 2022/05/18 05:16:11 DEBUG : backup/three.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f11836e3cec4ca1c8_d20220518_m051040_c001_v0001109_t0043_u01652850640345") 2022/05/18 05:16:11 DEBUG : backup/three.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f10459d4575d3b66c_d20220518_m051034_c001_v0001117_t0044_u01652850634920") 2022/05/18 05:16:11 DEBUG : backup/three.txt.bak: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1143f8df7d262ce8_d20220518_m051124_c001_v0001100_t0013_u01652850684693") 2022/05/18 05:16:11 DEBUG : backup/three.txt.bak: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f10251dccc3e7dc55_d20220518_m051120_c001_v0001018_t0013_u01652850680764") 2022/05/18 05:16:11 DEBUG : backup/three.txt.bak: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f107e9b54cb95663b_d20220518_m051108_c001_v0001109_t0056_u01652850668400") 2022/05/18 05:16:12 DEBUG : both0: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f10757c8b7b9bf981_d20220518_m051523_c001_v0001131_t0054_u01652850923629") 2022/05/18 05:16:12 DEBUG : both0: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1e6e_d20220518_m051430_c001_v0001128_t0048_u01652850870311") 2022/05/18 05:16:12 DEBUG : both0: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1087aa8408674c48_d20220518_m051411_c001_v0001103_t0058_u01652850851063") 2022/05/18 05:16:12 DEBUG : both0: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1fda5_d20220518_m051322_c001_v0001117_t0016_u01652850802699") 2022/05/18 05:16:12 DEBUG : both1: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1056a8506f30b4bf_d20220518_m051524_c001_v0001161_t0013_u01652850924301") 2022/05/18 05:16:12 DEBUG : both1: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1ffe1_d20220518_m051433_c001_v0001117_t0040_u01652850873988") 2022/05/18 05:16:12 DEBUG : both1: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117b7d60701a563c_d20220518_m051411_c001_v0001117_t0027_u01652850851580") 2022/05/18 05:16:12 DEBUG : both1: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b5e23_d20220518_m051324_c001_v0001100_t0011_u01652850804444") 2022/05/18 05:16:12 DEBUG : both10: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1044341df891bf05_d20220518_m051524_c001_v0001032_t0045_u01652850924824") 2022/05/18 05:16:12 DEBUG : both10: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa200a1_d20220518_m051451_c001_v0001117_t0013_u01652850891551") 2022/05/18 05:16:12 DEBUG : both10: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f11295ecc12bb3121_d20220518_m051412_c001_v0001130_t0021_u01652850852917") 2022/05/18 05:16:12 DEBUG : both10: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b5ef6_d20220518_m051343_c001_v0001100_t0020_u01652850823783") 2022/05/18 05:16:12 DEBUG : both11: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f10247ef3bd1e84b7_d20220518_m051525_c001_v0001131_t0055_u01652850925334") 2022/05/18 05:16:12 DEBUG : both11: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b6251_d20220518_m051453_c001_v0001100_t0053_u01652850893389") 2022/05/18 05:16:12 DEBUG : both11: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f116c8609f51d6e01_d20220518_m051413_c001_v0001101_t0031_u01652850853615") 2022/05/18 05:16:12 DEBUG : both11: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1ddb_d20220518_m051346_c001_v0001128_t0046_u01652850826579") 2022/05/18 05:16:13 DEBUG : both12: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1088be367ab1153f_d20220518_m051525_c001_v0001005_t0029_u01652850925852") 2022/05/18 05:16:13 DEBUG : both12: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1ec5_d20220518_m051457_c001_v0001128_t0045_u01652850897150") 2022/05/18 05:16:13 DEBUG : both12: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1198f95e6707c29c_d20220518_m051414_c001_v0001098_t0058_u01652850854205") 2022/05/18 05:16:13 DEBUG : both12: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1fe69_d20220518_m051348_c001_v0001117_t0033_u01652850828959") 2022/05/18 05:16:13 DEBUG : both13: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f105a0337fc976ac7_d20220518_m051526_c001_v0001092_t0002_u01652850926580") 2022/05/18 05:16:13 DEBUG : both13: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa200e6_d20220518_m051458_c001_v0001117_t0003_u01652850898332") 2022/05/18 05:16:13 DEBUG : both13: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f103088c1e220d2a8_d20220518_m051415_c001_v0001136_t0042_u01652850855218") 2022/05/18 05:16:13 DEBUG : both13: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b5f43_d20220518_m051350_c001_v0001100_t0013_u01652850830088") 2022/05/18 05:16:13 DEBUG : both14: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f108463d49eed2a6d_d20220518_m051527_c001_v0001137_t0035_u01652850927163") 2022/05/18 05:16:13 DEBUG : both14: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b629e_d20220518_m051500_c001_v0001100_t0055_u01652850900024") 2022/05/18 05:16:13 DEBUG : both14: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1076382206ab53d6_d20220518_m051415_c001_v0001099_t0026_u01652850855639") 2022/05/18 05:16:13 DEBUG : both14: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1de7_d20220518_m051351_c001_v0001128_t0018_u01652850831809") 2022/05/18 05:16:13 DEBUG : both15: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f118c901b5bd73eb8_d20220518_m051528_c001_v0001104_t0056_u01652850928077") 2022/05/18 05:16:13 DEBUG : both15: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1edc_d20220518_m051503_c001_v0001128_t0017_u01652850903483") 2022/05/18 05:16:13 DEBUG : both15: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f109371f11f66c061_d20220518_m051417_c001_v0001157_t0053_u01652850857136") 2022/05/18 05:16:13 DEBUG : both15: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1fe8e_d20220518_m051352_c001_v0001117_t0005_u01652850832669") 2022/05/18 05:16:14 DEBUG : both16: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f103040b6cf50720c_d20220518_m051529_c001_v0001102_t0049_u01652850929848") 2022/05/18 05:16:14 DEBUG : both16: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa2012b_d20220518_m051504_c001_v0001117_t0008_u01652850904606") 2022/05/18 05:16:14 DEBUG : both16: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1196870a8a796eaf_d20220518_m051417_c001_v0001033_t0021_u01652850857992") 2022/05/18 05:16:14 DEBUG : both16: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b5f84_d20220518_m051354_c001_v0001100_t0031_u01652850834660") 2022/05/18 05:16:14 DEBUG : both17: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f111c098c96eab122_d20220518_m051530_c001_v0001105_t0035_u01652850930273") 2022/05/18 05:16:14 DEBUG : both17: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b62e5_d20220518_m051508_c001_v0001100_t0018_u01652850908084") 2022/05/18 05:16:14 DEBUG : both17: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f10207ba126b32bf6_d20220518_m051418_c001_v0001120_t0054_u01652850858625") 2022/05/18 05:16:14 DEBUG : both17: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1dfc_d20220518_m051356_c001_v0001128_t0055_u01652850836848") 2022/05/18 05:16:14 DEBUG : both18: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1163483d4059c2ff_d20220518_m051531_c001_v0001032_t0049_u01652850931488") 2022/05/18 05:16:14 DEBUG : both18: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1efd_d20220518_m051513_c001_v0001128_t0044_u01652850913996") 2022/05/18 05:16:14 DEBUG : both18: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1039e2d99b7e87f4_d20220518_m051419_c001_v0001145_t0035_u01652850859884") 2022/05/18 05:16:14 DEBUG : both18: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1fec5_d20220518_m051359_c001_v0001117_t0019_u01652850838714") 2022/05/18 05:16:14 DEBUG : both19: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f104e84a100a003aa_d20220518_m051532_c001_v0001116_t0010_u01652850932793") 2022/05/18 05:16:14 DEBUG : both19: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa201a3_d20220518_m051515_c001_v0001117_t0005_u01652850915346") 2022/05/18 05:16:15 DEBUG : both19: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1033702f35704aa4_d20220518_m051420_c001_v0001128_t0008_u01652850860815") 2022/05/18 05:16:15 DEBUG : both19: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b5fd0_d20220518_m051401_c001_v0001100_t0056_u01652850841799") 2022/05/18 05:16:15 DEBUG : both2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f109ac0c30784990f_d20220518_m051533_c001_v0001044_t0001_u01652850933384") 2022/05/18 05:16:15 DEBUG : both2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b616f_d20220518_m051435_c001_v0001100_t0012_u01652850875454") 2022/05/18 05:16:15 DEBUG : both2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f108d9f08c38a601c_d20220518_m051421_c001_v0001041_t0052_u01652850861361") 2022/05/18 05:16:15 DEBUG : both2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1d8c_d20220518_m051326_c001_v0001128_t0030_u01652850806486") 2022/05/18 05:16:15 DEBUG : both3: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f114b98ada2880648_d20220518_m051534_c001_v0001098_t0032_u01652850934303") 2022/05/18 05:16:15 DEBUG : both3: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1e87_d20220518_m051437_c001_v0001128_t0019_u01652850877099") 2022/05/18 05:16:15 DEBUG : both3: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1103ca40e6c92636_d20220518_m051422_c001_v0001165_t0018_u01652850862007") 2022/05/18 05:16:15 DEBUG : both3: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1fdbf_d20220518_m051327_c001_v0001117_t0024_u01652850807801") 2022/05/18 05:16:15 DEBUG : both4: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f114a50bad4e07e82_d20220518_m051534_c001_v0001115_t0050_u01652850934710") 2022/05/18 05:16:15 DEBUG : both4: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa20011_d20220518_m051439_c001_v0001117_t0030_u01652850879045") 2022/05/18 05:16:15 DEBUG : both4: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112ea2091fdfb3ec_d20220518_m051422_c001_v0001099_t0018_u01652850862386") 2022/05/18 05:16:15 DEBUG : both4: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b5e7d_d20220518_m051331_c001_v0001100_t0031_u01652850811353") 2022/05/18 05:16:15 DEBUG : both5: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117df42e377612a0_d20220518_m051538_c001_v0001165_t0030_u01652850938303") 2022/05/18 05:16:15 DEBUG : both5: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b61ae_d20220518_m051440_c001_v0001100_t0059_u01652850880321") 2022/05/18 05:16:16 DEBUG : both5: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1184eecc3fe3d874_d20220518_m051423_c001_v0001165_t0015_u01652850863301") 2022/05/18 05:16:16 DEBUG : both5: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1db2_d20220518_m051333_c001_v0001128_t0056_u01652850813821") 2022/05/18 05:16:16 DEBUG : both6: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f107e9b54cb9575d3_d20220518_m051538_c001_v0001109_t0040_u01652850938593") 2022/05/18 05:16:16 DEBUG : both6: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1e9f_d20220518_m051444_c001_v0001128_t0000_u01652850884826") 2022/05/18 05:16:16 DEBUG : both6: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f111b774682a775b0_d20220518_m051423_c001_v0001120_t0036_u01652850863570") 2022/05/18 05:16:16 DEBUG : both6: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1fe0b_d20220518_m051335_c001_v0001117_t0021_u01652850815350") 2022/05/18 05:16:16 DEBUG : both7: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1086378c18a8b8a3_d20220518_m051539_c001_v0001097_t0046_u01652850939951") 2022/05/18 05:16:16 DEBUG : both7: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa2004c_d20220518_m051445_c001_v0001117_t0042_u01652850885708") 2022/05/18 05:16:16 DEBUG : both7: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f116b9acba744af09_d20220518_m051424_c001_v0001109_t0051_u01652850864694") 2022/05/18 05:16:16 DEBUG : both7: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b5ec2_d20220518_m051338_c001_v0001100_t0037_u01652850818678") 2022/05/18 05:16:16 DEBUG : both8: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f113fa0263781b5ff_d20220518_m051541_c001_v0001130_t0031_u01652850941802") 2022/05/18 05:16:16 DEBUG : both8: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b620e_d20220518_m051447_c001_v0001100_t0055_u01652850887229") 2022/05/18 05:16:16 DEBUG : both8: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1185d34e89199075_d20220518_m051428_c001_v0001106_t0048_u01652850868048") 2022/05/18 05:16:16 DEBUG : both8: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1dcd_d20220518_m051341_c001_v0001128_t0036_u01652850821545") 2022/05/18 05:16:16 DEBUG : both9: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1137e37623c6f54d_d20220518_m051542_c001_v0001103_t0024_u01652850942330") 2022/05/18 05:16:16 DEBUG : both9: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1eaf_d20220518_m051450_c001_v0001128_t0009_u01652850890135") 2022/05/18 05:16:17 DEBUG : both9: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f11295ecc12bb3142_d20220518_m051429_c001_v0001130_t0040_u01652850869297") 2022/05/18 05:16:17 DEBUG : both9: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1fe36_d20220518_m051342_c001_v0001117_t0016_u01652850822394") 2022/05/18 05:16:17 DEBUG : c/non empty space: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1157561407fc75ac_d20220518_m050632_c001_v0001103_t0020_u01652850392215") 2022/05/18 05:16:17 DEBUG : c/non empty space: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b26968d_d20220518_m050628_c001_v0001150_t0021_u01652850388382") 2022/05/18 05:16:17 DEBUG : c/non empty space: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106e49029b979abe_d20220518_m050626_c001_v0001161_t0053_u01652850386604") 2022/05/18 05:16:17 DEBUG : c/non empty space: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b269664_d20220518_m050619_c001_v0001150_t0014_u01652850379058") 2022/05/18 05:16:17 DEBUG : c/non empty space: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f102dd3d476d9a130_d20220518_m050546_c001_v0001104_t0007_u01652850346512") 2022/05/18 05:16:17 DEBUG : c/non empty space: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b2695cb_d20220518_m050543_c001_v0001150_t0041_u01652850343218") 2022/05/18 05:16:17 DEBUG : check sum: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f109d3dd706cbe432_d20220518_m050529_c001_v0001099_t0028_u01652850329318") 2022/05/18 05:16:17 DEBUG : check sum: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b26957d_d20220518_m050528_c001_v0001150_t0034_u01652850328186") 2022/05/18 05:16:17 DEBUG : dest/3: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1123e3855c330647_d20220518_m050952_c001_v0001150_t0008_u01652850592747") 2022/05/18 05:16:17 DEBUG : dest/3: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f109f2efeff27a243_d20220518_m050951_c001_v0001098_t0028_u01652850591344") 2022/05/18 05:16:17 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f115299982ab8deb9_d20220518_m051303_c001_v0001136_t0021_u01652850783819") 2022/05/18 05:16:17 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f11177f5b99dcf7e7_d20220518_m051300_c001_v0001099_t0047_u01652850780489") 2022/05/18 05:16:17 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f109e7cfaaacf4a50_d20220518_m051259_c001_v0001040_t0022_u01652850779862") 2022/05/18 05:16:17 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f11177f5b99dcf7a0_d20220518_m051253_c001_v0001099_t0005_u01652850773630") 2022/05/18 05:16:18 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1116a18c7a3b0f47_d20220518_m051252_c001_v0001106_t0025_u01652850772357") 2022/05/18 05:16:18 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b5c27_d20220518_m051243_c001_v0001100_t0036_u01652850763818") 2022/05/18 05:16:18 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1112a25cb4cc7703_d20220518_m051240_c001_v0001101_t0008_u01652850760834") 2022/05/18 05:16:18 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bea3d2a81a40a_d20220518_m051237_c001_v0001106_t0026_u01652850757104") 2022/05/18 05:16:18 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1128fdc33ec67554_d20220518_m051235_c001_v0001115_t0032_u01652850755718") 2022/05/18 05:16:18 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bea3d2a81a379_d20220518_m051227_c001_v0001106_t0002_u01652850747645") 2022/05/18 05:16:18 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f10233f67e7c2e1d7_d20220518_m051226_c001_v0001161_t0058_u01652850746423") 2022/05/18 05:16:18 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b5af8_d20220518_m051220_c001_v0001100_t0013_u01652850740372") 2022/05/18 05:16:18 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f10255df0ed2c63b9_d20220518_m051217_c001_v0001144_t0059_u01652850737750") 2022/05/18 05:16:18 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f109f4fca9dce8c5e_d20220518_m051214_c001_v0001092_t0023_u01652850734036") 2022/05/18 05:16:18 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1012c4a36d8ffec9_d20220518_m051213_c001_v0001130_t0017_u01652850733152") 2022/05/18 05:16:18 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f109f4fca9dce8c43_d20220518_m051203_c001_v0001092_t0039_u01652850723035") 2022/05/18 05:16:18 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f11039282e405c47c_d20220518_m051201_c001_v0001101_t0030_u01652850721936") 2022/05/18 05:16:18 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1c73_d20220518_m051155_c001_v0001128_t0044_u01652850715864") 2022/05/18 05:16:18 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1185d34e8919877c_d20220518_m051153_c001_v0001106_t0025_u01652850713412") 2022/05/18 05:16:18 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bea3d2a81a090_d20220518_m051145_c001_v0001106_t0025_u01652850705874") 2022/05/18 05:16:19 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f10007dc63152b78f_d20220518_m051144_c001_v0001109_t0001_u01652850704340") 2022/05/18 05:16:19 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bea3d2a819fe2_d20220518_m051137_c001_v0001106_t0007_u01652850697713") 2022/05/18 05:16:19 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f119b453898acae05_d20220518_m051136_c001_v0001092_t0014_u01652850696811") 2022/05/18 05:16:19 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1f9dc_d20220518_m051129_c001_v0001117_t0013_u01652850689425") 2022/05/18 05:16:19 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f102c0fb30f929431_d20220518_m051125_c001_v0001097_t0009_u01652850685113") 2022/05/18 05:16:19 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1051e0cc89ceddcf_d20220518_m051119_c001_v0001103_t0000_u01652850679211") 2022/05/18 05:16:19 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f100cefb3ee30e886_d20220518_m051118_c001_v0001038_t0055_u01652850678365") 2022/05/18 05:16:19 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1051e0cc89cedc6f_d20220518_m051059_c001_v0001103_t0028_u01652850659407") 2022/05/18 05:16:19 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f11550fda2fe3e704_d20220518_m051058_c001_v0001165_t0056_u01652850658589") 2022/05/18 05:16:19 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b5663_d20220518_m051050_c001_v0001100_t0058_u01652850650374") 2022/05/18 05:16:19 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f101ccc2cea591ab2_d20220518_m051048_c001_v0001144_t0005_u01652850648339") 2022/05/18 05:16:19 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f10233f67e7c2dc4f_d20220518_m051039_c001_v0001161_t0043_u01652850639453") 2022/05/18 05:16:19 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1103ca40e6c91856_d20220518_m051039_c001_v0001165_t0032_u01652850639186") 2022/05/18 05:16:19 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f10233f67e7c2dc0e_d20220518_m051034_c001_v0001161_t0008_u01652850634073") 2022/05/18 05:16:19 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1152c6c230671788_d20220518_m051032_c001_v0001113_t0007_u01652850632699") 2022/05/18 05:16:19 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1b65_d20220518_m051026_c001_v0001128_t0020_u01652850626189") 2022/05/18 05:16:19 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f115dc29604f1b87e_d20220518_m051022_c001_v0001144_t0052_u01652850622909") 2022/05/18 05:16:19 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f115566ddf11568f5_d20220518_m051009_c001_v0001117_t0030_u01652850609203") 2022/05/18 05:16:20 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1085040da3b62944_d20220518_m051008_c001_v0001165_t0025_u01652850608557") 2022/05/18 05:16:20 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1f6c3_d20220518_m051001_c001_v0001117_t0007_u01652850601008") 2022/05/18 05:16:20 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f10262ddf5146b098_d20220518_m050959_c001_v0001116_t0012_u01652850599613") 2022/05/18 05:16:20 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f10262ddf5146b086_d20220518_m050957_c001_v0001116_t0011_u01652850597293") 2022/05/18 05:16:20 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1144f35d85cde48f_d20220518_m050941_c001_v0001044_t0055_u01652850581343") 2022/05/18 05:16:20 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1ac9_d20220518_m050931_c001_v0001128_t0010_u01652850571850") 2022/05/18 05:16:20 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1137f66d6c19a093_d20220518_m050929_c001_v0001115_t0055_u01652850569821") 2022/05/18 05:16:20 DEBUG : dst/one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1137f66d6c19a072_d20220518_m050928_c001_v0001115_t0005_u01652850568068") 2022/05/18 05:16:20 DEBUG : dst/one-2019-01-01: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f101ccc2cea591f5f_d20220518_m051304_c001_v0001144_t0006_u01652850784263") 2022/05/18 05:16:20 DEBUG : dst/one-2019-01-01: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f10002e526ebb1515_d20220518_m051259_c001_v0001161_t0054_u01652850779065") 2022/05/18 05:16:20 DEBUG : dst/one-2019-01-01: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f111f8c5ad821c7d1_d20220518_m051251_c001_v0001130_t0013_u01652850771935") 2022/05/18 05:16:20 DEBUG : dst/one.bak: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f107c80e361f1f0c4_d20220518_m051241_c001_v0001154_t0021_u01652850761364") 2022/05/18 05:16:20 DEBUG : dst/one.bak: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f103040b6cf506616_d20220518_m051233_c001_v0001102_t0055_u01652850753345") 2022/05/18 05:16:20 DEBUG : dst/one.bak: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1012c4a36d8ffeef_d20220518_m051225_c001_v0001130_t0014_u01652850745855") 2022/05/18 05:16:20 DEBUG : dst/one.bak: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f110e2bbae14cf767_d20220518_m051218_c001_v0001136_t0053_u01652850738499") 2022/05/18 05:16:20 DEBUG : dst/one.bak: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1162d6157f074ef2_d20220518_m051211_c001_v0001157_t0023_u01652850731438") 2022/05/18 05:16:21 DEBUG : dst/one.bak: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f109371f11f66bbe4_d20220518_m051201_c001_v0001157_t0032_u01652850721465") 2022/05/18 05:16:21 DEBUG : dst/three: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f108951d402b295c0_d20220518_m051023_c001_v0001099_t0026_u01652850623966") 2022/05/18 05:16:21 DEBUG : dst/three: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f10262ddf5146b133_d20220518_m051017_c001_v0001116_t0044_u01652850616333") 2022/05/18 05:16:21 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f111722ff926de4df_d20220518_m051305_c001_v0001100_t0057_u01652850785023") 2022/05/18 05:16:21 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f111c7d1640f5c47b_d20220518_m051301_c001_v0001102_t0017_u01652850781532") 2022/05/18 05:16:21 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f11521f7777441c67_d20220518_m051254_c001_v0001161_t0042_u01652850774770") 2022/05/18 05:16:21 DEBUG : dst/three.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1128fdc33ec676f1_d20220518_m051306_c001_v0001115_t0034_u01652850786407") 2022/05/18 05:16:21 DEBUG : dst/three.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f11177f5b99dcf805_d20220518_m051303_c001_v0001099_t0052_u01652850783006") 2022/05/18 05:16:21 DEBUG : dst/three.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f102f3a0b0d1693c7_d20220518_m051302_c001_v0001037_t0010_u01652850782396") 2022/05/18 05:16:21 DEBUG : dst/three.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f11177f5b99dcf7b6_d20220518_m051255_c001_v0001099_t0044_u01652850775777") 2022/05/18 05:16:21 DEBUG : dst/three.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f109e7cfaaacf4a4b_d20220518_m051255_c001_v0001040_t0007_u01652850775194") 2022/05/18 05:16:21 DEBUG : dst/three.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1d17_d20220518_m051248_c001_v0001128_t0025_u01652850768732") 2022/05/18 05:16:21 DEBUG : dst/three.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1051e0cc89cee34c_d20220518_m051241_c001_v0001103_t0051_u01652850761637") 2022/05/18 05:16:21 DEBUG : dst/three.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bea3d2a81a434_d20220518_m051239_c001_v0001106_t0039_u01652850759539") 2022/05/18 05:16:21 DEBUG : dst/three.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f119c52b4e7e707d2_d20220518_m051239_c001_v0001157_t0035_u01652850759074") 2022/05/18 05:16:21 DEBUG : dst/three.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bea3d2a81a3ae_d20220518_m051230_c001_v0001106_t0056_u01652850750661") 2022/05/18 05:16:22 DEBUG : dst/three.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f100bc3e4a0dc7862_d20220518_m051229_c001_v0001106_t0042_u01652850749723") 2022/05/18 05:16:22 DEBUG : dst/three.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1cc4_d20220518_m051223_c001_v0001128_t0019_u01652850743040") 2022/05/18 05:16:22 DEBUG : dst/three.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f119b6de02cd88762_d20220518_m051215_c001_v0001101_t0032_u01652850735617") 2022/05/18 05:16:22 DEBUG : dst/three.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1c9a_d20220518_m051209_c001_v0001128_t0008_u01652850729889") 2022/05/18 05:16:22 DEBUG : dst/three.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f10335a4ca58b8519_d20220518_m051208_c001_v0001120_t0011_u01652850728279") 2022/05/18 05:16:22 DEBUG : dst/three.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1fb01_d20220518_m051158_c001_v0001117_t0019_u01652850718001") 2022/05/18 05:16:22 DEBUG : dst/three.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1185d34e8919872c_d20220518_m051149_c001_v0001106_t0049_u01652850709016") 2022/05/18 05:16:22 DEBUG : dst/three.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1fa42_d20220518_m051141_c001_v0001117_t0003_u01652850701640") 2022/05/18 05:16:22 DEBUG : dst/three.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1162d6157f074def_d20220518_m051140_c001_v0001157_t0037_u01652850700600") 2022/05/18 05:16:22 DEBUG : dst/three.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b5891_d20220518_m051131_c001_v0001100_t0016_u01652850691581") 2022/05/18 05:16:22 DEBUG : dst/three.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1126a5172aff50c5_d20220518_m051122_c001_v0001098_t0011_u01652850682095") 2022/05/18 05:16:22 DEBUG : dst/three.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b57a7_d20220518_m051115_c001_v0001100_t0028_u01652850675624") 2022/05/18 05:16:22 DEBUG : dst/three.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112f8989b3d01b70_d20220518_m051110_c001_v0001106_t0000_u01652850670973") 2022/05/18 05:16:22 DEBUG : dst/three.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1ba9_d20220518_m051053_c001_v0001128_t0006_u01652850653349") 2022/05/18 05:16:22 DEBUG : dst/three.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f101a59f8b1694781_d20220518_m051041_c001_v0001109_t0045_u01652850641932") 2022/05/18 05:16:22 DEBUG : dst/three.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1b7e_d20220518_m051037_c001_v0001128_t0024_u01652850637358") 2022/05/18 05:16:23 DEBUG : dst/three.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1199b53a803078c4_d20220518_m051035_c001_v0001117_t0001_u01652850635856") 2022/05/18 05:16:23 DEBUG : dst/three.txt: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1f7be_d20220518_m051028_c001_v0001117_t0019_u01652850628022") 2022/05/18 05:16:23 DEBUG : dst/three.txt.bak: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1023cc6bdcb56d9a_d20220518_m051242_c001_v0001105_t0007_u01652850762077") 2022/05/18 05:16:23 DEBUG : dst/three.txt.bak: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1128c52ca6d929ba_d20220518_m051238_c001_v0001102_t0007_u01652850758640") 2022/05/18 05:16:23 DEBUG : dst/three.txt.bak: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1157e6bc4d226e4d_d20220518_m051229_c001_v0001098_t0033_u01652850749174") 2022/05/18 05:16:23 DEBUG : dst/three.txt.bak: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1044866a3c842dbf_d20220518_m051219_c001_v0001103_t0034_u01652850739031") 2022/05/18 05:16:23 DEBUG : dst/three.txt.bak: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f119302611df9a03e_d20220518_m051215_c001_v0001019_t0030_u01652850735025") 2022/05/18 05:16:23 DEBUG : dst/three.txt.bak: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f110881e322e4ceee_d20220518_m051203_c001_v0001106_t0032_u01652850723922") 2022/05/18 05:16:23 DEBUG : dst/two: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112913e6163bd154_d20220518_m051307_c001_v0001103_t0043_u01652850787934") 2022/05/18 05:16:23 DEBUG : dst/two: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1fc7d_d20220518_m051244_c001_v0001117_t0029_u01652850764548") 2022/05/18 05:16:23 DEBUG : dst/two: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f116fb6dc93d3605c_d20220518_m051242_c001_v0001102_t0031_u01652850762567") 2022/05/18 05:16:23 DEBUG : dst/two: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1fbc3_d20220518_m051221_c001_v0001117_t0054_u01652850741632") 2022/05/18 05:16:23 DEBUG : dst/two: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f118066d99177c8be_d20220518_m051219_c001_v0001098_t0056_u01652850739516") 2022/05/18 05:16:23 DEBUG : dst/two: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b59e1_d20220518_m051157_c001_v0001100_t0038_u01652850717021") 2022/05/18 05:16:23 DEBUG : dst/two: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106ec315144a6627_d20220518_m051154_c001_v0001101_t0002_u01652850714880") 2022/05/18 05:16:23 DEBUG : dst/two: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1c2a_d20220518_m051130_c001_v0001128_t0025_u01652850690630") 2022/05/18 05:16:24 DEBUG : dst/two: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f111bc16a04bde311_d20220518_m051125_c001_v0001097_t0007_u01652850685786") 2022/05/18 05:16:24 DEBUG : dst/two: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1f870_d20220518_m051051_c001_v0001117_t0004_u01652850651201") 2022/05/18 05:16:24 DEBUG : dst/two: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1132aa24b72aa4d4_d20220518_m051049_c001_v0001099_t0042_u01652850649363") 2022/05/18 05:16:24 DEBUG : dst/two: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b5531_d20220518_m051027_c001_v0001100_t0033_u01652850627197") 2022/05/18 05:16:24 DEBUG : dst/two: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f105568352a50fea2_d20220518_m051024_c001_v0001099_t0023_u01652850624840") 2022/05/18 05:16:24 DEBUG : dst/two: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106298d7219baceb_d20220518_m051012_c001_v0001022_t0051_u01652850612379") 2022/05/18 05:16:24 DEBUG : dst/two: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f11002598f92f5291_d20220518_m050944_c001_v0001100_t0019_u01652850584228") 2022/05/18 05:16:24 DEBUG : dst/two: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1137f66d6c19a10d_d20220518_m050938_c001_v0001115_t0021_u01652850578247") 2022/05/18 05:16:24 DEBUG : empty space: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f107e9b54cb955f4a_d20220518_m050905_c001_v0001109_t0004_u01652850545966") 2022/05/18 05:16:24 DEBUG : empty space: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1a61_d20220518_m050859_c001_v0001128_t0024_u01652850539634") 2022/05/18 05:16:24 DEBUG : empty space: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f109d4ffc45640367_d20220518_m050849_c001_v0001101_t0015_u01652850529538") 2022/05/18 05:16:24 DEBUG : empty space: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1a14_d20220518_m050835_c001_v0001128_t0037_u01652850515363") 2022/05/18 05:16:24 DEBUG : empty space: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f109d3dd706cbeda3_d20220518_m050820_c001_v0001099_t0050_u01652850500872") 2022/05/18 05:16:24 DEBUG : empty space: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf19df_d20220518_m050816_c001_v0001128_t0033_u01652850496400") 2022/05/18 05:16:24 DEBUG : empty space: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1085a01d28c90834_d20220518_m050655_c001_v0001161_t0031_u01652850415545") 2022/05/18 05:16:24 DEBUG : empty space: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b2696f0_d20220518_m050650_c001_v0001150_t0034_u01652850410881") 2022/05/18 05:16:24 DEBUG : empty space: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f113e5893520ae7a7_d20220518_m050648_c001_v0001009_t0013_u01652850408494") 2022/05/18 05:16:25 DEBUG : empty space: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b2696e0_d20220518_m050647_c001_v0001150_t0049_u01652850407300") 2022/05/18 05:16:25 DEBUG : empty space: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1172e1ce28574015_d20220518_m050641_c001_v0001097_t0055_u01652850401362") 2022/05/18 05:16:25 DEBUG : empty space: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b2696bf_d20220518_m050638_c001_v0001150_t0034_u01652850398810") 2022/05/18 05:16:25 DEBUG : empty space: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1056cbaabf420b08_d20220518_m050635_c001_v0001100_t0017_u01652850395773") 2022/05/18 05:16:25 DEBUG : empty space: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b2696a7_d20220518_m050633_c001_v0001150_t0037_u01652850393521") 2022/05/18 05:16:25 DEBUG : empty space: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f10459d4575d3ad67_d20220518_m050612_c001_v0001117_t0016_u01652850372101") 2022/05/18 05:16:25 DEBUG : empty space: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b269641_d20220518_m050609_c001_v0001150_t0042_u01652850369881") 2022/05/18 05:16:25 DEBUG : empty space: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1053cf753809dbde_d20220518_m050608_c001_v0001101_t0025_u01652850368021") 2022/05/18 05:16:25 DEBUG : empty space: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b269639_d20220518_m050607_c001_v0001150_t0009_u01652850367012") 2022/05/18 05:16:25 DEBUG : empty space: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f100cdc0f680d4e07_d20220518_m050558_c001_v0001101_t0046_u01652850358134") 2022/05/18 05:16:25 DEBUG : empty space: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b269603_d20220518_m050556_c001_v0001150_t0022_u01652850356676") 2022/05/18 05:16:25 DEBUG : empty space: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1157561407fc72eb_d20220518_m050553_c001_v0001103_t0057_u01652850353126") 2022/05/18 05:16:25 DEBUG : empty space: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b2695f5_d20220518_m050552_c001_v0001150_t0028_u01652850352060") 2022/05/18 05:16:25 DEBUG : empty space: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f10251dccc3e7dba1_d20220518_m050551_c001_v0001018_t0005_u01652850351019") 2022/05/18 05:16:25 DEBUG : empty space: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f102bff864d8923be_d20220518_m050549_c001_v0001106_t0014_u01652850349399") 2022/05/18 05:16:25 DEBUG : empty space: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b2695e5_d20220518_m050547_c001_v0001150_t0018_u01652850347697") 2022/05/18 05:16:25 DEBUG : enormous: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f10769a431d26d0c5_d20220518_m050651_c001_v0001104_t0016_u01652850411962") 2022/05/18 05:16:25 DEBUG : enormous: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b2696f6_d20220518_m050651_c001_v0001150_t0042_u01652850411178") 2022/05/18 05:16:26 DEBUG : existing: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106ec315144a6aa0_d20220518_m051316_c001_v0001101_t0004_u01652850796563") 2022/05/18 05:16:26 DEBUG : existing: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1d60_d20220518_m051315_c001_v0001128_t0020_u01652850795209") 2022/05/18 05:16:26 DEBUG : existing: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f111c7d1640f5b2e1_d20220518_m050811_c001_v0001102_t0020_u01652850491584") 2022/05/18 05:16:26 DEBUG : existing: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b4ea9_d20220518_m050809_c001_v0001100_t0041_u01652850489853") 2022/05/18 05:16:26 DEBUG : existing: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1097c5b010bbaae7_d20220518_m050541_c001_v0001115_t0002_u01652850341356") 2022/05/18 05:16:26 DEBUG : existing: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b2695b5_d20220518_m050540_c001_v0001150_t0023_u01652850339904") 2022/05/18 05:16:26 DEBUG : existing: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f11469250bb3c8cf3_d20220518_m050538_c001_v0001105_t0051_u01652850338441") 2022/05/18 05:16:26 DEBUG : existing: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b2695a8_d20220518_m050537_c001_v0001150_t0045_u01652850337700") 2022/05/18 05:16:26 DEBUG : existing: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b26959c_d20220518_m050536_c001_v0001150_t0000_u01652850336552") 2022/05/18 05:16:26 DEBUG : existing-b: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1115a032b2f08b9d_d20220518_m050812_c001_v0001117_t0010_u01652850492022") 2022/05/18 05:16:26 DEBUG : existing-b: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf19cf_d20220518_m050809_c001_v0001128_t0053_u01652850489553") 2022/05/18 05:16:26 DEBUG : five: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1063cd346c13a77b_d20220518_m050705_c001_v0001099_t0011_u01652850425119") 2022/05/18 05:16:26 DEBUG : five: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b4bf5_d20220518_m050701_c001_v0001100_t0001_u01652850421574") 2022/05/18 05:16:26 DEBUG : foo: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1069dc753ba96a29_d20220518_m050555_c001_v0001040_t0001_u01652850355789") 2022/05/18 05:16:26 DEBUG : foo: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b2695ff_d20220518_m050555_c001_v0001150_t0050_u01652850355046") 2022/05/18 05:16:26 DEBUG : foo: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b2695fd_d20220518_m050554_c001_v0001150_t0007_u01652850354165") 2022/05/18 05:16:27 DEBUG : four: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1137f66d6c1997ee_d20220518_m050705_c001_v0001115_t0017_u01652850425738") 2022/05/18 05:16:27 DEBUG : four: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf18fc_d20220518_m050702_c001_v0001128_t0041_u01652850422098") 2022/05/18 05:16:27 DEBUG : four: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b4be7_d20220518_m050700_c001_v0001100_t0020_u01652850420660") 2022/05/18 05:16:27 DEBUG : hello world2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1092a7949933ee45_d20220518_m050458_c001_v0001106_t0055_u01652850298716") 2022/05/18 05:16:27 DEBUG : hello world2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b2694e8_d20220518_m050457_c001_v0001150_t0006_u01652850297956") 2022/05/18 05:16:27 DEBUG : ignore-size: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f102c93ebcabfc80c_d20220518_m050535_c001_v0001115_t0039_u01652850335114") 2022/05/18 05:16:27 DEBUG : ignore-size: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b269595_d20220518_m050534_c001_v0001150_t0028_u01652850334041") 2022/05/18 05:16:27 DEBUG : nested/sub dir/file: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f114a0280a44d25f0_d20220518_m050807_c001_v0001103_t0026_u01652850487907") 2022/05/18 05:16:27 DEBUG : nested/sub dir/file: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf19bd_d20220518_m050805_c001_v0001128_t0038_u01652850485967") 2022/05/18 05:16:27 DEBUG : nested/sub dir/file: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f11410743cde02624_d20220518_m050803_c001_v0001116_t0045_u01652850483753") 2022/05/18 05:16:27 DEBUG : nested/sub dir/file: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf19ac_d20220518_m050802_c001_v0001128_t0026_u01652850482270") 2022/05/18 05:16:27 DEBUG : one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117026e4bb508e35_d20220518_m050706_c001_v0001102_t0002_u01652850426976") 2022/05/18 05:16:27 DEBUG : one: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b4bd4_d20220518_m050659_c001_v0001100_t0047_u01652850419068") 2022/05/18 05:16:27 DEBUG : only0: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f102b983d176c3a8d_d20220518_m051545_c001_v0001099_t0056_u01652850945786") 2022/05/18 05:16:27 DEBUG : only0: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b636b_d20220518_m051517_c001_v0001100_t0043_u01652850917507") 2022/05/18 05:16:27 DEBUG : only0: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b6148_d20220518_m051430_c001_v0001100_t0049_u01652850870980") 2022/05/18 05:16:28 DEBUG : only0: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f115cb328b454fb50_d20220518_m051408_c001_v0001120_t0043_u01652850848753") 2022/05/18 05:16:28 DEBUG : only0: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1d7e_d20220518_m051323_c001_v0001128_t0046_u01652850803843") 2022/05/18 05:16:28 DEBUG : only1: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f110ecb6f60513621_d20220518_m051547_c001_v0001105_t0015_u01652850947413") 2022/05/18 05:16:28 DEBUG : only1: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1143f8df7d263907_d20220518_m051518_c001_v0001100_t0025_u01652850918062") 2022/05/18 05:16:28 DEBUG : only1: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1e7e_d20220518_m051435_c001_v0001128_t0000_u01652850875109") 2022/05/18 05:16:28 DEBUG : only1: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1056a8506f30b249_d20220518_m051407_c001_v0001161_t0016_u01652850847632") 2022/05/18 05:16:28 DEBUG : only1: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1fda9_d20220518_m051325_c001_v0001117_t0036_u01652850805062") 2022/05/18 05:16:28 DEBUG : only10: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f10520b7f0bb3c245_d20220518_m051548_c001_v0001117_t0034_u01652850948344") 2022/05/18 05:16:28 DEBUG : only10: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa201bd_d20220518_m051517_c001_v0001117_t0023_u01652850917518") 2022/05/18 05:16:28 DEBUG : only10: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1ebb_d20220518_m051452_c001_v0001128_t0002_u01652850892992") 2022/05/18 05:16:28 DEBUG : only10: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f11728e74fd27d0fe_d20220518_m051406_c001_v0001012_t0014_u01652850846260") 2022/05/18 05:16:28 DEBUG : only10: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1fe4a_d20220518_m051344_c001_v0001117_t0014_u01652850824570") 2022/05/18 05:16:28 DEBUG : only11: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f102a30b47eefc4d0_d20220518_m051549_c001_v0001102_t0002_u01652850949253") 2022/05/18 05:16:28 DEBUG : only11: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1f10_d20220518_m051517_c001_v0001128_t0037_u01652850917529") 2022/05/18 05:16:29 DEBUG : only11: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa200bf_d20220518_m051453_c001_v0001117_t0056_u01652850893948") 2022/05/18 05:16:29 DEBUG : only11: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f108ea066dc272673_d20220518_m051409_c001_v0001098_t0035_u01652850849824") 2022/05/18 05:16:29 DEBUG : only11: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b5f1d_d20220518_m051347_c001_v0001100_t0057_u01652850827411") 2022/05/18 05:16:29 DEBUG : only12: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f101385fef95965b1_d20220518_m051549_c001_v0001134_t0057_u01652850949699") 2022/05/18 05:16:29 DEBUG : only12: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1f14_d20220518_m051518_c001_v0001128_t0058_u01652850918044") 2022/05/18 05:16:29 DEBUG : only12: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b6284_d20220518_m051457_c001_v0001100_t0009_u01652850897594") 2022/05/18 05:16:29 DEBUG : only12: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f11274187a068fa13_d20220518_m051406_c001_v0001109_t0051_u01652850846431") 2022/05/18 05:16:29 DEBUG : only12: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1de1_d20220518_m051349_c001_v0001128_t0033_u01652850829715") 2022/05/18 05:16:29 DEBUG : only13: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117d40fedf6b7990_d20220518_m051550_c001_v0001115_t0009_u01652850950075") 2022/05/18 05:16:30 DEBUG : only13: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b6375_d20220518_m051518_c001_v0001100_t0018_u01652850918061") 2022/05/18 05:16:30 DEBUG : only13: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1ecb_d20220518_m051459_c001_v0001128_t0056_u01652850899431") 2022/05/18 05:16:30 DEBUG : only13: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f10255df0ed2c66de_d20220518_m051407_c001_v0001144_t0015_u01652850847958") 2022/05/18 05:16:30 DEBUG : only13: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1fe79_d20220518_m051350_c001_v0001117_t0044_u01652850830679") 2022/05/18 05:16:30 DEBUG : only14: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f11410743cde032fe_d20220518_m051551_c001_v0001116_t0017_u01652850951455") 2022/05/18 05:16:30 DEBUG : only14: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b63a7_d20220518_m051520_c001_v0001100_t0058_u01652850920094") 2022/05/18 05:16:30 DEBUG : only14: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa200fe_d20220518_m051500_c001_v0001117_t0014_u01652850900861") 2022/05/18 05:16:30 DEBUG : only14: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1006e3cc537fbacf_d20220518_m051408_c001_v0001030_t0007_u01652850848777") 2022/05/18 05:16:31 DEBUG : only14: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b5f5d_d20220518_m051352_c001_v0001100_t0049_u01652850832240") 2022/05/18 05:16:31 DEBUG : only15: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1131ecc613145a78_d20220518_m051552_c001_v0001104_t0049_u01652850952957") 2022/05/18 05:16:31 DEBUG : only15: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1f18_d20220518_m051518_c001_v0001128_t0042_u01652850918625") 2022/05/18 05:16:31 DEBUG : only15: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b62cb_d20220518_m051503_c001_v0001100_t0020_u01652850903994") 2022/05/18 05:16:31 DEBUG : only15: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1051e0cc89cee9a0_d20220518_m051406_c001_v0001103_t0003_u01652850846521") 2022/05/18 05:16:31 DEBUG : only15: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1df0_d20220518_m051354_c001_v0001128_t0020_u01652850834037") 2022/05/18 05:16:31 DEBUG : only16: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1092a79499341aa3_d20220518_m051553_c001_v0001106_t0011_u01652850953812") 2022/05/18 05:16:31 DEBUG : only16: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b6385_d20220518_m051518_c001_v0001100_t0028_u01652850918720") 2022/05/18 05:16:31 DEBUG : only16: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1ee4_d20220518_m051507_c001_v0001128_t0028_u01652850907541") 2022/05/18 05:16:31 DEBUG : only16: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f108951d402b29fe5_d20220518_m051408_c001_v0001099_t0057_u01652850848839") 2022/05/18 05:16:31 DEBUG : only16: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1feaa_d20220518_m051355_c001_v0001117_t0059_u01652850835533") 2022/05/18 05:16:31 DEBUG : only17: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1131ecc613145aaa_d20220518_m051555_c001_v0001104_t0017_u01652850955586") 2022/05/18 05:16:31 DEBUG : only17: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1143f8df7d263915_d20220518_m051519_c001_v0001100_t0018_u01652850919047") 2022/05/18 05:16:31 DEBUG : only17: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa20154_d20220518_m051509_c001_v0001117_t0007_u01652850909504") 2022/05/18 05:16:32 DEBUG : only17: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1059c150600378d8_d20220518_m051405_c001_v0001115_t0012_u01652850845239") 2022/05/18 05:16:32 DEBUG : only17: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b5fa0_d20220518_m051357_c001_v0001100_t0020_u01652850837387") 2022/05/18 05:16:32 DEBUG : only18: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f105568352a510d95_d20220518_m051556_c001_v0001099_t0040_u01652850956491") 2022/05/18 05:16:32 DEBUG : only18: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1f1c_d20220518_m051519_c001_v0001128_t0042_u01652850919143") 2022/05/18 05:16:32 DEBUG : only18: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b6330_d20220518_m051514_c001_v0001100_t0040_u01652850914889") 2022/05/18 05:16:32 DEBUG : only18: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f11274187a068fa1a_d20220518_m051406_c001_v0001109_t0011_u01652850846972") 2022/05/18 05:16:32 DEBUG : only18: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1e0c_d20220518_m051401_c001_v0001128_t0054_u01652850841430") 2022/05/18 05:16:32 DEBUG : only19: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117b9d7916dd03de_d20220518_m051557_c001_v0001031_t0030_u01652850957638") 2022/05/18 05:16:32 DEBUG : only19: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b6393_d20220518_m051519_c001_v0001100_t0043_u01652850919152") 2022/05/18 05:16:32 DEBUG : only19: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1f0a_d20220518_m051516_c001_v0001128_t0032_u01652850916350") 2022/05/18 05:16:32 DEBUG : only19: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f118bd9edbcbeaa14_d20220518_m051409_c001_v0001097_t0054_u01652850849304") 2022/05/18 05:16:32 DEBUG : only19: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1fee1_d20220518_m051402_c001_v0001117_t0028_u01652850842208") 2022/05/18 05:16:32 DEBUG : only2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f114a50bad4e07fe0_d20220518_m051559_c001_v0001115_t0042_u01652850959501") 2022/05/18 05:16:32 DEBUG : only2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa201c9_d20220518_m051519_c001_v0001117_t0014_u01652850919443") 2022/05/18 05:16:32 DEBUG : only2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1fff6_d20220518_m051436_c001_v0001117_t0050_u01652850876248") 2022/05/18 05:16:32 DEBUG : only2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1163acbc43755b80_d20220518_m051405_c001_v0001144_t0052_u01652850845618") 2022/05/18 05:16:32 DEBUG : only2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b5e49_d20220518_m051327_c001_v0001100_t0031_u01652850807206") 2022/05/18 05:16:33 DEBUG : only3: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f108ea066dc2729b9_d20220518_m051601_c001_v0001098_t0055_u01652850961105") 2022/05/18 05:16:33 DEBUG : only3: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1143f8df7d26391d_d20220518_m051519_c001_v0001100_t0005_u01652850919575") 2022/05/18 05:16:33 DEBUG : only3: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b6189_d20220518_m051437_c001_v0001100_t0020_u01652850877500") 2022/05/18 05:16:33 DEBUG : only3: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f115e1b8bd54ef070_d20220518_m051408_c001_v0001033_t0049_u01652850848494") 2022/05/18 05:16:33 DEBUG : only3: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1da2_d20220518_m051330_c001_v0001128_t0051_u01652850810831") 2022/05/18 05:16:33 DEBUG : only4: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f115a4a143bc97ba6_d20220518_m051601_c001_v0001032_t0037_u01652850961928") 2022/05/18 05:16:33 DEBUG : only4: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1f1e_d20220518_m051519_c001_v0001128_t0051_u01652850919872") 2022/05/18 05:16:33 DEBUG : only4: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1e8f_d20220518_m051439_c001_v0001128_t0023_u01652850879941") 2022/05/18 05:16:33 DEBUG : only4: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f10623aa647f5ad2e_d20220518_m051405_c001_v0001043_t0051_u01652850845658") 2022/05/18 05:16:33 DEBUG : only4: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1fdf1_d20220518_m051332_c001_v0001117_t0046_u01652850812429") 2022/05/18 05:16:33 DEBUG : only5: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1184c2892db6c977_d20220518_m051602_c001_v0001038_t0042_u01652850962386") 2022/05/18 05:16:33 DEBUG : only5: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1f24_d20220518_m051520_c001_v0001128_t0018_u01652850920937") 2022/05/18 05:16:33 DEBUG : only5: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa20030_d20220518_m051443_c001_v0001117_t0040_u01652850882334") 2022/05/18 05:16:33 DEBUG : only5: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1117231bbd13ddf5_d20220518_m051407_c001_v0001115_t0057_u01652850847125") 2022/05/18 05:16:33 DEBUG : only5: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b5e9d_d20220518_m051334_c001_v0001100_t0002_u01652850814551") 2022/05/18 05:16:33 DEBUG : only6: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f100f0ddfc9ab39af_d20220518_m051603_c001_v0001042_t0000_u01652850963414") 2022/05/18 05:16:34 DEBUG : only6: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1143f8df7d263929_d20220518_m051520_c001_v0001100_t0048_u01652850920166") 2022/05/18 05:16:34 DEBUG : only6: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b61f1_d20220518_m051445_c001_v0001100_t0049_u01652850885200") 2022/05/18 05:16:34 DEBUG : only6: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1066e904a169cb08_d20220518_m051405_c001_v0001131_t0010_u01652850845624") 2022/05/18 05:16:34 DEBUG : only6: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1dc5_d20220518_m051338_c001_v0001128_t0019_u01652850818349") 2022/05/18 05:16:34 DEBUG : only7: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f100b895866005f33_d20220518_m051605_c001_v0001043_t0039_u01652850965138") 2022/05/18 05:16:34 DEBUG : only7: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1f22_d20220518_m051520_c001_v0001128_t0014_u01652850920398") 2022/05/18 05:16:34 DEBUG : only7: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1ea3_d20220518_m051446_c001_v0001128_t0019_u01652850886664") 2022/05/18 05:16:34 DEBUG : only7: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f105328e6d619c586_d20220518_m051407_c001_v0001109_t0041_u01652850847543") 2022/05/18 05:16:34 DEBUG : only7: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1fe24_d20220518_m051339_c001_v0001117_t0024_u01652850819432") 2022/05/18 05:16:34 DEBUG : only8: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117026e4bb50b24d_d20220518_m051606_c001_v0001102_t0031_u01652850966058") 2022/05/18 05:16:34 DEBUG : only8: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1143f8df7d263933_d20220518_m051520_c001_v0001100_t0048_u01652850920718") 2022/05/18 05:16:34 DEBUG : only8: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa2006f_d20220518_m051448_c001_v0001117_t0033_u01652850888299") 2022/05/18 05:16:34 DEBUG : only8: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1041529d3e1b18d3_d20220518_m051406_c001_v0001043_t0024_u01652850846009") 2022/05/18 05:16:34 DEBUG : only8: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b5ede_d20220518_m051341_c001_v0001100_t0014_u01652850821923") 2022/05/18 05:16:34 DEBUG : only9: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f10531890eb5d6bca_d20220518_m051606_c001_v0001106_t0028_u01652850966482") 2022/05/18 05:16:34 DEBUG : only9: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b63ad_d20220518_m051520_c001_v0001100_t0041_u01652850920728") 2022/05/18 05:16:35 DEBUG : only9: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b622f_d20220518_m051450_c001_v0001100_t0033_u01652850890908") 2022/05/18 05:16:35 DEBUG : only9: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f116a6f26961e9552_d20220518_m051409_c001_v0001145_t0049_u01652850849625") 2022/05/18 05:16:35 DEBUG : only9: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1dd5_d20220518_m051343_c001_v0001128_t0016_u01652850823447") 2022/05/18 05:16:35 DEBUG : potato: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f113a186b1d83e95e_d20220518_m050759_c001_v0001100_t0013_u01652850479068") 2022/05/18 05:16:35 DEBUG : potato: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1f261_d20220518_m050752_c001_v0001117_t0024_u01652850472753") 2022/05/18 05:16:35 DEBUG : potato: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f11410743cde025c9_d20220518_m050750_c001_v0001116_t0045_u01652850470139") 2022/05/18 05:16:35 DEBUG : potato: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b4da1_d20220518_m050743_c001_v0001100_t0030_u01652850463662") 2022/05/18 05:16:35 DEBUG : potato: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a92a82910a062_d20220518_m050740_c001_v0001031_t0007_u01652850460791") 2022/05/18 05:16:35 DEBUG : potato: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1911_d20220518_m050710_c001_v0001128_t0013_u01652850430736") 2022/05/18 05:16:35 DEBUG : potato: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106ec315144a5616_d20220518_m050645_c001_v0001101_t0004_u01652850405335") 2022/05/18 05:16:35 DEBUG : potato: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b2696d2_d20220518_m050644_c001_v0001150_t0046_u01652850404036") 2022/05/18 05:16:35 DEBUG : potato: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f114ffa489e8caa53_d20220518_m050639_c001_v0001134_t0011_u01652850399456") 2022/05/18 05:16:35 DEBUG : potato: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b2696bd_d20220518_m050638_c001_v0001150_t0056_u01652850398300") 2022/05/18 05:16:35 DEBUG : potato: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f111aad0b8c9296ae_d20220518_m050634_c001_v0001113_t0049_u01652850394287") 2022/05/18 05:16:35 DEBUG : potato: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b2696a5_d20220518_m050633_c001_v0001150_t0059_u01652850393164") 2022/05/18 05:16:35 DEBUG : potato: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f107edbb796dd7727_d20220518_m050611_c001_v0001157_t0051_u01652850371042") 2022/05/18 05:16:36 DEBUG : potato: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b26963d_d20220518_m050609_c001_v0001150_t0052_u01652850369479") 2022/05/18 05:16:36 DEBUG : potato: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1058c051713574ae_d20220518_m050609_c001_v0001165_t0052_u01652850369028") 2022/05/18 05:16:36 DEBUG : potato: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b269637_d20220518_m050606_c001_v0001150_t0005_u01652850366523") 2022/05/18 05:16:36 DEBUG : potato: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f115a64b22823d0ae_d20220518_m050603_c001_v0001106_t0001_u01652850363816") 2022/05/18 05:16:36 DEBUG : potato: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b269624_d20220518_m050603_c001_v0001150_t0043_u01652850363046") 2022/05/18 05:16:36 DEBUG : potato: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b269619_d20220518_m050602_c001_v0001150_t0006_u01652850362298") 2022/05/18 05:16:36 DEBUG : potato: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f108fb7f7f1718b05_d20220518_m050601_c001_v0001144_t0020_u01652850361313") 2022/05/18 05:16:36 DEBUG : potato: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b269610_d20220518_m050600_c001_v0001150_t0042_u01652850360565") 2022/05/18 05:16:36 DEBUG : potato: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b26960c_d20220518_m050559_c001_v0001150_t0013_u01652850359786") 2022/05/18 05:16:36 DEBUG : potato: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1126a5172aff459a_d20220518_m050558_c001_v0001098_t0039_u01652850358806") 2022/05/18 05:16:36 DEBUG : potato: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b269605_d20220518_m050557_c001_v0001150_t0039_u01652850357396") 2022/05/18 05:16:36 DEBUG : potato2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f111c7d1640f5b713_d20220518_m050922_c001_v0001102_t0051_u01652850560880") 2022/05/18 05:16:36 DEBUG : potato2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1f56b_d20220518_m050919_c001_v0001117_t0051_u01652850559809") 2022/05/18 05:16:36 DEBUG : potato2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f110317ddce3e9061_d20220518_m050908_c001_v0001113_t0024_u01652850548277") 2022/05/18 05:16:36 DEBUG : potato2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1f4ac_d20220518_m050856_c001_v0001117_t0032_u01652850536764") 2022/05/18 05:16:36 DEBUG : potato2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f110881e322e4c1bd_d20220518_m050839_c001_v0001106_t0059_u01652850519932") 2022/05/18 05:16:36 DEBUG : potato2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1f3bf_d20220518_m050833_c001_v0001117_t0045_u01652850513069") 2022/05/18 05:16:36 DEBUG : potato2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f11174cec65dd4ccd_d20220518_m050821_c001_v0001012_t0036_u01652850501913") 2022/05/18 05:16:37 DEBUG : potato2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1f330_d20220518_m050815_c001_v0001117_t0059_u01652850495260") 2022/05/18 05:16:37 DEBUG : potato2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f102a677c44685409_d20220518_m050654_c001_v0001098_t0006_u01652850412316") 2022/05/18 05:16:37 DEBUG : potato2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b2696ec_d20220518_m050650_c001_v0001150_t0058_u01652850410382") 2022/05/18 05:16:37 DEBUG : potato2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112d2c795fa58f19_d20220518_m050649_c001_v0001097_t0054_u01652850409419") 2022/05/18 05:16:37 DEBUG : potato2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b2696de_d20220518_m050646_c001_v0001150_t0048_u01652850406882") 2022/05/18 05:16:37 DEBUG : potato2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f10435c00013e6685_d20220518_m050645_c001_v0001039_t0000_u01652850405876") 2022/05/18 05:16:37 DEBUG : potato2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b2696d8_d20220518_m050644_c001_v0001150_t0013_u01652850404687") 2022/05/18 05:16:37 DEBUG : potato2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f11925f0f749ad583_d20220518_m050643_c001_v0001103_t0007_u01652850403380") 2022/05/18 05:16:37 DEBUG : potato2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b2696c6_d20220518_m050640_c001_v0001150_t0006_u01652850400596") 2022/05/18 05:16:37 DEBUG : potato2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f110e47195a7db277_d20220518_m050637_c001_v0001150_t0056_u01652850397815") 2022/05/18 05:16:37 DEBUG : potato2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b2696ab_d20220518_m050634_c001_v0001150_t0026_u01652850394292") 2022/05/18 05:16:37 DEBUG : potato2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f11274187a068dea4_d20220518_m050615_c001_v0001109_t0025_u01652850375166") 2022/05/18 05:16:37 DEBUG : potato2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b269643_d20220518_m050610_c001_v0001150_t0007_u01652850370643") 2022/05/18 05:16:37 DEBUG : potato2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1157e6bc4d225eb0_d20220518_m050506_c001_v0001098_t0012_u01652850306443") 2022/05/18 05:16:37 DEBUG : potato2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b269505_d20220518_m050505_c001_v0001150_t0055_u01652850305442") 2022/05/18 05:16:37 DEBUG : potato2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106cc344aa68e4fc_d20220518_m050501_c001_v0001109_t0013_u01652850301430") 2022/05/18 05:16:37 DEBUG : potato2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b2694f4_d20220518_m050500_c001_v0001150_t0055_u01652850300558") 2022/05/18 05:16:38 DEBUG : potato3: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1158101af5b39620_d20220518_m050907_c001_v0001101_t0044_u01652850547258") 2022/05/18 05:16:38 DEBUG : potato3: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b5134_d20220518_m050900_c001_v0001100_t0038_u01652850540554") 2022/05/18 05:16:38 DEBUG : potato3: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f114daf0e825072e1_d20220518_m050840_c001_v0001041_t0045_u01652850520906") 2022/05/18 05:16:38 DEBUG : potato3: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b4fda_d20220518_m050836_c001_v0001100_t0038_u01652850516193") 2022/05/18 05:16:38 DEBUG : potato3: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f10576fc79fcd34f6_d20220518_m050821_c001_v0001102_t0050_u01652850501804") 2022/05/18 05:16:38 DEBUG : potato3: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b4ef4_d20220518_m050817_c001_v0001100_t0003_u01652850497287") 2022/05/18 05:16:38 DEBUG : pre-dest1/1: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f105b093198c2cffb_d20220518_m050953_c001_v0001145_t0003_u01652850593075") 2022/05/18 05:16:38 DEBUG : pre-dest1/1: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1af4_d20220518_m050945_c001_v0001128_t0040_u01652850585367") 2022/05/18 05:16:38 DEBUG : pre-dest2/2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1047a3a4514ebb60_d20220518_m050954_c001_v0001017_t0007_u01652850594402") 2022/05/18 05:16:38 DEBUG : pre-dest2/2: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b5319_d20220518_m050946_c001_v0001100_t0037_u01652850586432") 2022/05/18 05:16:38 DEBUG : sizeonly: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f10753aea95d74e35_d20220518_m050532_c001_v0001102_t0031_u01652850332759") 2022/05/18 05:16:38 DEBUG : sizeonly: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b26958d_d20220518_m050531_c001_v0001150_t0013_u01652850331629") 2022/05/18 05:16:38 DEBUG : sub dir/hello world: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117918c06ad635db_d20220518_m050808_c001_v0001105_t0026_u01652850488465") 2022/05/18 05:16:38 DEBUG : sub dir/hello world: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1f2e8_d20220518_m050806_c001_v0001117_t0042_u01652850486299") 2022/05/18 05:16:38 DEBUG : sub dir/hello world: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1128fdc33ec664ff_d20220518_m050804_c001_v0001115_t0026_u01652850484632") 2022/05/18 05:16:38 DEBUG : sub dir/hello world: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b4e6a_d20220518_m050802_c001_v0001100_t0044_u01652850482268") 2022/05/18 05:16:38 DEBUG : sub dir/hello world: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f100efe22bdd45515_d20220518_m050527_c001_v0001100_t0024_u01652850327162") 2022/05/18 05:16:39 DEBUG : sub dir/hello world: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b269570_d20220518_m050525_c001_v0001150_t0018_u01652850325680") 2022/05/18 05:16:39 DEBUG : sub dir/hello world: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1056cbaabf4207c5_d20220518_m050524_c001_v0001100_t0028_u01652850324961") 2022/05/18 05:16:39 DEBUG : sub dir/hello world: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b26955f_d20220518_m050523_c001_v0001150_t0041_u01652850323883") 2022/05/18 05:16:39 DEBUG : sub dir/hello world: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1012c4a36d8ffa3a_d20220518_m050522_c001_v0001130_t0008_u01652850322995") 2022/05/18 05:16:39 DEBUG : sub dir/hello world: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b26953c_d20220518_m050515_c001_v0001150_t0058_u01652850315079") 2022/05/18 05:16:39 DEBUG : sub dir/hello world: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f119b6de02cd8735f_d20220518_m050514_c001_v0001101_t0040_u01652850314257") 2022/05/18 05:16:39 DEBUG : sub dir/hello world: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b26952c_d20220518_m050512_c001_v0001150_t0013_u01652850312964") 2022/05/18 05:16:39 DEBUG : sub dir/hello world: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1041b6555a1a18c4_d20220518_m050510_c001_v0001104_t0026_u01652850310420") 2022/05/18 05:16:39 DEBUG : sub dir/hello world: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b269518_d20220518_m050509_c001_v0001150_t0016_u01652850309643") 2022/05/18 05:16:39 DEBUG : sub dir/hello world: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112f8989b3d00500_d20220518_m050508_c001_v0001106_t0010_u01652850308269") 2022/05/18 05:16:39 DEBUG : sub dir/hello world: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b26950c_d20220518_m050507_c001_v0001150_t0028_u01652850307364") 2022/05/18 05:16:39 DEBUG : sub dir/hello world: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f10826b1147271222_d20220518_m050456_c001_v0001116_t0035_u01652850296335") 2022/05/18 05:16:39 DEBUG : sub dir/hello world: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b2694d8_d20220518_m050455_c001_v0001150_t0049_u01652850295672") 2022/05/18 05:16:39 DEBUG : sub dir/hello world: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f111abc47cab92e47_d20220518_m050454_c001_v0001039_t0026_u01652850294792") 2022/05/18 05:16:39 DEBUG : sub dir/hello world: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b2694d0_d20220518_m050453_c001_v0001150_t0000_u01652850293982") 2022/05/18 05:16:39 DEBUG : sub dir/hello world: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f11974c8811c76414_d20220518_m050452_c001_v0001106_t0008_u01652850292352") 2022/05/18 05:16:39 DEBUG : sub dir/hello world: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b2694c9_d20220518_m050451_c001_v0001150_t0030_u01652850291702") 2022/05/18 05:16:40 DEBUG : sub dir/hello world: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117799eb0e802640_d20220518_m050450_c001_v0001161_t0003_u01652850290109") 2022/05/18 05:16:40 DEBUG : sub dir/hello world: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106a907b6b2694be_d20220518_m050449_c001_v0001150_t0045_u01652850289413") 2022/05/18 05:16:40 DEBUG : sub/yam: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1004bed443338939_d20220518_m050758_c001_v0001017_t0012_u01652850478123") 2022/05/18 05:16:40 DEBUG : sub/yam: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b4dfa_d20220518_m050752_c001_v0001100_t0037_u01652850472760") 2022/05/18 05:16:40 DEBUG : three: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1187b805657b3248_d20220518_m050709_c001_v0001101_t0033_u01652850429282") 2022/05/18 05:16:40 DEBUG : three: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b4c0f_d20220518_m050703_c001_v0001100_t0011_u01652850423663") 2022/05/18 05:16:40 DEBUG : three: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b4be0_d20220518_m050700_c001_v0001100_t0027_u01652850420053") 2022/05/18 05:16:40 DEBUG : two: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f11792aad1d983a92_d20220518_m050709_c001_v0001157_t0032_u01652850429662") 2022/05/18 05:16:40 DEBUG : two: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1f0b1_d20220518_m050702_c001_v0001117_t0006_u01652850422304") 2022/05/18 05:16:40 DEBUG : two: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1084a148375b4bda_d20220518_m050659_c001_v0001100_t0009_u01652850419564") 2022/05/18 05:16:40 DEBUG : yam: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f111e981f923a03b0_d20220518_m050759_c001_v0001109_t0041_u01652850479545") 2022/05/18 05:16:40 DEBUG : yam: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f102cc32916dbd358_d20220518_m050757_c001_v0001109_t0010_u01652850477022") 2022/05/18 05:16:40 DEBUG : yam: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106fc4620935f4a0_d20220518_m050748_c001_v0001120_t0044_u01652850468899") 2022/05/18 05:16:40 DEBUG : yam: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f117bda8186cf1974_d20220518_m050743_c001_v0001128_t0020_u01652850463687") 2022/05/18 05:16:40 DEBUG : yam: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f11833ac05a900ba9_d20220518_m050739_c001_v0001120_t0053_u01652850459493") 2022/05/18 05:16:40 DEBUG : yam: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f112c9f813fa1f0fd_d20220518_m050710_c001_v0001117_t0041_u01652850430726") 2022/05/18 05:16:40 DEBUG : yaml: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f106e92a0fc82cc26_d20220518_m050750_c001_v0001117_t0000_u01652850470841") 2022/05/18 05:16:41 DEBUG : yaml: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1128c52ca6d91315_d20220518_m050745_c001_v0001102_t0058_u01652850465588") 2022/05/18 05:16:41 DEBUG : yaml: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f10753aea95d756be_d20220518_m050742_c001_v0001102_t0014_u01652850462413") 2022/05/18 05:16:41 DEBUG : yaml: Deleting (id "4_z0fb2ed3380dddb5b8f080e1b_f1091d1d2b63e54ab_d20220518_m050714_c001_v0001104_t0048_u01652850434181") "./sync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -fast-list" - Finished OK in 11m56.399191834s (try 1/5)