"./sync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -fast-list" - Starting (try 1/5) 2022/01/13 06:03:18 DEBUG : Creating backend with remote "TestB2:rclone-test-lewaley0bapivup8hexajuj9" 2022/01/13 06:03:18 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2022/01/13 06:03:18 DEBUG : Creating backend with remote "/tmp/rclone1601322039" === RUN TestPipe --- PASS: TestPipe (0.00s) === RUN TestPipeConcurrent --- PASS: TestPipeConcurrent (0.03s) === 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-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:03:20 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:03:20 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) 2022/01/13 06:03:20 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish --- PASS: TestCopyWithDryRun (1.69s) === RUN TestCopy run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:03:20 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:03:20 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:03:21 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/01/13 06:03:21 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopy (2.17s) === RUN TestCopyMissingDirectory run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:03:22 DEBUG : Creating backend with remote "/non-existing" 2022/01/13 06:03:22 ERROR : Local file system at /non-existing: error reading source root directory: directory not found 2022/01/13 06:03:22 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:03:22 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish --- PASS: TestCopyMissingDirectory (0.50s) === RUN TestCopyNoTraverse run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:03:23 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:03:23 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:03:23 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:03:24 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/01/13 06:03:24 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoTraverse (2.07s) === RUN TestCopyCheckFirst run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:03:25 INFO : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Running all checks before starting transfers 2022/01/13 06:03:25 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:03:25 INFO : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Checks finished, now starting transfers 2022/01/13 06:03:25 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:03:25 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/01/13 06:03:25 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyCheckFirst (1.46s) === RUN TestSyncNoTraverse run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:03:26 ERROR : Ignoring --no-traverse with sync 2022/01/13 06:03:26 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:03:26 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:03:27 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/01/13 06:03:27 INFO : sub dir/hello world: Copied (new) 2022/01/13 06:03:27 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoTraverse (2.07s) === RUN TestCopyWithDepth run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:03:29 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:03:29 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:03:31 DEBUG : hello world2: sha1 = c0bf117f9c93d02c894fe8ffd6e5cecf3545c209 OK 2022/01/13 06:03:31 INFO : hello world2: Copied (new) --- PASS: TestCopyWithDepth (7.06s) === RUN TestCopyWithFilesFrom run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:03:35 DEBUG : hello world2: Excluded 2022/01/13 06:03:36 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:03:36 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:03:36 DEBUG : potato2: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/01/13 06:03:36 INFO : potato2: Copied (new) --- PASS: TestCopyWithFilesFrom (1.54s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:03:38 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:03:38 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:03:38 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:03:38 DEBUG : potato2: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/01/13 06:03:38 INFO : potato2: Copied (new) --- PASS: TestCopyWithFilesFromAndNoTraverse (3.08s) === RUN TestCopyEmptyDirectories run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:03:40 DEBUG : sub dir2: Making directory 2022/01/13 06:03:40 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:03:40 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:03:41 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/01/13 06:03:41 INFO : sub dir/hello world: Copied (new) 2022/01/13 06:03:41 DEBUG : sub dir2: Making directory 2022/01/13 06:03:41 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: copied 1 directories fstest.go:251: Filtering empty directory "sub dir2" --- PASS: TestCopyEmptyDirectories (1.74s) === RUN TestMoveEmptyDirectories run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:03:42 DEBUG : sub dir2: Making directory 2022/01/13 06:03:42 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:03:42 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:03:42 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/01/13 06:03:42 INFO : sub dir/hello world: Copied (new) 2022/01/13 06:03:42 INFO : sub dir/hello world: Deleted 2022/01/13 06:03:42 DEBUG : sub dir: Making directory 2022/01/13 06:03:42 DEBUG : sub dir2: Making directory 2022/01/13 06:03:42 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: copied 2 directories fstest.go:251: Filtering empty directory "sub dir2" --- PASS: TestMoveEmptyDirectories (1.55s) === RUN TestSyncEmptyDirectories run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:03:43 DEBUG : sub dir2: Making directory 2022/01/13 06:03:44 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:03:44 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:03:44 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/01/13 06:03:44 INFO : sub dir/hello world: Copied (new) 2022/01/13 06:03:44 DEBUG : sub dir2: Making directory 2022/01/13 06:03:44 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: copied 1 directories 2022/01/13 06:03:44 DEBUG : Waiting for deletions to finish fstest.go:251: Filtering empty directory "sub dir2" --- PASS: TestSyncEmptyDirectories (1.72s) === RUN TestServerSideCopy run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:03:46 DEBUG : Creating backend with remote "TestB2:rclone-test-dahezay8secefog5qomuwif7" sync_test.go:275: Server side copy (if possible) B2 bucket rclone-test-lewaley0bapivup8hexajuj9 -> B2 bucket rclone-test-dahezay8secefog5qomuwif7 2022/01/13 06:03:47 DEBUG : B2 bucket rclone-test-dahezay8secefog5qomuwif7: Waiting for checks to finish 2022/01/13 06:03:47 DEBUG : B2 bucket rclone-test-dahezay8secefog5qomuwif7: Waiting for transfers to finish 2022/01/13 06:03:48 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/01/13 06:03:48 INFO : sub dir/hello world: Copied (server-side copy) 2022/01/13 06:03:48 DEBUG : B2 bucket rclone-test-dahezay8secefog5qomuwif7: Purge remote 2022/01/13 06:03:48 DEBUG : sub dir/hello world: Deleting (id "4_zeff2fdb3008d5b2b7fe80e1b_f102655c71bf251e1_d20220113_m060348_c001_v0001093_t0055") --- PASS: TestServerSideCopy (4.46s) === RUN TestCopyAfterDelete run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:03:50 ERROR : : error listing: directory not found 2022/01/13 06:03:50 DEBUG : Local file system at /tmp/rclone1601322039: Making directory 2022/01/13 06:03:50 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:03:50 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish --- PASS: TestCopyAfterDelete (1.79s) === RUN TestCopyRedownload run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:03:52 DEBUG : Local file system at /tmp/rclone1601322039: Waiting for checks to finish 2022/01/13 06:03:52 DEBUG : Local file system at /tmp/rclone1601322039: Waiting for transfers to finish 2022/01/13 06:03:53 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/01/13 06:03:53 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyRedownload (2.99s) === RUN TestSyncBasedOnCheckSum run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:03:54 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:03:54 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:03:55 DEBUG : check sum: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/01/13 06:03:55 INFO : check sum: Copied (new) 2022/01/13 06:03:55 DEBUG : Waiting for deletions to finish 2022/01/13 06:03:55 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:03:55 DEBUG : check sum: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/01/13 06:03:55 DEBUG : check sum: Size and sha1 of src and dst objects identical 2022/01/13 06:03:55 DEBUG : check sum: Unchanged skipping 2022/01/13 06:03:55 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:03:55 DEBUG : Waiting for deletions to finish 2022/01/13 06:03:55 INFO : There was nothing to transfer --- PASS: TestSyncBasedOnCheckSum (2.62s) === RUN TestSyncSizeOnly run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:03:57 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:03:57 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:03:58 DEBUG : sizeonly: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2022/01/13 06:03:58 INFO : sizeonly: Copied (new) 2022/01/13 06:03:58 DEBUG : Waiting for deletions to finish 2022/01/13 06:03:58 DEBUG : sizeonly: Sizes identical 2022/01/13 06:03:58 DEBUG : sizeonly: Unchanged skipping 2022/01/13 06:03:58 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:03:58 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:03:58 DEBUG : Waiting for deletions to finish 2022/01/13 06:03:58 INFO : There was nothing to transfer --- PASS: TestSyncSizeOnly (1.94s) === RUN TestSyncIgnoreSize run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:03:59 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:03:59 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:03:59 DEBUG : ignore-size: sha1 = 4a756ca07e9487f482465a99e8286abc86ba4dc7 OK 2022/01/13 06:03:59 INFO : ignore-size: Copied (new) 2022/01/13 06:03:59 DEBUG : Waiting for deletions to finish 2022/01/13 06:04:00 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:04:00 DEBUG : ignore-size: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:04:00 DEBUG : ignore-size: Unchanged skipping 2022/01/13 06:04:00 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:04:00 DEBUG : Waiting for deletions to finish 2022/01/13 06:04:00 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreSize (1.72s) === RUN TestSyncIgnoreTimes run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:04:02 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:04:02 DEBUG : existing: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:04:02 DEBUG : existing: Unchanged skipping 2022/01/13 06:04:02 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:04:02 DEBUG : Waiting for deletions to finish 2022/01/13 06:04:02 INFO : There was nothing to transfer 2022/01/13 06:04:02 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2022/01/13 06:04:02 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:04:02 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:04:02 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2022/01/13 06:04:02 INFO : existing: Copied (replaced existing) 2022/01/13 06:04:02 DEBUG : Waiting for deletions to finish --- PASS: TestSyncIgnoreTimes (2.73s) === RUN TestSyncIgnoreExisting run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:04:03 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:04:03 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:04:04 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2022/01/13 06:04:04 INFO : existing: Copied (new) 2022/01/13 06:04:04 DEBUG : Waiting for deletions to finish 2022/01/13 06:04:05 DEBUG : existing: Destination exists, skipping 2022/01/13 06:04:05 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:04:05 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:04:05 DEBUG : Waiting for deletions to finish 2022/01/13 06:04:05 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreExisting (2.23s) === RUN TestSyncIgnoreErrors run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:04:07 DEBUG : d: Making directory fstest.go:251: Filtering empty directory "d" 2022/01/13 06:04:07 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:04:07 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/13 06:04:07 DEBUG : c/non empty space: Unchanged skipping 2022/01/13 06:04:07 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:04:08 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/01/13 06:04:08 INFO : a/potato2: Copied (new) 2022/01/13 06:04:08 DEBUG : Waiting for deletions to finish 2022/01/13 06:04:09 INFO : b/potato: Deleted --- PASS: TestSyncIgnoreErrors (5.10s) === RUN TestSyncAfterChangingModtimeOnly run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:04:12 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:04:12 DEBUG : empty space: Modification times differ by -95456h54m52.624456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499 +0000 UTC 2022/01/13 06:04:12 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/01/13 06:04:12 NOTICE: empty space: Skipped update modification time as --dry-run is set (size 1) 2022/01/13 06:04:12 DEBUG : empty space: Unchanged skipping 2022/01/13 06:04:12 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:04:12 DEBUG : Waiting for deletions to finish 2022/01/13 06:04:12 INFO : There was nothing to transfer 2022/01/13 06:04:12 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:04:12 DEBUG : empty space: Modification times differ by -95456h54m52.624456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499 +0000 UTC 2022/01/13 06:04:12 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/01/13 06:04:13 INFO : empty space: Updated modification time in destination 2022/01/13 06:04:13 DEBUG : empty space: Unchanged skipping 2022/01/13 06:04:13 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:04:13 DEBUG : Waiting for deletions to finish 2022/01/13 06:04:13 INFO : There was nothing to transfer --- PASS: TestSyncAfterChangingModtimeOnly (3.30s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:04:15 DEBUG : empty space: Modification times differ by -95456h54m52.624456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499 +0000 UTC 2022/01/13 06:04:15 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:04:15 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/01/13 06:04:15 DEBUG : empty space: Unchanged skipping 2022/01/13 06:04:15 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:04:15 DEBUG : Waiting for deletions to finish 2022/01/13 06:04:15 INFO : There was nothing to transfer --- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (7.27s) === RUN TestSyncDoesntUpdateModtime run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:04:23 DEBUG : foo: Modification times differ by -95456h54m52.624456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499 +0000 UTC 2022/01/13 06:04:23 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:04:23 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 (Local file system at /tmp/rclone1601322039) 2022/01/13 06:04:23 DEBUG : foo: sha1 = 62cdb7020ff920e5aa642c3d4066950dd1f01f4d (B2 bucket rclone-test-lewaley0bapivup8hexajuj9) 2022/01/13 06:04:23 DEBUG : foo: sha1 differ 2022/01/13 06:04:23 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:04:23 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 OK 2022/01/13 06:04:23 INFO : foo: Copied (replaced existing) 2022/01/13 06:04:23 DEBUG : Waiting for deletions to finish --- PASS: TestSyncDoesntUpdateModtime (3.33s) === RUN TestSyncAfterAddingAFile run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:04:25 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/13 06:04:25 DEBUG : empty space: Unchanged skipping 2022/01/13 06:04:25 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:04:25 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:04:26 DEBUG : potato: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/01/13 06:04:26 INFO : potato: Copied (new) 2022/01/13 06:04:26 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterAddingAFile (2.64s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:04:28 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2022/01/13 06:04:28 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:04:28 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:04:28 DEBUG : potato: sha1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f OK 2022/01/13 06:04:28 INFO : potato: Copied (replaced existing) 2022/01/13 06:04:28 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingFilesSizeOnly (2.12s) === RUN TestSyncAfterChangingContentsOnly run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:04:30 DEBUG : potato: Modification times differ by 119h59m59.876543211s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2011-12-30 12:59:59 +0000 UTC 2022/01/13 06:04:30 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:04:30 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f (Local file system at /tmp/rclone1601322039) 2022/01/13 06:04:30 DEBUG : potato: sha1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f (B2 bucket rclone-test-lewaley0bapivup8hexajuj9) 2022/01/13 06:04:30 DEBUG : potato: sha1 differ 2022/01/13 06:04:30 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:04:31 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f OK 2022/01/13 06:04:31 INFO : potato: Copied (replaced existing) 2022/01/13 06:04:31 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingContentsOnly (2.63s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:04:33 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2022/01/13 06:04:33 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/13 06:04:33 DEBUG : empty space: Unchanged skipping 2022/01/13 06:04:33 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:04:33 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:04:33 DEBUG : Waiting for deletions to finish 2022/01/13 06:04:33 NOTICE: potato: Skipped delete as --dry-run is set (size 21) --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (2.58s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:04:36 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/13 06:04:36 DEBUG : empty space: Unchanged skipping 2022/01/13 06:04:36 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:04:36 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:04:37 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/01/13 06:04:37 INFO : potato2: Copied (new) 2022/01/13 06:04:37 DEBUG : Waiting for deletions to finish 2022/01/13 06:04:37 INFO : potato: Deleted --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (4.22s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:04:40 DEBUG : d: Making directory 2022/01/13 06:04:40 DEBUG : d/e: Making directory fstest.go:251: Filtering empty directory "d" fstest.go:251: Filtering empty directory "d/e" 2022/01/13 06:04:40 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:04:40 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/13 06:04:40 DEBUG : c/non empty space: Unchanged skipping 2022/01/13 06:04:40 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:04:41 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/01/13 06:04:41 INFO : a/potato2: Copied (new) 2022/01/13 06:04:41 DEBUG : Waiting for deletions to finish 2022/01/13 06:04:41 INFO : b/potato: Deleted --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (4.05s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:04:44 DEBUG : d: Making directory fstest.go:251: Filtering empty directory "d" 2022/01/13 06:04:44 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/13 06:04:44 DEBUG : c/non empty space: Unchanged skipping 2022/01/13 06:04:44 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:04:44 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:04:45 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/01/13 06:04:45 INFO : a/potato2: Copied (new) 2022/01/13 06:04:45 ERROR : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: not deleting files as there were IO errors 2022/01/13 06:04:45 ERROR : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: not deleting directories as there were IO errors fstest.go:251: Filtering empty directory "d" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (5.16s) === RUN TestSyncDeleteAfter --- PASS: TestSyncDeleteAfter (0.00s) === RUN TestSyncDeleteDuring run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:04:49 DEBUG : Waiting for deletions to finish 2022/01/13 06:04:49 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/13 06:04:49 DEBUG : empty space: Unchanged skipping 2022/01/13 06:04:49 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:04:49 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:04:50 INFO : potato: Deleted 2022/01/13 06:04:50 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/01/13 06:04:50 INFO : potato2: Copied (new) --- PASS: TestSyncDeleteDuring (4.21s) === RUN TestSyncDeleteBefore run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:04:54 DEBUG : Waiting for deletions to finish 2022/01/13 06:04:54 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:04:54 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:04:55 INFO : potato: Deleted 2022/01/13 06:04:56 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/13 06:04:56 DEBUG : empty space: Unchanged skipping 2022/01/13 06:04:56 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:04:56 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:04:56 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/01/13 06:04:56 INFO : potato2: Copied (new) --- PASS: TestSyncDeleteBefore (5.57s) === RUN TestCopyDeleteBefore run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:04:59 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:04:59 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:04:59 DEBUG : potato2: sha1 = 810274f0df19dab60a894a562b7a8ff04c072623 OK 2022/01/13 06:04:59 INFO : potato2: Copied (new) --- PASS: TestCopyDeleteBefore (6.18s) === RUN TestSyncWithExclude run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:05:05 DEBUG : enormous: Excluded 2022/01/13 06:05:05 DEBUG : potato2: Excluded 2022/01/13 06:05:05 DEBUG : potato2: Excluded from sync (and deletion) 2022/01/13 06:05:05 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/13 06:05:05 DEBUG : empty space: Unchanged skipping 2022/01/13 06:05:05 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:05:05 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:05:05 DEBUG : Waiting for deletions to finish 2022/01/13 06:05:05 INFO : There was nothing to transfer 2022/01/13 06:05:05 DEBUG : enormous: Excluded 2022/01/13 06:05:05 DEBUG : potato2: Excluded 2022/01/13 06:05:06 DEBUG : potato2: Excluded from sync (and deletion) 2022/01/13 06:05:06 DEBUG : empty space: Size and modification time the same (differ by 456.789µs, within tolerance 1ms) 2022/01/13 06:05:06 DEBUG : empty space: Unchanged skipping 2022/01/13 06:05:06 DEBUG : Local file system at /tmp/rclone1601322039: Waiting for checks to finish 2022/01/13 06:05:06 DEBUG : Local file system at /tmp/rclone1601322039: Waiting for transfers to finish 2022/01/13 06:05:06 DEBUG : Waiting for deletions to finish 2022/01/13 06:05:06 INFO : There was nothing to transfer --- PASS: TestSyncWithExclude (3.71s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:05:10 DEBUG : enormous: Excluded 2022/01/13 06:05:10 DEBUG : potato2: Excluded 2022/01/13 06:05:10 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/13 06:05:10 DEBUG : empty space: Unchanged skipping 2022/01/13 06:05:10 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:05:10 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:05:10 DEBUG : Waiting for deletions to finish 2022/01/13 06:05:10 INFO : potato2: Deleted 2022/01/13 06:05:11 INFO : enormous: Deleted 2022/01/13 06:05:11 INFO : There was nothing to transfer 2022/01/13 06:05:11 DEBUG : empty space: Size and modification time the same (differ by 456.789µs, within tolerance 1ms) 2022/01/13 06:05:11 DEBUG : empty space: Unchanged skipping 2022/01/13 06:05:11 DEBUG : Local file system at /tmp/rclone1601322039: Waiting for checks to finish 2022/01/13 06:05:11 DEBUG : Local file system at /tmp/rclone1601322039: Waiting for transfers to finish 2022/01/13 06:05:11 DEBUG : Waiting for deletions to finish 2022/01/13 06:05:11 INFO : enormous: Deleted 2022/01/13 06:05:11 INFO : potato2: Deleted 2022/01/13 06:05:11 INFO : There was nothing to transfer --- PASS: TestSyncWithExcludeAndDeleteExcluded (4.77s) === RUN TestSyncWithUpdateOlder run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:05:15 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:05:15 DEBUG : four: Sizes differ (src 4 vs dst 8) 2022/01/13 06:05:15 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2022/01/13 06:05:15 DEBUG : one: Destination is newer than source, skipping 2022/01/13 06:05:15 DEBUG : three: Sizes identical 2022/01/13 06:05:15 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2022/01/13 06:05:15 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b (Local file system at /tmp/rclone1601322039) 2022/01/13 06:05:15 DEBUG : two: sha1 = b10e0da85e90399abfec36c7376b20aa4596461b (B2 bucket rclone-test-lewaley0bapivup8hexajuj9) 2022/01/13 06:05:15 DEBUG : two: sha1 differ 2022/01/13 06:05:15 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:05:15 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2022/01/13 06:05:15 INFO : five: Copied (new) 2022/01/13 06:05:16 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2022/01/13 06:05:16 INFO : two: Copied (replaced existing) 2022/01/13 06:05:17 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2022/01/13 06:05:17 INFO : four: Copied (replaced existing) 2022/01/13 06:05:17 DEBUG : Waiting for deletions to finish 2022/01/13 06:05:17 DEBUG : one: Destination is newer than source, skipping 2022/01/13 06:05:17 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:05:17 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb (Local file system at /tmp/rclone1601322039) 2022/01/13 06:05:17 DEBUG : three: sha1 = 03731cad13f4cf7b59703c77529381cdec1632e5 (B2 bucket rclone-test-lewaley0bapivup8hexajuj9) 2022/01/13 06:05:17 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2022/01/13 06:05:17 DEBUG : three: sha1 differ 2022/01/13 06:05:17 DEBUG : two: Size and sha1 of src and dst objects identical 2022/01/13 06:05:17 DEBUG : three: Destination mod time is within 1s of source but files differ, transferring 2022/01/13 06:05:17 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2022/01/13 06:05:17 DEBUG : two: Destination mod time is within 1s of source and files identical, skipping 2022/01/13 06:05:17 DEBUG : four: Size and sha1 of src and dst objects identical 2022/01/13 06:05:17 DEBUG : four: Destination mod time is within 1s of source and files identical, skipping 2022/01/13 06:05:17 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2022/01/13 06:05:17 DEBUG : five: Size and sha1 of src and dst objects identical 2022/01/13 06:05:17 DEBUG : five: Destination mod time is within 1s of source and files identical, skipping 2022/01/13 06:05:17 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:05:18 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/01/13 06:05:18 INFO : three: Copied (replaced existing) 2022/01/13 06:05:18 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithUpdateOlder (8.17s) === 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-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" sync_test.go:1058: Can track renames: true 2022/01/13 06:05:21 INFO : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Making map for --track-renames 2022/01/13 06:05:21 INFO : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Finished making map for --track-renames 2022/01/13 06:05:21 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:05:21 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for renames to finish 2022/01/13 06:05:21 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:05:21 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2022/01/13 06:05:21 INFO : yam: Copied (new) 2022/01/13 06:05:22 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2022/01/13 06:05:22 INFO : potato: Copied (new) 2022/01/13 06:05:22 DEBUG : Waiting for deletions to finish 2022/01/13 06:05:22 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:05:22 DEBUG : potato: Unchanged skipping 2022/01/13 06:05:22 INFO : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Making map for --track-renames 2022/01/13 06:05:22 INFO : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Finished making map for --track-renames 2022/01/13 06:05:22 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:05:22 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for renames to finish 2022/01/13 06:05:23 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:05:23 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2022/01/13 06:05:23 INFO : yam: Copied (server-side copy) to: yaml 2022/01/13 06:05:24 INFO : yam: Deleted 2022/01/13 06:05:24 INFO : yaml: Renamed from "yam" 2022/01/13 06:05:24 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:05:24 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenames (5.28s) === RUN TestParseRenamesStrategyModtime --- PASS: TestParseRenamesStrategyModtime (0.00s) === RUN TestRenamesStrategyModtime --- PASS: TestRenamesStrategyModtime (0.00s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" sync_test.go:1127: Can track renames: true 2022/01/13 06:05:26 INFO : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Making map for --track-renames 2022/01/13 06:05:26 INFO : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Finished making map for --track-renames 2022/01/13 06:05:26 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:05:26 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for renames to finish 2022/01/13 06:05:26 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:05:26 DEBUG : yam: Clearing upload URL because of error: Post "https://pod-000-1150-14.backblaze.com/b2api/v1/b2_upload_file/7f128de3008d5b2b7fe80e1b/c001_v0001150_t0008": EOF 2022/01/13 06:05:26 DEBUG : pacer: low level retry 1/1 (error Post "https://pod-000-1150-14.backblaze.com/b2api/v1/b2_upload_file/7f128de3008d5b2b7fe80e1b/c001_v0001150_t0008": EOF) 2022/01/13 06:05:26 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2022/01/13 06:05:26 DEBUG : yam: Received error: Post "https://pod-000-1150-14.backblaze.com/b2api/v1/b2_upload_file/7f128de3008d5b2b7fe80e1b/c001_v0001150_t0008": EOF - low level retry 1/10 2022/01/13 06:05:27 DEBUG : pacer: Reducing sleep to 10ms 2022/01/13 06:05:27 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2022/01/13 06:05:27 INFO : yam: Copied (new) 2022/01/13 06:05:27 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2022/01/13 06:05:27 INFO : potato: Copied (new) 2022/01/13 06:05:27 DEBUG : Waiting for deletions to finish 2022/01/13 06:05:27 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:05:27 DEBUG : potato: Unchanged skipping 2022/01/13 06:05:27 INFO : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Making map for --track-renames 2022/01/13 06:05:27 INFO : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Finished making map for --track-renames 2022/01/13 06:05:27 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:05:27 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for renames to finish 2022/01/13 06:05:28 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:05:29 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2022/01/13 06:05:29 INFO : yam: Copied (server-side copy) to: yaml 2022/01/13 06:05:30 INFO : yam: Deleted 2022/01/13 06:05:30 INFO : yaml: Renamed from "yam" 2022/01/13 06:05:30 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:05:30 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenamesStrategyModtime (5.58s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" sync_test.go:1163: Can track renames: true 2022/01/13 06:05:32 INFO : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Making map for --track-renames 2022/01/13 06:05:32 INFO : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Finished making map for --track-renames 2022/01/13 06:05:32 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:05:32 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for renames to finish 2022/01/13 06:05:32 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:05:32 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2022/01/13 06:05:32 INFO : sub/yam: Copied (new) 2022/01/13 06:05:32 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2022/01/13 06:05:32 INFO : potato: Copied (new) 2022/01/13 06:05:32 DEBUG : Waiting for deletions to finish 2022/01/13 06:05:33 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:05:33 DEBUG : potato: Unchanged skipping 2022/01/13 06:05:33 INFO : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Making map for --track-renames 2022/01/13 06:05:33 INFO : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Finished making map for --track-renames 2022/01/13 06:05:33 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:05:33 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for renames to finish 2022/01/13 06:05:33 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:05:34 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2022/01/13 06:05:34 INFO : sub/yam: Copied (server-side copy) to: yam 2022/01/13 06:05:35 INFO : sub/yam: Deleted 2022/01/13 06:05:35 INFO : yam: Renamed from "sub/yam" 2022/01/13 06:05:35 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:05:35 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenamesStrategyLeaf (6.67s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:05:38 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:05:38 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:05:39 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2022/01/13 06:05:39 INFO : nested/sub dir/file: Copied (new) 2022/01/13 06:05:39 INFO : nested/sub dir/file: Deleted 2022/01/13 06:05:40 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/01/13 06:05:40 INFO : sub dir/hello world: Copied (new) 2022/01/13 06:05:40 INFO : sub dir/hello world: Deleted 2022/01/13 06:05:40 INFO : sub dir: Removing directory 2022/01/13 06:05:40 INFO : nested/sub dir: Removing directory 2022/01/13 06:05:40 INFO : nested: Removing directory 2022/01/13 06:05:40 DEBUG : Local file system at /tmp/rclone1601322039: deleted 3 directories --- PASS: TestMoveWithDeleteEmptySrcDirs (3.27s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:05:42 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:05:42 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:05:42 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2022/01/13 06:05:42 INFO : nested/sub dir/file: Copied (new) 2022/01/13 06:05:42 INFO : nested/sub dir/file: Deleted 2022/01/13 06:05:42 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/01/13 06:05:42 INFO : sub dir/hello world: Copied (new) 2022/01/13 06:05:42 INFO : sub dir/hello world: Deleted --- PASS: TestMoveWithoutDeleteEmptySrcDirs (2.98s) === RUN TestMoveWithIgnoreExisting run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:05:44 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:05:44 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:05:45 DEBUG : existing-b: sha1 = 321f6b7e8bf7f29aab89c5e41a555b1b0baa41a9 OK 2022/01/13 06:05:45 INFO : existing-b: Copied (new) 2022/01/13 06:05:45 INFO : existing-b: Deleted 2022/01/13 06:05:45 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2022/01/13 06:05:45 INFO : existing: Copied (new) 2022/01/13 06:05:45 INFO : existing: Deleted 2022/01/13 06:05:45 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:05:45 DEBUG : existing: Destination exists, skipping 2022/01/13 06:05:45 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2022/01/13 06:05:45 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:05:45 INFO : There was nothing to transfer --- PASS: TestMoveWithIgnoreExisting (2.39s) === RUN TestServerSideMove run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:05:47 DEBUG : Creating backend with remote "TestB2:rclone-test-wiruzar2wazusew0vunevav2" 2022/01/13 06:05:47 DEBUG : Config file has changed externaly - reloading sync_test.go:1215: Server side move (if possible) B2 bucket rclone-test-lewaley0bapivup8hexajuj9 -> B2 bucket rclone-test-wiruzar2wazusew0vunevav2 2022/01/13 06:05:53 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ms) 2022/01/13 06:05:53 DEBUG : empty space: Unchanged skipping 2022/01/13 06:05:53 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2022/01/13 06:05:53 DEBUG : B2 bucket rclone-test-wiruzar2wazusew0vunevav2: Waiting for checks to finish 2022/01/13 06:05:54 INFO : empty space: Deleted 2022/01/13 06:05:54 DEBUG : B2 bucket rclone-test-wiruzar2wazusew0vunevav2: Waiting for transfers to finish 2022/01/13 06:05:55 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2022/01/13 06:05:55 INFO : potato3: Copied (server-side copy) 2022/01/13 06:05:55 INFO : potato3: Deleted 2022/01/13 06:05:56 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/01/13 06:05:56 INFO : potato2: Copied (server-side copy) 2022/01/13 06:05:56 INFO : potato2: Deleted 2022/01/13 06:05:57 DEBUG : Creating backend with remote "TestB2:rclone-test-roqekit0roribuc9zapiteg9" 2022/01/13 06:05:57 DEBUG : B2 bucket rclone-test-roqekit0roribuc9zapiteg9: Waiting for checks to finish 2022/01/13 06:05:57 DEBUG : B2 bucket rclone-test-roqekit0roribuc9zapiteg9: Waiting for transfers to finish 2022/01/13 06:05:59 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2022/01/13 06:05:59 INFO : potato3: Copied (server-side copy) 2022/01/13 06:05:59 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/01/13 06:05:59 INFO : potato2: Copied (server-side copy) 2022/01/13 06:05:59 INFO : potato2: Deleted 2022/01/13 06:05:59 INFO : potato3: Deleted 2022/01/13 06:06:00 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/01/13 06:06:00 INFO : empty space: Copied (server-side copy) 2022/01/13 06:06:01 INFO : empty space: Deleted 2022/01/13 06:06:01 DEBUG : B2 bucket rclone-test-roqekit0roribuc9zapiteg9: Purge remote 2022/01/13 06:06:02 DEBUG : empty space: Deleting (id "4_zbf72fd9300ad5b2b7fe80e1b_f114ee64f3c6b9b47_d20220113_m060558_c001_v0001105_t0042") 2022/01/13 06:06:02 DEBUG : potato2: Deleting (id "4_zbf72fd9300ad5b2b7fe80e1b_f107a009d3a0f285e_d20220113_m060558_c001_v0001105_t0034") 2022/01/13 06:06:02 DEBUG : potato3: Deleting (id "4_zbf72fd9300ad5b2b7fe80e1b_f103c199938a11346_d20220113_m060558_c001_v0001105_t0007") 2022/01/13 06:06:03 DEBUG : B2 bucket rclone-test-wiruzar2wazusew0vunevav2: Purge remote 2022/01/13 06:06:03 DEBUG : empty space: Deleting (id "4_zbf62dda300ad5b2b7fe80e1b_f11791ba4e1fcabae_d20220113_m060600_c001_v0001097_t0053") 2022/01/13 06:06:03 DEBUG : empty space: Deleting (id "4_zbf62dda300ad5b2b7fe80e1b_f11797d79e15265ac_d20220113_m060551_c001_v0001105_t0006") 2022/01/13 06:06:03 DEBUG : potato2: Deleting (id "4_zbf62dda300ad5b2b7fe80e1b_f1034f3f8f07aa349_d20220113_m060559_c001_v0001030_t0011") 2022/01/13 06:06:03 DEBUG : potato2: Deleting (id "4_zbf62dda300ad5b2b7fe80e1b_f10875e538aba5960_d20220113_m060553_c001_v0001105_t0045") 2022/01/13 06:06:03 DEBUG : potato3: Deleting (id "4_zbf62dda300ad5b2b7fe80e1b_f114e60b30e507d0b_d20220113_m060559_c001_v0001117_t0042") 2022/01/13 06:06:03 DEBUG : potato3: Deleting (id "4_zbf62dda300ad5b2b7fe80e1b_f101d48d12a36149b_d20220113_m060554_c001_v0001105_t0053") 2022/01/13 06:06:03 DEBUG : potato3: Deleting (id "4_zbf62dda300ad5b2b7fe80e1b_f11797d79e15265c7_d20220113_m060552_c001_v0001105_t0019") --- PASS: TestServerSideMove (17.18s) === RUN TestServerSideMoveWithFilter run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:06:04 DEBUG : Creating backend with remote "TestB2:rclone-test-xitoguj9poquvod7rotehic9" sync_test.go:1215: Server side move (if possible) B2 bucket rclone-test-lewaley0bapivup8hexajuj9 -> B2 bucket rclone-test-xitoguj9poquvod7rotehic9 2022/01/13 06:06:10 DEBUG : empty space: Excluded from sync (and deletion) 2022/01/13 06:06:10 DEBUG : empty space: Excluded from sync (and deletion) 2022/01/13 06:06:10 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2022/01/13 06:06:10 DEBUG : B2 bucket rclone-test-xitoguj9poquvod7rotehic9: Waiting for checks to finish 2022/01/13 06:06:10 DEBUG : B2 bucket rclone-test-xitoguj9poquvod7rotehic9: Waiting for transfers to finish 2022/01/13 06:06:11 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/01/13 06:06:11 INFO : potato2: Copied (server-side copy) 2022/01/13 06:06:11 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2022/01/13 06:06:11 INFO : potato3: Copied (server-side copy) 2022/01/13 06:06:11 INFO : potato2: Deleted 2022/01/13 06:06:12 INFO : potato3: Deleted 2022/01/13 06:06:12 DEBUG : Creating backend with remote "TestB2:rclone-test-mezereg9mucipoh7juwixek9" 2022/01/13 06:06:13 DEBUG : empty space: Excluded from sync (and deletion) 2022/01/13 06:06:13 DEBUG : B2 bucket rclone-test-mezereg9mucipoh7juwixek9: Waiting for checks to finish 2022/01/13 06:06:13 DEBUG : B2 bucket rclone-test-mezereg9mucipoh7juwixek9: Waiting for transfers to finish 2022/01/13 06:06:14 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/01/13 06:06:14 INFO : potato2: Copied (server-side copy) 2022/01/13 06:06:14 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2022/01/13 06:06:14 INFO : potato3: Copied (server-side copy) 2022/01/13 06:06:14 INFO : potato2: Deleted 2022/01/13 06:06:15 INFO : potato3: Deleted 2022/01/13 06:06:15 DEBUG : B2 bucket rclone-test-mezereg9mucipoh7juwixek9: Purge remote 2022/01/13 06:06:15 DEBUG : potato2: Deleting (id "4_z1f923d6300bd5b2b7fe80e1b_f118065f94f56287b_d20220113_m060613_c001_v0001093_t0038") 2022/01/13 06:06:15 DEBUG : potato3: Deleting (id "4_z1f923d6300bd5b2b7fe80e1b_f11525f0bb06be5b6_d20220113_m060614_c001_v0001146_t0003") 2022/01/13 06:06:16 DEBUG : B2 bucket rclone-test-xitoguj9poquvod7rotehic9: Purge remote 2022/01/13 06:06:16 DEBUG : empty space: Deleting (id "4_zef321df300bd5b2b7fe80e1b_f115a47e7b6e26a4a_d20220113_m060609_c001_v0001098_t0016") 2022/01/13 06:06:16 DEBUG : potato2: Deleting (id "4_zef321df300bd5b2b7fe80e1b_f11958106b06d753f_d20220113_m060614_c001_v0001130_t0020") 2022/01/13 06:06:16 DEBUG : potato2: Deleting (id "4_zef321df300bd5b2b7fe80e1b_f104f8d3cbda17d14_d20220113_m060610_c001_v0001109_t0056") 2022/01/13 06:06:16 DEBUG : potato3: Deleting (id "4_zef321df300bd5b2b7fe80e1b_f105466517458cbd2_d20220113_m060614_c001_v0001018_t0010") 2022/01/13 06:06:16 DEBUG : potato3: Deleting (id "4_zef321df300bd5b2b7fe80e1b_f104576c6f2e945a7_d20220113_m060610_c001_v0001117_t0024") 2022/01/13 06:06:16 DEBUG : potato3: Deleting (id "4_zef321df300bd5b2b7fe80e1b_f115a47e7b6e26a52_d20220113_m060609_c001_v0001098_t0033") --- PASS: TestServerSideMoveWithFilter (14.17s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:06:18 DEBUG : Creating backend with remote "TestB2:rclone-test-lesalex1rarunin2nezarak5" 2022/01/13 06:06:21 DEBUG : tomatoDir: Making directory sync_test.go:1215: Server side move (if possible) B2 bucket rclone-test-lewaley0bapivup8hexajuj9 -> B2 bucket rclone-test-lesalex1rarunin2nezarak5 2022/01/13 06:06:23 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ms) 2022/01/13 06:06:23 DEBUG : empty space: Unchanged skipping 2022/01/13 06:06:23 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2022/01/13 06:06:23 DEBUG : B2 bucket rclone-test-lesalex1rarunin2nezarak5: Waiting for checks to finish 2022/01/13 06:06:24 INFO : empty space: Deleted 2022/01/13 06:06:24 DEBUG : B2 bucket rclone-test-lesalex1rarunin2nezarak5: Waiting for transfers to finish 2022/01/13 06:06:24 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/01/13 06:06:24 INFO : potato2: Copied (server-side copy) 2022/01/13 06:06:25 INFO : potato2: Deleted 2022/01/13 06:06:28 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2022/01/13 06:06:28 INFO : potato3: Copied (server-side copy) 2022/01/13 06:06:28 INFO : potato3: Deleted 2022/01/13 06:06:28 DEBUG : Creating backend with remote "TestB2:rclone-test-layegus9butiviz0hidesuj2" 2022/01/13 06:06:29 DEBUG : tomatoDir: Making directory 2022/01/13 06:06:29 DEBUG : B2 bucket rclone-test-layegus9butiviz0hidesuj2: Waiting for checks to finish 2022/01/13 06:06:29 DEBUG : B2 bucket rclone-test-layegus9butiviz0hidesuj2: Waiting for transfers to finish 2022/01/13 06:06:30 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/01/13 06:06:30 INFO : potato2: Copied (server-side copy) 2022/01/13 06:06:31 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/01/13 06:06:31 INFO : empty space: Copied (server-side copy) 2022/01/13 06:06:31 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2022/01/13 06:06:31 INFO : potato3: Copied (server-side copy) 2022/01/13 06:06:31 INFO : potato2: Deleted 2022/01/13 06:06:31 INFO : empty space: Deleted 2022/01/13 06:06:31 INFO : potato3: Deleted 2022/01/13 06:06:32 DEBUG : B2 bucket rclone-test-layegus9butiviz0hidesuj2: Purge remote 2022/01/13 06:06:32 DEBUG : empty space: Deleting (id "4_z1fd27d6300bd5b2b7fe80e1b_f111aaafa6faab1c2_d20220113_m060630_c001_v0001090_t0046") 2022/01/13 06:06:32 DEBUG : potato2: Deleting (id "4_z1fd27d6300bd5b2b7fe80e1b_f1117a9955183290a_d20220113_m060630_c001_v0001137_t0022") 2022/01/13 06:06:32 DEBUG : potato3: Deleting (id "4_z1fd27d6300bd5b2b7fe80e1b_f1107b80a4bcf94fd_d20220113_m060630_c001_v0001165_t0004") 2022/01/13 06:06:33 DEBUG : B2 bucket rclone-test-lesalex1rarunin2nezarak5: Purge remote 2022/01/13 06:06:33 DEBUG : empty space: Deleting (id "4_zcf725d6300bd5b2b7fe80e1b_f106eb339080b2574_d20220113_m060631_c001_v0001109_t0016") 2022/01/13 06:06:33 DEBUG : empty space: Deleting (id "4_zcf725d6300bd5b2b7fe80e1b_f1002a1f36a68531a_d20220113_m060622_c001_v0001093_t0042") 2022/01/13 06:06:33 DEBUG : potato2: Deleting (id "4_zcf725d6300bd5b2b7fe80e1b_f105d377b6f31468c_d20220113_m060630_c001_v0001042_t0054") 2022/01/13 06:06:33 DEBUG : potato2: Deleting (id "4_zcf725d6300bd5b2b7fe80e1b_f10052d5b266cc2b4_d20220113_m060624_c001_v0001134_t0018") 2022/01/13 06:06:33 DEBUG : potato3: Deleting (id "4_zcf725d6300bd5b2b7fe80e1b_f1195cc8bc5ba7f3e_d20220113_m060631_c001_v0001013_t0030") 2022/01/13 06:06:33 DEBUG : potato3: Deleting (id "4_zcf725d6300bd5b2b7fe80e1b_f119a5ced73cfcc26_d20220113_m060624_c001_v0001039_t0037") 2022/01/13 06:06:33 DEBUG : potato3: Deleting (id "4_zcf725d6300bd5b2b7fe80e1b_f1002a1f36a68531c_d20220113_m060623_c001_v0001093_t0000") --- PASS: TestServerSideMoveDeleteEmptySourceDirs (16.07s) === RUN TestServerSideMoveOverlap run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:06:34 DEBUG : Creating backend with remote "TestB2:rclone-test-lewaley0bapivup8hexajuj9/rclone-move-test" 2022/01/13 06:06:36 DEBUG : Couldn't decode error response: EOF --- PASS: TestServerSideMoveOverlap (3.71s) === RUN TestSyncOverlap run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:06:38 DEBUG : Creating backend with remote "TestB2:rclone-test-lewaley0bapivup8hexajuj9/rclone-sync-test" 2022/01/13 06:06:38 DEBUG : Couldn't decode error response: EOF --- PASS: TestSyncOverlap (0.77s) === RUN TestSyncCompareDest run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:06:39 DEBUG : Creating backend with remote "TestB2:rclone-test-lewaley0bapivup8hexajuj9/dst" 2022/01/13 06:06:39 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:06:39 DEBUG : Creating backend with remote "TestB2:rclone-test-lewaley0bapivup8hexajuj9/CompareDest" 2022/01/13 06:06:39 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:06:40 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:06:40 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for checks to finish 2022/01/13 06:06:40 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for transfers to finish 2022/01/13 06:06:41 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/01/13 06:06:41 INFO : one: Copied (new) 2022/01/13 06:06:41 DEBUG : Waiting for deletions to finish 2022/01/13 06:06:42 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for checks to finish 2022/01/13 06:06:42 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:06:42 DEBUG : one: Sizes differ (src 5 vs dst 3) 2022/01/13 06:06:42 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for transfers to finish 2022/01/13 06:06:43 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2022/01/13 06:06:43 INFO : one: Copied (replaced existing) 2022/01/13 06:06:43 DEBUG : Waiting for deletions to finish 2022/01/13 06:06:46 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for checks to finish 2022/01/13 06:06:46 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/13 06:06:46 DEBUG : one: Destination found in --compare-dest, skipping 2022/01/13 06:06:46 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for transfers to finish 2022/01/13 06:06:46 DEBUG : Waiting for deletions to finish 2022/01/13 06:06:46 INFO : There was nothing to transfer 2022/01/13 06:06:47 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/13 06:06:47 DEBUG : two: Destination found in --compare-dest, skipping 2022/01/13 06:06:47 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for checks to finish 2022/01/13 06:06:47 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/13 06:06:47 DEBUG : one: Destination found in --compare-dest, skipping 2022/01/13 06:06:47 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for transfers to finish 2022/01/13 06:06:47 DEBUG : Waiting for deletions to finish 2022/01/13 06:06:47 INFO : There was nothing to transfer 2022/01/13 06:06:48 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/13 06:06:48 DEBUG : two: Destination found in --compare-dest, skipping 2022/01/13 06:06:48 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for checks to finish 2022/01/13 06:06:48 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/13 06:06:48 DEBUG : one: Destination found in --compare-dest, skipping 2022/01/13 06:06:48 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for transfers to finish 2022/01/13 06:06:48 DEBUG : Waiting for deletions to finish 2022/01/13 06:06:48 INFO : There was nothing to transfer 2022/01/13 06:06:49 DEBUG : two: Modification times differ by -119h59m59.877s: 2011-12-30 12:59:59 +0000 UTC, 2011-12-25 12:59:59.123 +0000 UTC 2022/01/13 06:06:49 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2022/01/13 06:06:49 DEBUG : two: Destination found in --compare-dest, skipping 2022/01/13 06:06:49 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for checks to finish 2022/01/13 06:06:49 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/13 06:06:49 DEBUG : one: Destination found in --compare-dest, skipping 2022/01/13 06:06:49 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for transfers to finish 2022/01/13 06:06:49 DEBUG : Waiting for deletions to finish 2022/01/13 06:06:49 INFO : There was nothing to transfer 2022/01/13 06:06:50 DEBUG : two: Sizes differ (src 5 vs dst 3) 2022/01/13 06:06:50 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for checks to finish 2022/01/13 06:06:50 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/13 06:06:50 DEBUG : one: Destination found in --compare-dest, skipping 2022/01/13 06:06:50 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for transfers to finish 2022/01/13 06:06:50 DEBUG : two: sha1 = a4be8877ad88f3109a6411985a1f359e10e2d930 OK 2022/01/13 06:06:50 INFO : two: Copied (new) 2022/01/13 06:06:50 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (17.83s) === RUN TestSyncMultipleCompareDest run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:06:59 DEBUG : Creating backend with remote "TestB2:rclone-test-lewaley0bapivup8hexajuj9/dest" 2022/01/13 06:07:00 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:07:00 DEBUG : Creating backend with remote "TestB2:rclone-test-lewaley0bapivup8hexajuj9/pre-dest1" 2022/01/13 06:07:00 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:07:00 DEBUG : Creating backend with remote "TestB2:rclone-test-lewaley0bapivup8hexajuj9/pre-dest2" 2022/01/13 06:07:01 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:07:01 DEBUG : 1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:07:01 DEBUG : 1: Destination found in --compare-dest, skipping 2022/01/13 06:07:01 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:07:02 DEBUG : 2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:07:02 DEBUG : 2: Destination found in --compare-dest, skipping 2022/01/13 06:07:02 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:07:02 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:07:02 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dest: Waiting for checks to finish 2022/01/13 06:07:02 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dest: Waiting for transfers to finish 2022/01/13 06:07:03 DEBUG : 3: sha1 = 77de68daecd823babbb58edb1c8e14d7106e83bb OK 2022/01/13 06:07:03 INFO : 3: Copied (new) 2022/01/13 06:07:03 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (9.59s) === RUN TestSyncCopyDest run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:07:06 DEBUG : Creating backend with remote "TestB2:rclone-test-lewaley0bapivup8hexajuj9/dst" 2022/01/13 06:07:08 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:07:08 DEBUG : Creating backend with remote "TestB2:rclone-test-lewaley0bapivup8hexajuj9/CopyDest" 2022/01/13 06:07:08 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:07:09 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:07:09 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for checks to finish 2022/01/13 06:07:09 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for transfers to finish 2022/01/13 06:07:10 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/01/13 06:07:10 INFO : one: Copied (new) 2022/01/13 06:07:10 DEBUG : Waiting for deletions to finish 2022/01/13 06:07:10 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for checks to finish 2022/01/13 06:07:10 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:07:10 DEBUG : one: Sizes differ (src 5 vs dst 3) 2022/01/13 06:07:10 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for transfers to finish 2022/01/13 06:07:11 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2022/01/13 06:07:11 INFO : one: Copied (replaced existing) 2022/01/13 06:07:11 DEBUG : Waiting for deletions to finish 2022/01/13 06:07:13 DEBUG : Creating backend with remote "TestB2:rclone-test-lewaley0bapivup8hexajuj9/BackupDir" 2022/01/13 06:07:14 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:07:14 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for checks to finish 2022/01/13 06:07:14 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/13 06:07:14 DEBUG : one: Sizes differ (src 5 vs dst 3) 2022/01/13 06:07:15 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:07:16 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/01/13 06:07:16 INFO : one: Copied (server-side copy) 2022/01/13 06:07:17 INFO : one: Deleted 2022/01/13 06:07:17 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2022/01/13 06:07:17 INFO : one: Copied (server-side copy) 2022/01/13 06:07:17 DEBUG : one: Destination found in --copy-dest, using server-side copy 2022/01/13 06:07:17 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for transfers to finish 2022/01/13 06:07:17 DEBUG : Waiting for deletions to finish 2022/01/13 06:07:19 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/13 06:07:19 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2022/01/13 06:07:19 INFO : two: Copied (server-side copy) 2022/01/13 06:07:19 DEBUG : two: Destination found in --copy-dest, using server-side copy 2022/01/13 06:07:19 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for checks to finish 2022/01/13 06:07:20 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/13 06:07:20 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/13 06:07:20 DEBUG : one: Unchanged skipping 2022/01/13 06:07:20 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for transfers to finish 2022/01/13 06:07:20 DEBUG : Waiting for deletions to finish 2022/01/13 06:07:20 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for checks to finish 2022/01/13 06:07:20 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/13 06:07:20 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/13 06:07:20 DEBUG : one: Unchanged skipping 2022/01/13 06:07:20 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/13 06:07:20 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/13 06:07:20 DEBUG : two: Unchanged skipping 2022/01/13 06:07:20 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for transfers to finish 2022/01/13 06:07:20 DEBUG : Waiting for deletions to finish 2022/01/13 06:07:20 INFO : There was nothing to transfer 2022/01/13 06:07:22 DEBUG : three: Sizes differ (src 7 vs dst 5) 2022/01/13 06:07:22 DEBUG : three: Destination not found in --copy-dest 2022/01/13 06:07:22 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for checks to finish 2022/01/13 06:07:22 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/13 06:07:22 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/13 06:07:22 DEBUG : one: Unchanged skipping 2022/01/13 06:07:22 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/13 06:07:22 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/01/13 06:07:22 DEBUG : two: Unchanged skipping 2022/01/13 06:07:22 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for transfers to finish 2022/01/13 06:07:23 DEBUG : three: sha1 = 370e613335f3cf2f19b2a2d35a86402f55c659f8 OK 2022/01/13 06:07:23 INFO : three: Copied (new) 2022/01/13 06:07:23 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCopyDest (23.30s) === RUN TestSyncBackupDir run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:07:32 DEBUG : Creating backend with remote "TestB2:rclone-test-lewaley0bapivup8hexajuj9/dst" 2022/01/13 06:07:33 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:07:33 DEBUG : Creating backend with remote "TestB2:rclone-test-lewaley0bapivup8hexajuj9/backup" 2022/01/13 06:07:33 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:07:34 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/01/13 06:07:34 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for checks to finish 2022/01/13 06:07:34 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:07:34 DEBUG : two: Unchanged skipping 2022/01/13 06:07:34 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:07:35 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/01/13 06:07:35 INFO : one: Copied (server-side copy) 2022/01/13 06:07:35 INFO : one: Deleted 2022/01/13 06:07:35 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for transfers to finish 2022/01/13 06:07:36 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/01/13 06:07:36 INFO : one: Copied (new) 2022/01/13 06:07:36 DEBUG : Waiting for deletions to finish 2022/01/13 06:07:36 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:07:37 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/01/13 06:07:37 INFO : three.txt: Copied (server-side copy) 2022/01/13 06:07:38 INFO : three.txt: Deleted 2022/01/13 06:07:38 INFO : three.txt: Moved into backup dir 2022/01/13 06:07:40 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/01/13 06:07:40 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for checks to finish 2022/01/13 06:07:40 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:07:40 DEBUG : two: Unchanged skipping 2022/01/13 06:07:41 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/01/13 06:07:41 INFO : one: Copied (server-side copy) 2022/01/13 06:07:42 INFO : one: Deleted 2022/01/13 06:07:42 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for transfers to finish 2022/01/13 06:07:43 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2022/01/13 06:07:43 INFO : one: Copied (new) 2022/01/13 06:07:43 DEBUG : Waiting for deletions to finish 2022/01/13 06:07:44 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/01/13 06:07:44 INFO : three.txt: Copied (server-side copy) 2022/01/13 06:07:46 INFO : three.txt: Deleted 2022/01/13 06:07:46 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (19.66s) === RUN TestSyncBackupDirWithSuffix run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:07:52 DEBUG : Creating backend with remote "TestB2:rclone-test-lewaley0bapivup8hexajuj9/dst" 2022/01/13 06:07:53 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:07:53 DEBUG : Creating backend with remote "TestB2:rclone-test-lewaley0bapivup8hexajuj9/backup" 2022/01/13 06:07:53 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:07:54 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/01/13 06:07:54 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:07:54 DEBUG : two: Unchanged skipping 2022/01/13 06:07:54 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for checks to finish 2022/01/13 06:07:54 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:07:55 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/01/13 06:07:55 INFO : one: Copied (server-side copy) to: one.bak 2022/01/13 06:07:56 INFO : one: Deleted 2022/01/13 06:07:56 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for transfers to finish 2022/01/13 06:07:58 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/01/13 06:07:58 INFO : one: Copied (new) 2022/01/13 06:07:58 DEBUG : Waiting for deletions to finish 2022/01/13 06:07:58 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:07:59 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/01/13 06:07:59 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/01/13 06:07:59 INFO : three.txt: Deleted 2022/01/13 06:07:59 INFO : three.txt: Moved into backup dir 2022/01/13 06:08:02 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/01/13 06:08:02 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:08:02 DEBUG : two: Unchanged skipping 2022/01/13 06:08:02 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for checks to finish 2022/01/13 06:08:03 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/01/13 06:08:03 INFO : one: Copied (server-side copy) to: one.bak 2022/01/13 06:08:03 INFO : one: Deleted 2022/01/13 06:08:03 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for transfers to finish 2022/01/13 06:08:05 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2022/01/13 06:08:05 INFO : one: Copied (new) 2022/01/13 06:08:05 DEBUG : Waiting for deletions to finish 2022/01/13 06:08:05 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/01/13 06:08:05 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/01/13 06:08:07 INFO : three.txt: Deleted 2022/01/13 06:08:07 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (20.48s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:08:12 DEBUG : Creating backend with remote "TestB2:rclone-test-lewaley0bapivup8hexajuj9/dst" 2022/01/13 06:08:13 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:08:13 DEBUG : Creating backend with remote "TestB2:rclone-test-lewaley0bapivup8hexajuj9/backup" 2022/01/13 06:08:14 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:08:14 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/01/13 06:08:14 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for checks to finish 2022/01/13 06:08:14 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:08:14 DEBUG : two: Unchanged skipping 2022/01/13 06:08:14 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:08:16 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/01/13 06:08:16 INFO : one: Copied (server-side copy) to: one-2019-01-01 2022/01/13 06:08:18 INFO : one: Deleted 2022/01/13 06:08:18 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for transfers to finish 2022/01/13 06:08:19 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/01/13 06:08:19 INFO : one: Copied (new) 2022/01/13 06:08:19 DEBUG : Waiting for deletions to finish 2022/01/13 06:08:19 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:08:19 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/01/13 06:08:19 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2022/01/13 06:08:20 INFO : three.txt: Deleted 2022/01/13 06:08:20 INFO : three.txt: Moved into backup dir 2022/01/13 06:08:21 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/01/13 06:08:21 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for checks to finish 2022/01/13 06:08:21 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:08:21 DEBUG : two: Unchanged skipping 2022/01/13 06:08:22 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/01/13 06:08:22 INFO : one: Copied (server-side copy) to: one-2019-01-01 2022/01/13 06:08:23 INFO : one: Deleted 2022/01/13 06:08:23 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for transfers to finish 2022/01/13 06:08:23 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2022/01/13 06:08:23 INFO : one: Copied (new) 2022/01/13 06:08:23 DEBUG : Waiting for deletions to finish 2022/01/13 06:08:24 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/01/13 06:08:24 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2022/01/13 06:08:24 INFO : three.txt: Deleted 2022/01/13 06:08:24 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (18.29s) === RUN TestSyncBackupDirSuffixOnly run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:08:30 DEBUG : Creating backend with remote "TestB2:rclone-test-lewaley0bapivup8hexajuj9/dst" 2022/01/13 06:08:31 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:08:32 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/01/13 06:08:32 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:08:32 DEBUG : two: Unchanged skipping 2022/01/13 06:08:32 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for checks to finish 2022/01/13 06:08:32 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:08:32 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/01/13 06:08:32 INFO : one: Copied (server-side copy) to: one.bak 2022/01/13 06:08:34 INFO : one: Deleted 2022/01/13 06:08:34 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for transfers to finish 2022/01/13 06:08:35 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/01/13 06:08:35 INFO : one: Copied (new) 2022/01/13 06:08:35 DEBUG : Waiting for deletions to finish 2022/01/13 06:08:35 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:08:35 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/01/13 06:08:35 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/01/13 06:08:36 INFO : three.txt: Deleted 2022/01/13 06:08:36 INFO : three.txt: Moved into backup dir 2022/01/13 06:08:38 DEBUG : one.bak: Excluded from sync (and deletion) 2022/01/13 06:08:38 DEBUG : three.txt.bak: Excluded from sync (and deletion) 2022/01/13 06:08:38 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/01/13 06:08:38 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:08:38 DEBUG : two: Unchanged skipping 2022/01/13 06:08:38 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for checks to finish 2022/01/13 06:08:38 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/01/13 06:08:38 INFO : one: Copied (server-side copy) to: one.bak 2022/01/13 06:08:40 INFO : one: Deleted 2022/01/13 06:08:40 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9 path dst: Waiting for transfers to finish 2022/01/13 06:08:40 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2022/01/13 06:08:40 INFO : one: Copied (new) 2022/01/13 06:08:40 DEBUG : Waiting for deletions to finish 2022/01/13 06:08:41 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/01/13 06:08:41 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/01/13 06:08:44 INFO : three.txt: Deleted 2022/01/13 06:08:44 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (19.38s) === RUN TestSyncSuffix run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:08:50 DEBUG : Creating backend with remote "TestB2:rclone-test-lewaley0bapivup8hexajuj9/dst" 2022/01/13 06:08:51 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:08:51 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/01/13 06:08:52 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:08:54 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/01/13 06:08:54 INFO : one: Copied (server-side copy) to: one.bak 2022/01/13 06:08:55 INFO : one: Deleted 2022/01/13 06:08:56 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/01/13 06:08:56 INFO : one: Copied (new) 2022/01/13 06:08:56 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:08:56 DEBUG : two: Unchanged skipping 2022/01/13 06:08:56 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2022/01/13 06:08:56 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:08:57 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/01/13 06:08:57 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/01/13 06:08:58 INFO : three.txt: Deleted 2022/01/13 06:08:58 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/01/13 06:08:58 INFO : three.txt: Copied (new) 2022/01/13 06:08:59 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/01/13 06:09:00 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/01/13 06:09:00 INFO : one: Copied (server-side copy) to: one.bak 2022/01/13 06:09:01 INFO : one: Deleted 2022/01/13 06:09:01 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2022/01/13 06:09:01 INFO : one: Copied (new) 2022/01/13 06:09:01 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:09:01 DEBUG : two: Unchanged skipping 2022/01/13 06:09:02 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2022/01/13 06:09:02 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/01/13 06:09:02 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/01/13 06:09:02 INFO : three.txt: Deleted 2022/01/13 06:09:03 DEBUG : three.txt: sha1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK 2022/01/13 06:09:03 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (22.20s) === RUN TestSyncSuffixKeepExtension run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:09:12 DEBUG : Creating backend with remote "TestB2:rclone-test-lewaley0bapivup8hexajuj9/dst" 2022/01/13 06:09:14 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:09:14 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/01/13 06:09:14 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:09:15 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/01/13 06:09:15 INFO : one: Copied (server-side copy) to: one-2019-01-01 2022/01/13 06:09:16 INFO : one: Deleted 2022/01/13 06:09:18 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/01/13 06:09:18 INFO : one: Copied (new) 2022/01/13 06:09:18 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:09:18 DEBUG : two: Unchanged skipping 2022/01/13 06:09:19 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2022/01/13 06:09:19 DEBUG : Couldn't decode error response: EOF 2022/01/13 06:09:19 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/01/13 06:09:19 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2022/01/13 06:09:19 INFO : three.txt: Deleted 2022/01/13 06:09:20 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/01/13 06:09:20 INFO : three.txt: Copied (new) 2022/01/13 06:09:20 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/01/13 06:09:21 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/01/13 06:09:21 INFO : one: Copied (server-side copy) to: one-2019-01-01 2022/01/13 06:09:22 INFO : one: Deleted 2022/01/13 06:09:22 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2022/01/13 06:09:22 INFO : one: Copied (new) 2022/01/13 06:09:22 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:09:22 DEBUG : two: Unchanged skipping 2022/01/13 06:09:22 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2022/01/13 06:09:23 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/01/13 06:09:23 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2022/01/13 06:09:23 INFO : three.txt: Deleted 2022/01/13 06:09:24 DEBUG : three.txt: sha1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK 2022/01/13 06:09:24 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (20.62s) === RUN TestSyncUTFNorm run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:09:31 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:09:31 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2022/01/13 06:09:31 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:09:33 DEBUG : Testêé: sha1 = a54d88e06612d820bc3be72877c74f257b561b19 OK 2022/01/13 06:09:33 INFO : Testêé: Copied (replaced existing) to: Testêé 2022/01/13 06:09:33 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (3.74s) === RUN TestSyncImmutable run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:09:34 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:09:34 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:09:35 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2022/01/13 06:09:35 INFO : existing: Copied (new) 2022/01/13 06:09:35 DEBUG : Waiting for deletions to finish 2022/01/13 06:09:35 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2022/01/13 06:09:35 ERROR : existing: Source and destination exist but do not match: immutable file modified 2022/01/13 06:09:35 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:09:35 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:09:35 ERROR : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: not deleting files as there were IO errors 2022/01/13 06:09:35 ERROR : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: not deleting directories as there were IO errors --- PASS: TestSyncImmutable (2.52s) === RUN TestSyncIgnoreCase run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:09:37 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:09:37 DEBUG : existing: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:09:37 DEBUG : existing: Unchanged skipping 2022/01/13 06:09:37 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:09:37 DEBUG : Waiting for deletions to finish 2022/01/13 06:09:37 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (1.80s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" sync_test.go:1989: This test only runs on local === RUN TestMaxTransfer/Soft run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" sync_test.go:1989: This test only runs on local === RUN TestMaxTransfer/Cautious run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" sync_test.go:1989: This test only runs on local --- PASS: TestMaxTransfer (1.05s) --- SKIP: TestMaxTransfer/Hard (0.35s) --- SKIP: TestMaxTransfer/Soft (0.35s) --- SKIP: TestMaxTransfer/Cautious (0.35s) === RUN TestSyncConcurrentDelete run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:10:02 DEBUG : both0: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:02 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:10:02 DEBUG : both0: Unchanged skipping 2022/01/13 06:10:02 DEBUG : both1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:02 DEBUG : both12: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:02 DEBUG : both1: Unchanged skipping 2022/01/13 06:10:02 DEBUG : both12: Unchanged skipping 2022/01/13 06:10:02 DEBUG : both14: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:02 DEBUG : both10: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:02 DEBUG : both10: Unchanged skipping 2022/01/13 06:10:02 DEBUG : both15: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:02 DEBUG : both15: Unchanged skipping 2022/01/13 06:10:02 DEBUG : both16: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:02 DEBUG : both16: Unchanged skipping 2022/01/13 06:10:02 DEBUG : both17: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:02 DEBUG : both17: Unchanged skipping 2022/01/13 06:10:02 DEBUG : both18: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:02 DEBUG : both18: Unchanged skipping 2022/01/13 06:10:02 DEBUG : both19: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:02 DEBUG : both19: Unchanged skipping 2022/01/13 06:10:02 DEBUG : both2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:02 DEBUG : both2: Unchanged skipping 2022/01/13 06:10:02 DEBUG : both3: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:02 DEBUG : both3: Unchanged skipping 2022/01/13 06:10:02 DEBUG : both4: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:02 DEBUG : both4: Unchanged skipping 2022/01/13 06:10:02 DEBUG : both5: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:02 DEBUG : both5: Unchanged skipping 2022/01/13 06:10:02 DEBUG : both6: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:02 DEBUG : both6: Unchanged skipping 2022/01/13 06:10:02 DEBUG : both7: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:02 DEBUG : both7: Unchanged skipping 2022/01/13 06:10:02 DEBUG : both13: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:02 DEBUG : both8: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:02 DEBUG : both8: Unchanged skipping 2022/01/13 06:10:02 DEBUG : both9: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:02 DEBUG : both9: Unchanged skipping 2022/01/13 06:10:02 DEBUG : both13: Unchanged skipping 2022/01/13 06:10:02 DEBUG : both14: Unchanged skipping 2022/01/13 06:10:02 DEBUG : both11: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:02 DEBUG : both11: Unchanged skipping 2022/01/13 06:10:02 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:10:02 DEBUG : Waiting for deletions to finish 2022/01/13 06:10:02 INFO : only14: Deleted 2022/01/13 06:10:03 INFO : only1: Deleted 2022/01/13 06:10:03 INFO : only12: Deleted 2022/01/13 06:10:03 INFO : only5: Deleted 2022/01/13 06:10:03 INFO : only3: Deleted 2022/01/13 06:10:03 INFO : only8: Deleted 2022/01/13 06:10:03 INFO : only9: Deleted 2022/01/13 06:10:03 INFO : only10: Deleted 2022/01/13 06:10:04 INFO : only19: Deleted 2022/01/13 06:10:04 INFO : only17: Deleted 2022/01/13 06:10:04 INFO : only2: Deleted 2022/01/13 06:10:04 INFO : only0: Deleted 2022/01/13 06:10:05 INFO : only4: Deleted 2022/01/13 06:10:05 INFO : only15: Deleted 2022/01/13 06:10:05 INFO : only11: Deleted 2022/01/13 06:10:05 INFO : only6: Deleted 2022/01/13 06:10:05 INFO : only7: Deleted 2022/01/13 06:10:05 INFO : only18: Deleted 2022/01/13 06:10:06 INFO : only13: Deleted 2022/01/13 06:10:07 INFO : only16: Deleted 2022/01/13 06:10:07 INFO : There was nothing to transfer --- PASS: TestSyncConcurrentDelete (41.40s) === RUN TestSyncConcurrentTruncate run.go:181: Remote "B2 bucket rclone-test-lewaley0bapivup8hexajuj9", Local "Local file system at /tmp/rclone1601322039", Modify Window "1ms" 2022/01/13 06:10:53 DEBUG : both0: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:53 DEBUG : both0: Unchanged skipping 2022/01/13 06:10:53 DEBUG : both12: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:53 DEBUG : both11: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:53 DEBUG : both11: Unchanged skipping 2022/01/13 06:10:53 DEBUG : both13: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:53 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for checks to finish 2022/01/13 06:10:53 DEBUG : both10: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:53 DEBUG : both10: Unchanged skipping 2022/01/13 06:10:53 DEBUG : both14: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:53 DEBUG : both14: Unchanged skipping 2022/01/13 06:10:53 DEBUG : both15: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:53 DEBUG : both15: Unchanged skipping 2022/01/13 06:10:53 DEBUG : both16: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:53 DEBUG : both16: Unchanged skipping 2022/01/13 06:10:53 DEBUG : both17: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:53 DEBUG : both17: Unchanged skipping 2022/01/13 06:10:53 DEBUG : both18: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:53 DEBUG : both18: Unchanged skipping 2022/01/13 06:10:53 DEBUG : both19: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:53 DEBUG : both19: Unchanged skipping 2022/01/13 06:10:53 DEBUG : both2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:53 DEBUG : both2: Unchanged skipping 2022/01/13 06:10:53 DEBUG : both3: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:53 DEBUG : both3: Unchanged skipping 2022/01/13 06:10:53 DEBUG : both4: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:53 DEBUG : both4: Unchanged skipping 2022/01/13 06:10:53 DEBUG : both5: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:53 DEBUG : both5: Unchanged skipping 2022/01/13 06:10:53 DEBUG : both6: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:53 DEBUG : both6: Unchanged skipping 2022/01/13 06:10:53 DEBUG : both7: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:53 DEBUG : both7: Unchanged skipping 2022/01/13 06:10:53 DEBUG : both8: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:53 DEBUG : both8: Unchanged skipping 2022/01/13 06:10:53 DEBUG : both9: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:53 DEBUG : both9: Unchanged skipping 2022/01/13 06:10:53 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2022/01/13 06:10:53 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2022/01/13 06:10:53 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2022/01/13 06:10:53 DEBUG : both13: Unchanged skipping 2022/01/13 06:10:53 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2022/01/13 06:10:53 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2022/01/13 06:10:53 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2022/01/13 06:10:53 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2022/01/13 06:10:53 DEBUG : both1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/01/13 06:10:53 DEBUG : both1: Unchanged skipping 2022/01/13 06:10:53 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2022/01/13 06:10:53 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2022/01/13 06:10:53 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2022/01/13 06:10:53 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2022/01/13 06:10:53 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2022/01/13 06:10:53 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2022/01/13 06:10:53 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2022/01/13 06:10:53 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2022/01/13 06:10:53 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2022/01/13 06:10:53 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2022/01/13 06:10:53 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2022/01/13 06:10:53 DEBUG : both12: Unchanged skipping 2022/01/13 06:10:53 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2022/01/13 06:10:53 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2022/01/13 06:10:53 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Waiting for transfers to finish 2022/01/13 06:10:54 DEBUG : only0: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/13 06:10:54 INFO : only0: Copied (replaced existing) 2022/01/13 06:10:54 DEBUG : only1: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/13 06:10:54 INFO : only1: Copied (replaced existing) 2022/01/13 06:10:54 DEBUG : only12: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/13 06:10:54 INFO : only12: Copied (replaced existing) 2022/01/13 06:10:55 DEBUG : only14: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/13 06:10:55 INFO : only14: Copied (replaced existing) 2022/01/13 06:10:55 DEBUG : only13: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/13 06:10:55 INFO : only13: Copied (replaced existing) 2022/01/13 06:10:55 DEBUG : only11: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/13 06:10:55 INFO : only11: Copied (replaced existing) 2022/01/13 06:10:55 DEBUG : only17: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/13 06:10:55 INFO : only17: Copied (replaced existing) 2022/01/13 06:10:55 DEBUG : only19: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/13 06:10:55 INFO : only19: Copied (replaced existing) 2022/01/13 06:10:55 DEBUG : only10: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/13 06:10:55 INFO : only10: Copied (replaced existing) 2022/01/13 06:10:56 DEBUG : only3: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/13 06:10:56 INFO : only3: Copied (replaced existing) 2022/01/13 06:10:56 DEBUG : only2: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/13 06:10:56 INFO : only2: Copied (replaced existing) 2022/01/13 06:10:56 DEBUG : only18: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/13 06:10:56 INFO : only18: Copied (replaced existing) 2022/01/13 06:10:56 DEBUG : only5: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/13 06:10:56 INFO : only5: Copied (replaced existing) 2022/01/13 06:10:56 DEBUG : only4: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/13 06:10:56 INFO : only4: Copied (replaced existing) 2022/01/13 06:10:56 DEBUG : only6: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/13 06:10:56 INFO : only6: Copied (replaced existing) 2022/01/13 06:10:57 DEBUG : only8: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/13 06:10:57 INFO : only8: Copied (replaced existing) 2022/01/13 06:10:57 DEBUG : only15: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/13 06:10:57 INFO : only15: Copied (replaced existing) 2022/01/13 06:10:57 DEBUG : only7: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/13 06:10:57 INFO : only7: Copied (replaced existing) 2022/01/13 06:10:57 DEBUG : only16: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/13 06:10:57 INFO : only16: Copied (replaced existing) 2022/01/13 06:10:59 DEBUG : only9: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/01/13 06:10:59 INFO : only9: Copied (replaced existing) 2022/01/13 06:10:59 DEBUG : Waiting for deletions to finish --- PASS: TestSyncConcurrentTruncate (64.78s) PASS 2022/01/13 06:11:25 DEBUG : B2 bucket rclone-test-lewaley0bapivup8hexajuj9: Purge remote 2022/01/13 06:11:26 DEBUG : BackupDir/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f100a37c1ee98c4e1_d20220113_m060724_c001_v0001120_t0008") 2022/01/13 06:11:26 DEBUG : BackupDir/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1002b0bb2172aff4_d20220113_m060716_c001_v0001039_t0006") 2022/01/13 06:11:26 DEBUG : CompareDest/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1010c460bcb41702_d20220113_m060651_c001_v0001144_t0042") 2022/01/13 06:11:26 DEBUG : CompareDest/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1167872680624190_d20220113_m060645_c001_v0001136_t0052") 2022/01/13 06:11:26 DEBUG : CompareDest/two: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11572d8bdc2422dd_d20220113_m060654_c001_v0001097_t0002") 2022/01/13 06:11:26 DEBUG : CompareDest/two: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571504_d20220113_m060646_c001_v0001109_t0000") 2022/01/13 06:11:26 DEBUG : CopyDest/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f119947a12ea769f2_d20220113_m060725_c001_v0001117_t0024") 2022/01/13 06:11:26 DEBUG : CopyDest/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e727857163d_d20220113_m060712_c001_v0001109_t0058") 2022/01/13 06:11:26 DEBUG : CopyDest/three: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1122cd0bb61df772_d20220113_m060727_c001_v0001097_t0039") 2022/01/13 06:11:26 DEBUG : CopyDest/three: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571699_d20220113_m060721_c001_v0001109_t0003") 2022/01/13 06:11:26 DEBUG : CopyDest/two: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1056fafa89dfd94d_d20220113_m060728_c001_v0001150_t0000") 2022/01/13 06:11:27 DEBUG : CopyDest/two: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11678726806241f4_d20220113_m060718_c001_v0001136_t0033") 2022/01/13 06:11:27 DEBUG : EXISTING: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11903cdd71ddfcc0_d20220113_m060938_c001_v0001157_t0025") 2022/01/13 06:11:27 DEBUG : EXISTING: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571c0a_d20220113_m060936_c001_v0001109_t0055") 2022/01/13 06:11:27 DEBUG : Testêé: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11733c70870ebecf_d20220113_m060933_c001_v0001113_t0003") 2022/01/13 06:11:27 DEBUG : Testêé: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571bce_d20220113_m060932_c001_v0001109_t0046") 2022/01/13 06:11:27 DEBUG : Testêé: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1167872680624335_d20220113_m060931_c001_v0001136_t0007") 2022/01/13 06:11:27 DEBUG : a/potato2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11797d79e1525d5a_d20220113_m060445_c001_v0001105_t0043") 2022/01/13 06:11:27 DEBUG : a/potato2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570e83_d20220113_m060444_c001_v0001109_t0036") 2022/01/13 06:11:27 DEBUG : a/potato2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1041d05f28099024_d20220113_m060442_c001_v0001013_t0004") 2022/01/13 06:11:27 DEBUG : a/potato2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570e3d_d20220113_m060440_c001_v0001109_t0014") 2022/01/13 06:11:27 DEBUG : a/potato2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11631e01165db176_d20220113_m060410_c001_v0001157_t0000") 2022/01/13 06:11:27 DEBUG : a/potato2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570c86_d20220113_m060407_c001_v0001109_t0014") 2022/01/13 06:11:27 DEBUG : b/potato: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11797d79e1525d82_d20220113_m060447_c001_v0001105_t0009") 2022/01/13 06:11:27 DEBUG : b/potato: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570e6e_d20220113_m060443_c001_v0001109_t0046") 2022/01/13 06:11:27 DEBUG : b/potato: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1180a1485422c352_d20220113_m060441_c001_v0001030_t0029") 2022/01/13 06:11:27 DEBUG : b/potato: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570e2a_d20220113_m060439_c001_v0001109_t0055") 2022/01/13 06:11:27 DEBUG : b/potato: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1119e88a74897866_d20220113_m060408_c001_v0001117_t0056") 2022/01/13 06:11:27 DEBUG : b/potato: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570c71_d20220113_m060406_c001_v0001109_t0049") 2022/01/13 06:11:27 DEBUG : backup/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f110e725a1bdb9bf9_d20220113_m060747_c001_v0001113_t0000") 2022/01/13 06:11:27 DEBUG : backup/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f114590969a6c0212_d20220113_m060740_c001_v0001109_t0004") 2022/01/13 06:11:28 DEBUG : backup/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11509f9c3e26e327_d20220113_m060735_c001_v0001092_t0049") 2022/01/13 06:11:28 DEBUG : backup/one-2019-01-01: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f111fc4d873d4fbe7_d20220113_m060825_c001_v0001109_t0037") 2022/01/13 06:11:28 DEBUG : backup/one-2019-01-01: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1006b496fc8b1bc5_d20220113_m060822_c001_v0001128_t0059") 2022/01/13 06:11:28 DEBUG : backup/one-2019-01-01: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1094c776b2cd83f9_d20220113_m060815_c001_v0001033_t0041") 2022/01/13 06:11:28 DEBUG : backup/one.bak: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f108da012fcd3c2af_d20220113_m060807_c001_v0001165_t0017") 2022/01/13 06:11:28 DEBUG : backup/one.bak: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1033948d0116e313_d20220113_m060802_c001_v0001109_t0019") 2022/01/13 06:11:28 DEBUG : backup/one.bak: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1037286013e53afc_d20220113_m060755_c001_v0001153_t0012") 2022/01/13 06:11:28 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1182ae0c3c631b41_d20220113_m060825_c001_v0001022_t0045") 2022/01/13 06:11:28 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f101d48d12a3623f2_d20220113_m060823_c001_v0001105_t0017") 2022/01/13 06:11:28 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10271f1a20fcd631_d20220113_m060819_c001_v0001032_t0028") 2022/01/13 06:11:28 DEBUG : backup/three.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1158e7a8cb8d2a8e_d20220113_m060747_c001_v0001165_t0000") 2022/01/13 06:11:28 DEBUG : backup/three.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f103f59c747a90067_d20220113_m060744_c001_v0001137_t0049") 2022/01/13 06:11:28 DEBUG : backup/three.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f113113993df2541b_d20220113_m060737_c001_v0001000_t0018") 2022/01/13 06:11:28 DEBUG : backup/three.txt.bak: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f100cb56336c41ff0_d20220113_m060808_c001_v0001097_t0044") 2022/01/13 06:11:28 DEBUG : backup/three.txt.bak: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f113745cef21dbf7e_d20220113_m060805_c001_v0001146_t0040") 2022/01/13 06:11:28 DEBUG : backup/three.txt.bak: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11958106b06d7690_d20220113_m060758_c001_v0001130_t0045") 2022/01/13 06:11:28 DEBUG : both0: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f104e0a22742d6aef_d20220113_m061100_c001_v0001105_t0017") 2022/01/13 06:11:28 DEBUG : both0: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11678726806243d8_d20220113_m061021_c001_v0001136_t0057") 2022/01/13 06:11:29 DEBUG : both0: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f114cf5f4d67ceadf_d20220113_m061009_c001_v0001032_t0013") 2022/01/13 06:11:29 DEBUG : both0: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1167872680624356_d20220113_m060939_c001_v0001136_t0047") 2022/01/13 06:11:29 DEBUG : both1: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10790bcbe6ca62e0_d20220113_m061101_c001_v0001150_t0046") 2022/01/13 06:11:29 DEBUG : both1: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11678726806243df_d20220113_m061024_c001_v0001136_t0044") 2022/01/13 06:11:29 DEBUG : both1: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11012dfc3c596333_d20220113_m061009_c001_v0001105_t0011") 2022/01/13 06:11:29 DEBUG : both1: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f116787268062435b_d20220113_m060940_c001_v0001136_t0049") 2022/01/13 06:11:29 DEBUG : both10: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11797b246fcbb1df_d20220113_m061101_c001_v0001165_t0055") 2022/01/13 06:11:29 DEBUG : both10: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1167872680624415_d20220113_m061038_c001_v0001136_t0027") 2022/01/13 06:11:29 DEBUG : both10: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10081dd545bcbc54_d20220113_m061010_c001_v0001109_t0047") 2022/01/13 06:11:29 DEBUG : both10: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1167872680624380_d20220113_m060949_c001_v0001136_t0052") 2022/01/13 06:11:29 DEBUG : both11: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f101d48d12a3633e8_d20220113_m061102_c001_v0001105_t0039") 2022/01/13 06:11:29 DEBUG : both11: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1167872680624418_d20220113_m061039_c001_v0001136_t0046") 2022/01/13 06:11:29 DEBUG : both11: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1129720b540b97b6_d20220113_m061011_c001_v0001044_t0049") 2022/01/13 06:11:29 DEBUG : both11: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1167872680624382_d20220113_m060950_c001_v0001136_t0046") 2022/01/13 06:11:29 DEBUG : both12: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1035defc481cead3_d20220113_m061103_c001_v0001150_t0003") 2022/01/13 06:11:29 DEBUG : both12: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f116787268062441d_d20220113_m061040_c001_v0001136_t0037") 2022/01/13 06:11:29 DEBUG : both12: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f104e0a22742d6571_d20220113_m061011_c001_v0001105_t0058") 2022/01/13 06:11:29 DEBUG : both12: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1167872680624389_d20220113_m060951_c001_v0001136_t0036") 2022/01/13 06:11:29 DEBUG : both13: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f101553daa8186c0a_d20220113_m061103_c001_v0001131_t0043") 2022/01/13 06:11:29 DEBUG : both13: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1167872680624424_d20220113_m061041_c001_v0001136_t0051") 2022/01/13 06:11:29 DEBUG : both13: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f100ce1ab6095cdc7_d20220113_m061012_c001_v0001105_t0025") 2022/01/13 06:11:29 DEBUG : both13: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f116787268062438b_d20220113_m060952_c001_v0001136_t0038") 2022/01/13 06:11:30 DEBUG : both14: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f117c2a3cb50223b2_d20220113_m061103_c001_v0001157_t0007") 2022/01/13 06:11:30 DEBUG : both14: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f116787268062442a_d20220113_m061043_c001_v0001136_t0054") 2022/01/13 06:11:30 DEBUG : both14: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f119947a12ea77160_d20220113_m061013_c001_v0001117_t0041") 2022/01/13 06:11:30 DEBUG : both14: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1167872680624393_d20220113_m060953_c001_v0001136_t0002") 2022/01/13 06:11:30 DEBUG : both15: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f110e9ec12bcf03b3_d20220113_m061104_c001_v0001098_t0035") 2022/01/13 06:11:30 DEBUG : both15: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f116787268062442e_d20220113_m061044_c001_v0001136_t0042") 2022/01/13 06:11:30 DEBUG : both15: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11076ad9815c9a24_d20220113_m061014_c001_v0001150_t0044") 2022/01/13 06:11:30 DEBUG : both15: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f116787268062439b_d20220113_m060954_c001_v0001136_t0014") 2022/01/13 06:11:30 DEBUG : both16: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f118cc1900b53e684_d20220113_m061104_c001_v0001128_t0022") 2022/01/13 06:11:30 DEBUG : both16: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1167872680624431_d20220113_m061046_c001_v0001136_t0015") 2022/01/13 06:11:30 DEBUG : both16: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f107b819eba9b4fa4_d20220113_m061014_c001_v0001098_t0030") 2022/01/13 06:11:30 DEBUG : both16: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f116787268062439d_d20220113_m060955_c001_v0001136_t0051") 2022/01/13 06:11:30 DEBUG : both17: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1042848dbf18382f_d20220113_m061104_c001_v0001033_t0004") 2022/01/13 06:11:30 DEBUG : both17: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1167872680624437_d20220113_m061047_c001_v0001136_t0027") 2022/01/13 06:11:30 DEBUG : both17: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1024e49d62adf0f9_d20220113_m061014_c001_v0001113_t0044") 2022/01/13 06:11:30 DEBUG : both17: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11678726806243a1_d20220113_m060956_c001_v0001136_t0000") 2022/01/13 06:11:30 DEBUG : both18: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11797b246fcbb20d_d20220113_m061105_c001_v0001165_t0025") 2022/01/13 06:11:30 DEBUG : both18: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1167872680624447_d20220113_m061051_c001_v0001136_t0034") 2022/01/13 06:11:30 DEBUG : both18: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f114c17c97228706b_d20220113_m061015_c001_v0001165_t0003") 2022/01/13 06:11:30 DEBUG : both18: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11678726806243a9_d20220113_m060959_c001_v0001136_t0005") 2022/01/13 06:11:30 DEBUG : both19: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1115f2f71a72ad0e_d20220113_m061105_c001_v0001105_t0008") 2022/01/13 06:11:31 DEBUG : both19: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f116787268062444c_d20220113_m061052_c001_v0001136_t0003") 2022/01/13 06:11:31 DEBUG : both19: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f113cc887a487289e_d20220113_m061015_c001_v0001137_t0055") 2022/01/13 06:11:31 DEBUG : both19: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11678726806243ae_d20220113_m061000_c001_v0001136_t0009") 2022/01/13 06:11:31 DEBUG : both2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f119bf407cb346f88_d20220113_m061108_c001_v0001153_t0019") 2022/01/13 06:11:31 DEBUG : both2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11678726806243e3_d20220113_m061026_c001_v0001136_t0007") 2022/01/13 06:11:31 DEBUG : both2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f100cb56336c424e9_d20220113_m061015_c001_v0001097_t0009") 2022/01/13 06:11:31 DEBUG : both2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f116787268062435e_d20220113_m060941_c001_v0001136_t0000") 2022/01/13 06:11:31 DEBUG : both3: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11572d8bdc242c7c_d20220113_m061108_c001_v0001097_t0002") 2022/01/13 06:11:31 DEBUG : both3: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11678726806243f0_d20220113_m061028_c001_v0001136_t0027") 2022/01/13 06:11:31 DEBUG : both3: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f111ad702e024e7d5_d20220113_m061016_c001_v0001097_t0049") 2022/01/13 06:11:31 DEBUG : both3: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1167872680624363_d20220113_m060941_c001_v0001136_t0055") 2022/01/13 06:11:31 DEBUG : both4: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f104a385dc2611bf4_d20220113_m061109_c001_v0001154_t0011") 2022/01/13 06:11:31 DEBUG : both4: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11678726806243f4_d20220113_m061031_c001_v0001136_t0001") 2022/01/13 06:11:31 DEBUG : both4: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f100ef97a4ae2c9ef_d20220113_m061017_c001_v0001150_t0041") 2022/01/13 06:11:31 DEBUG : both4: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1167872680624365_d20220113_m060942_c001_v0001136_t0028") 2022/01/13 06:11:31 DEBUG : both5: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1056b8c974386d7b_d20220113_m061109_c001_v0001134_t0023") 2022/01/13 06:11:31 DEBUG : both5: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11678726806243f6_d20220113_m061032_c001_v0001136_t0042") 2022/01/13 06:11:31 DEBUG : both5: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f116c74a6b33799d6_d20220113_m061017_c001_v0001145_t0034") 2022/01/13 06:11:32 DEBUG : both5: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f116787268062436f_d20220113_m060944_c001_v0001136_t0026") 2022/01/13 06:11:32 DEBUG : both6: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10157797a8826e15_d20220113_m061109_c001_v0001039_t0023") 2022/01/13 06:11:32 DEBUG : both6: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11678726806243f9_d20220113_m061033_c001_v0001136_t0020") 2022/01/13 06:11:32 DEBUG : both6: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f105d7412138a5ac0_d20220113_m061018_c001_v0001032_t0030") 2022/01/13 06:11:32 DEBUG : both6: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1167872680624371_d20220113_m060945_c001_v0001136_t0017") 2022/01/13 06:11:32 DEBUG : both7: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1170d046be2e0343_d20220113_m061110_c001_v0001161_t0021") 2022/01/13 06:11:32 DEBUG : both7: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1167872680624401_d20220113_m061034_c001_v0001136_t0039") 2022/01/13 06:11:32 DEBUG : both7: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1133f8d15b56813a_d20220113_m061019_c001_v0001105_t0018") 2022/01/13 06:11:32 DEBUG : both7: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1167872680624377_d20220113_m060946_c001_v0001136_t0018") 2022/01/13 06:11:32 DEBUG : both8: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f101e67130aa105f6_d20220113_m061110_c001_v0001097_t0009") 2022/01/13 06:11:32 DEBUG : both8: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1167872680624404_d20220113_m061035_c001_v0001136_t0011") 2022/01/13 06:11:32 DEBUG : both8: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f119ce1a3eaa88334_d20220113_m061019_c001_v0001105_t0027") 2022/01/13 06:11:32 DEBUG : both8: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f116787268062437a_d20220113_m060947_c001_v0001136_t0044") 2022/01/13 06:11:32 DEBUG : both9: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f119d07f6ecd0ba1f_d20220113_m061110_c001_v0001150_t0024") 2022/01/13 06:11:32 DEBUG : both9: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1167872680624408_d20220113_m061036_c001_v0001136_t0054") 2022/01/13 06:11:32 DEBUG : both9: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1012760b4ac7579b_d20220113_m061020_c001_v0001093_t0041") 2022/01/13 06:11:32 DEBUG : both9: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f116787268062437e_d20220113_m060948_c001_v0001136_t0058") 2022/01/13 06:11:32 DEBUG : c/non empty space: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1052e7dbfbd82289_d20220113_m060447_c001_v0001146_t0008") 2022/01/13 06:11:32 DEBUG : c/non empty space: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570e74_d20220113_m060443_c001_v0001109_t0019") 2022/01/13 06:11:32 DEBUG : c/non empty space: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f104576c6f2e9419c_d20220113_m060442_c001_v0001117_t0045") 2022/01/13 06:11:32 DEBUG : c/non empty space: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570e35_d20220113_m060439_c001_v0001109_t0058") 2022/01/13 06:11:33 DEBUG : c/non empty space: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f109c4b9e01e88b20_d20220113_m060410_c001_v0001026_t0026") 2022/01/13 06:11:33 DEBUG : c/non empty space: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570c7b_d20220113_m060406_c001_v0001109_t0047") 2022/01/13 06:11:33 DEBUG : check sum: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f119ce1a3eaa8548d_d20220113_m060356_c001_v0001105_t0016") 2022/01/13 06:11:33 DEBUG : check sum: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570be7_d20220113_m060355_c001_v0001109_t0038") 2022/01/13 06:11:33 DEBUG : dest/3: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f118541851ced3fd9_d20220113_m060704_c001_v0001090_t0018") 2022/01/13 06:11:33 DEBUG : dest/3: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1175ded1c18d9f10_d20220113_m060703_c001_v0001144_t0057") 2022/01/13 06:11:33 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f114ee64f3c6bb638_d20220113_m060925_c001_v0001105_t0047") 2022/01/13 06:11:33 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f118912261da666f1_d20220113_m060922_c001_v0001025_t0034") 2022/01/13 06:11:33 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11776354f5f3963f_d20220113_m060921_c001_v0001128_t0056") 2022/01/13 06:11:33 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f118912261da666ed_d20220113_m060917_c001_v0001025_t0024") 2022/01/13 06:11:33 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f116ce72b8d215bc8_d20220113_m060916_c001_v0001044_t0025") 2022/01/13 06:11:33 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571ae3_d20220113_m060910_c001_v0001109_t0056") 2022/01/13 06:11:33 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f104966f8bdfde8ac_d20220113_m060903_c001_v0001042_t0053") 2022/01/13 06:11:33 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1186e43dff7e3459_d20220113_m060901_c001_v0001105_t0052") 2022/01/13 06:11:33 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10471d5c8aceae7c_d20220113_m060900_c001_v0001039_t0042") 2022/01/13 06:11:33 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1186e43dff7e33d1_d20220113_m060855_c001_v0001105_t0005") 2022/01/13 06:11:33 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11283d5a77e0c918_d20220113_m060854_c001_v0001040_t0030") 2022/01/13 06:11:33 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11678726806242b0_d20220113_m060848_c001_v0001136_t0053") 2022/01/13 06:11:33 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11835a5b25f744f6_d20220113_m060844_c001_v0001117_t0009") 2022/01/13 06:11:33 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1112977eb6a97316_d20220113_m060840_c001_v0001098_t0038") 2022/01/13 06:11:33 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11375d07b738ebd2_d20220113_m060839_c001_v0001165_t0054") 2022/01/13 06:11:33 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1112977eb6a972f8_d20220113_m060835_c001_v0001098_t0040") 2022/01/13 06:11:34 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f108fceb1ef8595fb_d20220113_m060832_c001_v0001117_t0027") 2022/01/13 06:11:34 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f116787268062428d_d20220113_m060828_c001_v0001136_t0015") 2022/01/13 06:11:34 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f118a3c373b11258a_d20220113_m060827_c001_v0001157_t0056") 2022/01/13 06:11:34 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1187a902ab4e40d0_d20220113_m060823_c001_v0001131_t0005") 2022/01/13 06:11:34 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f102e8c11ad84e4ca_d20220113_m060822_c001_v0001144_t0057") 2022/01/13 06:11:34 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1187a902ab4e40b0_d20220113_m060818_c001_v0001131_t0032") 2022/01/13 06:11:34 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f102ddffe7b2e8a28_d20220113_m060817_c001_v0001131_t0006") 2022/01/13 06:11:34 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1167872680624265_d20220113_m060810_c001_v0001136_t0047") 2022/01/13 06:11:34 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f118a3c373b11253e_d20220113_m060808_c001_v0001157_t0002") 2022/01/13 06:11:34 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1015be620f973955_d20220113_m060804_c001_v0001137_t0052") 2022/01/13 06:11:34 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f101c482e98b2ccb7_d20220113_m060803_c001_v0001044_t0032") 2022/01/13 06:11:34 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1015be620f97393b_d20220113_m060757_c001_v0001137_t0004") 2022/01/13 06:11:34 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11012dfc3c595596_d20220113_m060755_c001_v0001105_t0013") 2022/01/13 06:11:34 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f116787268062423c_d20220113_m060750_c001_v0001136_t0016") 2022/01/13 06:11:34 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f115ac477b78142d4_d20220113_m060748_c001_v0001105_t0024") 2022/01/13 06:11:34 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f109c38c35e4f01da_d20220113_m060743_c001_v0001098_t0031") 2022/01/13 06:11:34 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f103c199938a11dc2_d20220113_m060741_c001_v0001105_t0051") 2022/01/13 06:11:34 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f109c38c35e4f01a9_d20220113_m060736_c001_v0001098_t0052") 2022/01/13 06:11:34 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f104ccde4958f469b_d20220113_m060735_c001_v0001157_t0017") 2022/01/13 06:11:34 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1167872680624218_d20220113_m060730_c001_v0001136_t0058") 2022/01/13 06:11:35 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f100fc5804b34fa04_d20220113_m060728_c001_v0001019_t0026") 2022/01/13 06:11:35 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f114c17c972286a53_d20220113_m060717_c001_v0001165_t0058") 2022/01/13 06:11:35 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f116ef10569bf16b5_d20220113_m060716_c001_v0001040_t0008") 2022/01/13 06:11:35 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11678726806241dd_d20220113_m060712_c001_v0001136_t0011") 2022/01/13 06:11:35 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f101e67130aa0fe94_d20220113_m060710_c001_v0001097_t0018") 2022/01/13 06:11:35 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f101e67130aa0fe89_d20220113_m060709_c001_v0001097_t0003") 2022/01/13 06:11:35 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10081dd545bcb232_d20220113_m060656_c001_v0001109_t0041") 2022/01/13 06:11:35 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e72785714e8_d20220113_m060644_c001_v0001109_t0000") 2022/01/13 06:11:35 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f110e9ec12bcefb34_d20220113_m060642_c001_v0001098_t0058") 2022/01/13 06:11:35 DEBUG : dst/one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f110e9ec12bcefb25_d20220113_m060641_c001_v0001098_t0034") 2022/01/13 06:11:35 DEBUG : dst/one-2019-01-01: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1033948d0116e617_d20220113_m060926_c001_v0001109_t0044") 2022/01/13 06:11:35 DEBUG : dst/one-2019-01-01: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f107a009d3a0f3f59_d20220113_m060921_c001_v0001105_t0019") 2022/01/13 06:11:35 DEBUG : dst/one-2019-01-01: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1092860db7128d1d_d20220113_m060915_c001_v0001161_t0017") 2022/01/13 06:11:35 DEBUG : dst/one.bak: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10875e538aba6c7d_d20220113_m060907_c001_v0001105_t0033") 2022/01/13 06:11:35 DEBUG : dst/one.bak: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1119e88a7489851c_d20220113_m060859_c001_v0001117_t0020") 2022/01/13 06:11:35 DEBUG : dst/one.bak: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f108a49fa886eea8c_d20220113_m060853_c001_v0001044_t0023") 2022/01/13 06:11:35 DEBUG : dst/one.bak: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1186e43dff7e32b5_d20220113_m060845_c001_v0001105_t0051") 2022/01/13 06:11:35 DEBUG : dst/one.bak: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f107a009d3a0f3a88_d20220113_m060838_c001_v0001105_t0059") 2022/01/13 06:11:36 DEBUG : dst/one.bak: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1087dce2859585f7_d20220113_m060832_c001_v0001137_t0036") 2022/01/13 06:11:36 DEBUG : dst/three: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f111b55150ee5d7fd_d20220113_m060729_c001_v0001165_t0008") 2022/01/13 06:11:36 DEBUG : dst/three: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f101e67130aa0fef3_d20220113_m060723_c001_v0001097_t0024") 2022/01/13 06:11:36 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1017110bee16eb3b_d20220113_m060926_c001_v0001117_t0016") 2022/01/13 06:11:36 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f100faef61cda16a3_d20220113_m060923_c001_v0001137_t0023") 2022/01/13 06:11:36 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f100d9c36ec5dcea6_d20220113_m060919_c001_v0001161_t0038") 2022/01/13 06:11:36 DEBUG : dst/three.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f104ced6360d6513e_d20220113_m060929_c001_v0001092_t0014") 2022/01/13 06:11:36 DEBUG : dst/three.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f118912261da666f3_d20220113_m060924_c001_v0001025_t0027") 2022/01/13 06:11:36 DEBUG : dst/three.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10200b2bb8904aec_d20220113_m060923_c001_v0001161_t0018") 2022/01/13 06:11:36 DEBUG : dst/three.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f118912261da666ef_d20220113_m060920_c001_v0001025_t0032") 2022/01/13 06:11:36 DEBUG : dst/three.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1025601e0a2589f2_d20220113_m060919_c001_v0001098_t0032") 2022/01/13 06:11:36 DEBUG : dst/three.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571af1_d20220113_m060912_c001_v0001109_t0034") 2022/01/13 06:11:36 DEBUG : dst/three.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f107a009d3a0f3e0f_d20220113_m060908_c001_v0001105_t0015") 2022/01/13 06:11:36 DEBUG : dst/three.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1186e43dff7e3492_d20220113_m060903_c001_v0001105_t0019") 2022/01/13 06:11:36 DEBUG : dst/three.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f116696faf3833fff_d20220113_m060902_c001_v0001109_t0053") 2022/01/13 06:11:36 DEBUG : dst/three.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1186e43dff7e340f_d20220113_m060858_c001_v0001105_t0033") 2022/01/13 06:11:36 DEBUG : dst/three.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1186e43dff7e3404_d20220113_m060857_c001_v0001105_t0050") 2022/01/13 06:11:37 DEBUG : dst/three.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11678726806242b4_d20220113_m060849_c001_v0001136_t0044") 2022/01/13 06:11:37 DEBUG : dst/three.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11600f323f88a01e_d20220113_m060843_c001_v0001105_t0045") 2022/01/13 06:11:37 DEBUG : dst/three.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571965_d20220113_m060837_c001_v0001109_t0026") 2022/01/13 06:11:37 DEBUG : dst/three.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1133f8d15b5676f6_d20220113_m060835_c001_v0001105_t0042") 2022/01/13 06:11:37 DEBUG : dst/three.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1167872680624291_d20220113_m060830_c001_v0001136_t0051") 2022/01/13 06:11:37 DEBUG : dst/three.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f102bb1c81e45bb62_d20220113_m060824_c001_v0001165_t0044") 2022/01/13 06:11:37 DEBUG : dst/three.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e72785718c0_d20220113_m060820_c001_v0001109_t0052") 2022/01/13 06:11:37 DEBUG : dst/three.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1017110bee16e7dd_d20220113_m060819_c001_v0001117_t0052") 2022/01/13 06:11:37 DEBUG : dst/three.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f116787268062426b_d20220113_m060811_c001_v0001136_t0019") 2022/01/13 06:11:37 DEBUG : dst/three.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1186e43dff7e2ed5_d20220113_m060805_c001_v0001105_t0059") 2022/01/13 06:11:38 DEBUG : dst/three.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e727857180c_d20220113_m060800_c001_v0001109_t0035") 2022/01/13 06:11:38 DEBUG : dst/three.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f109c38c35e4f026c_d20220113_m060759_c001_v0001098_t0047") 2022/01/13 06:11:38 DEBUG : dst/three.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1167872680624240_d20220113_m060751_c001_v0001136_t0058") 2022/01/13 06:11:38 DEBUG : dst/three.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11345816d22df239_d20220113_m060746_c001_v0001092_t0047") 2022/01/13 06:11:38 DEBUG : dst/three.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571740_d20220113_m060739_c001_v0001109_t0040") 2022/01/13 06:11:38 DEBUG : dst/three.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1036f52bcafa44b9_d20220113_m060737_c001_v0001097_t0028") 2022/01/13 06:11:38 DEBUG : dst/three.txt: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f116787268062421a_d20220113_m060731_c001_v0001136_t0037") 2022/01/13 06:11:38 DEBUG : dst/three.txt.bak: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1005e9753cc41f63_d20220113_m060909_c001_v0001165_t0047") 2022/01/13 06:11:38 DEBUG : dst/three.txt.bak: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1073ffb5ee491d6e_d20220113_m060902_c001_v0001165_t0058") 2022/01/13 06:11:38 DEBUG : dst/three.txt.bak: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f119fc4154b889329_d20220113_m060857_c001_v0001134_t0008") 2022/01/13 06:11:38 DEBUG : dst/three.txt.bak: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f103c199938a12424_d20220113_m060845_c001_v0001105_t0012") 2022/01/13 06:11:38 DEBUG : dst/three.txt.bak: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f102aa092ed85d6da_d20220113_m060840_c001_v0001097_t0054") 2022/01/13 06:11:38 DEBUG : dst/three.txt.bak: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1115f2f71a729cf3_d20220113_m060835_c001_v0001105_t0022") 2022/01/13 06:11:38 DEBUG : dst/two: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f109a0bd6abc0957f_d20220113_m060929_c001_v0001146_t0046") 2022/01/13 06:11:38 DEBUG : dst/two: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11678726806242f4_d20220113_m060911_c001_v0001136_t0057") 2022/01/13 06:11:38 DEBUG : dst/two: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10369698e2f01ed0_d20220113_m060909_c001_v0001146_t0049") 2022/01/13 06:11:38 DEBUG : dst/two: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e72785719f3_d20220113_m060848_c001_v0001109_t0015") 2022/01/13 06:11:38 DEBUG : dst/two: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f113ea5ba5269b281_d20220113_m060847_c001_v0001131_t0003") 2022/01/13 06:11:38 DEBUG : dst/two: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571916_d20220113_m060829_c001_v0001109_t0037") 2022/01/13 06:11:38 DEBUG : dst/two: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f116809e7a3cdcf53_d20220113_m060827_c001_v0001131_t0056") 2022/01/13 06:11:38 DEBUG : dst/two: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571866_d20220113_m060811_c001_v0001109_t0002") 2022/01/13 06:11:38 DEBUG : dst/two: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f100d42226e341376_d20220113_m060809_c001_v0001031_t0036") 2022/01/13 06:11:39 DEBUG : dst/two: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e72785717a6_d20220113_m060750_c001_v0001109_t0054") 2022/01/13 06:11:39 DEBUG : dst/two: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f112ce198d136253e_d20220113_m060749_c001_v0001146_t0055") 2022/01/13 06:11:39 DEBUG : dst/two: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571701_d20220113_m060731_c001_v0001109_t0040") 2022/01/13 06:11:39 DEBUG : dst/two: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11797b246fcba6bd_d20220113_m060729_c001_v0001165_t0035") 2022/01/13 06:11:39 DEBUG : dst/two: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f116ea032280c8d78_d20220113_m060719_c001_v0001117_t0022") 2022/01/13 06:11:39 DEBUG : dst/two: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1123a08f95af34c6_d20220113_m060656_c001_v0001165_t0005") 2022/01/13 06:11:39 DEBUG : dst/two: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f110e9ec12bcefb74_d20220113_m060650_c001_v0001098_t0041") 2022/01/13 06:11:39 DEBUG : empty space: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f110785a007864e5f_d20220113_m060624_c001_v0001157_t0026") 2022/01/13 06:11:39 DEBUG : empty space: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1167872680624158_d20220113_m060620_c001_v0001136_t0057") 2022/01/13 06:11:39 DEBUG : empty space: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f115fe84a3e4761cc_d20220113_m060617_c001_v0001144_t0052") 2022/01/13 06:11:39 DEBUG : empty space: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571355_d20220113_m060606_c001_v0001109_t0040") 2022/01/13 06:11:39 DEBUG : empty space: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f116b55c20abbd514_d20220113_m060553_c001_v0001042_t0033") 2022/01/13 06:11:39 DEBUG : empty space: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1167872680624111_d20220113_m060549_c001_v0001136_t0011") 2022/01/13 06:11:39 DEBUG : empty space: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1103e6f7bef5fb0a_d20220113_m060511_c001_v0001044_t0044") 2022/01/13 06:11:39 DEBUG : empty space: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571017_d20220113_m060509_c001_v0001109_t0052") 2022/01/13 06:11:39 DEBUG : empty space: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f115285fd1f066845_d20220113_m060506_c001_v0001130_t0057") 2022/01/13 06:11:39 DEBUG : empty space: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570fdf_d20220113_m060504_c001_v0001109_t0057") 2022/01/13 06:11:39 DEBUG : empty space: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1180c2581f372961_d20220113_m060457_c001_v0001165_t0057") 2022/01/13 06:11:39 DEBUG : empty space: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570f28_d20220113_m060453_c001_v0001109_t0054") 2022/01/13 06:11:39 DEBUG : empty space: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f114ee64f3c6b9203_d20220113_m060450_c001_v0001105_t0004") 2022/01/13 06:11:39 DEBUG : empty space: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570ed3_d20220113_m060449_c001_v0001109_t0043") 2022/01/13 06:11:40 DEBUG : empty space: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f114072d592fe2943_d20220113_m060438_c001_v0001131_t0024") 2022/01/13 06:11:40 DEBUG : empty space: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570df8_d20220113_m060435_c001_v0001109_t0004") 2022/01/13 06:11:40 DEBUG : empty space: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1050b710db64c747_d20220113_m060434_c001_v0001097_t0019") 2022/01/13 06:11:40 DEBUG : empty space: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570dd0_d20220113_m060433_c001_v0001109_t0040") 2022/01/13 06:11:40 DEBUG : empty space: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f109496c3ddebd13f_d20220113_m060426_c001_v0001131_t0046") 2022/01/13 06:11:40 DEBUG : empty space: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570d45_d20220113_m060425_c001_v0001109_t0045") 2022/01/13 06:11:40 DEBUG : empty space: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f103a8c5cb4aabd12_d20220113_m060416_c001_v0001042_t0046") 2022/01/13 06:11:40 DEBUG : empty space: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570ccb_d20220113_m060415_c001_v0001109_t0041") 2022/01/13 06:11:40 DEBUG : empty space: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f115a47e7b6e26431_d20220113_m060414_c001_v0001098_t0047") 2022/01/13 06:11:40 DEBUG : empty space: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1158e7a8cb8d214b_d20220113_m060413_c001_v0001165_t0002") 2022/01/13 06:11:40 DEBUG : empty space: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570cab_d20220113_m060411_c001_v0001109_t0042") 2022/01/13 06:11:40 DEBUG : enormous: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f106c1a1897422d3b_d20220113_m060510_c001_v0001093_t0054") 2022/01/13 06:11:40 DEBUG : enormous: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e727857101d_d20220113_m060509_c001_v0001109_t0051") 2022/01/13 06:11:40 DEBUG : existing: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10404e88077fc917_d20220113_m060936_c001_v0001097_t0019") 2022/01/13 06:11:40 DEBUG : existing: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f116787268062433d_d20220113_m060934_c001_v0001136_t0025") 2022/01/13 06:11:40 DEBUG : existing: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1025601e0a258043_d20220113_m060546_c001_v0001098_t0046") 2022/01/13 06:11:40 DEBUG : existing: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1167872680624108_d20220113_m060545_c001_v0001136_t0025") 2022/01/13 06:11:40 DEBUG : existing: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1177b2097f8423bb_d20220113_m060405_c001_v0001130_t0025") 2022/01/13 06:11:40 DEBUG : existing: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570c54_d20220113_m060404_c001_v0001109_t0037") 2022/01/13 06:11:40 DEBUG : existing: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f117a1dcefa8b1ff8_d20220113_m060403_c001_v0001131_t0035") 2022/01/13 06:11:41 DEBUG : existing: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570c44_d20220113_m060402_c001_v0001109_t0055") 2022/01/13 06:11:41 DEBUG : existing: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570c35_d20220113_m060401_c001_v0001109_t0044") 2022/01/13 06:11:41 DEBUG : existing-b: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f106498166b6c0ead_d20220113_m060546_c001_v0001011_t0007") 2022/01/13 06:11:41 DEBUG : existing-b: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e727857124a_d20220113_m060545_c001_v0001109_t0049") 2022/01/13 06:11:41 DEBUG : five: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f100ac1c7a68f8d5a_d20220113_m060518_c001_v0001146_t0023") 2022/01/13 06:11:41 DEBUG : five: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e727857107b_d20220113_m060515_c001_v0001109_t0008") 2022/01/13 06:11:41 DEBUG : foo: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f115fe84a3e475f5b_d20220113_m060424_c001_v0001144_t0056") 2022/01/13 06:11:41 DEBUG : foo: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570d29_d20220113_m060423_c001_v0001109_t0039") 2022/01/13 06:11:41 DEBUG : foo: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570d1b_d20220113_m060422_c001_v0001109_t0003") 2022/01/13 06:11:41 DEBUG : four: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f118e086ef61cf789_d20220113_m060519_c001_v0001154_t0016") 2022/01/13 06:11:41 DEBUG : four: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1144fbc88177e5c3_d20220113_m060517_c001_v0001150_t0012") 2022/01/13 06:11:41 DEBUG : four: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e727857106d_d20220113_m060514_c001_v0001109_t0023") 2022/01/13 06:11:41 DEBUG : hello world2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f102aa092ed85cb12_d20220113_m060334_c001_v0001097_t0004") 2022/01/13 06:11:41 DEBUG : hello world2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570a99_d20220113_m060331_c001_v0001109_t0041") 2022/01/13 06:11:41 DEBUG : ignore-size: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f101d9a9db4f4196a_d20220113_m060400_c001_v0001165_t0046") 2022/01/13 06:11:41 DEBUG : ignore-size: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570c27_d20220113_m060359_c001_v0001109_t0002") 2022/01/13 06:11:41 DEBUG : nested/sub dir/file: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f113c278bb70edbe8_d20220113_m060543_c001_v0001130_t0024") 2022/01/13 06:11:42 DEBUG : nested/sub dir/file: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1167872680624101_d20220113_m060542_c001_v0001136_t0001") 2022/01/13 06:11:42 DEBUG : nested/sub dir/file: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1144e6788a7095c4_d20220113_m060540_c001_v0001161_t0041") 2022/01/13 06:11:42 DEBUG : nested/sub dir/file: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e72785711f1_d20220113_m060539_c001_v0001109_t0022") 2022/01/13 06:11:42 DEBUG : one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1159689b389142fb_d20220113_m060519_c001_v0001090_t0001") 2022/01/13 06:11:42 DEBUG : one: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571052_d20220113_m060512_c001_v0001109_t0055") 2022/01/13 06:11:42 DEBUG : only0: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f104e0a22742d6c69_d20220113_m061111_c001_v0001105_t0025") 2022/01/13 06:11:42 DEBUG : only0: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1167872680624458_d20220113_m061054_c001_v0001136_t0037") 2022/01/13 06:11:42 DEBUG : only0: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571df3_d20220113_m061023_c001_v0001109_t0009") 2022/01/13 06:11:42 DEBUG : only0: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11903cdd71ddfd5a_d20220113_m061004_c001_v0001157_t0007") 2022/01/13 06:11:42 DEBUG : only0: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571c2a_d20220113_m060939_c001_v0001109_t0028") 2022/01/13 06:11:42 DEBUG : only1: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10627b2d93db03d2_d20220113_m061112_c001_v0001117_t0029") 2022/01/13 06:11:42 DEBUG : only1: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571f82_d20220113_m061054_c001_v0001109_t0048") 2022/01/13 06:11:42 DEBUG : only1: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571e09_d20220113_m061024_c001_v0001109_t0010") 2022/01/13 06:11:42 DEBUG : only1: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1089deb5f4121986_d20220113_m061002_c001_v0001113_t0011") 2022/01/13 06:11:42 DEBUG : only1: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571c36_d20220113_m060940_c001_v0001109_t0034") 2022/01/13 06:11:42 DEBUG : only10: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10875e538aba7900_d20220113_m061113_c001_v0001105_t0028") 2022/01/13 06:11:42 DEBUG : only10: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1058101fe1f7df37_d20220113_m061054_c001_v0001113_t0019") 2022/01/13 06:11:42 DEBUG : only10: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571ece_d20220113_m061038_c001_v0001109_t0008") 2022/01/13 06:11:42 DEBUG : only10: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f103deb101d43a955_d20220113_m061003_c001_v0001165_t0012") 2022/01/13 06:11:42 DEBUG : only10: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571cad_d20220113_m060949_c001_v0001109_t0003") 2022/01/13 06:11:42 DEBUG : only11: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1137019be0698989_d20220113_m061114_c001_v0001097_t0055") 2022/01/13 06:11:42 DEBUG : only11: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f115a47e7b6e27a1b_d20220113_m061055_c001_v0001098_t0020") 2022/01/13 06:11:43 DEBUG : only11: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571edb_d20220113_m061039_c001_v0001109_t0035") 2022/01/13 06:11:43 DEBUG : only11: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1115f2f71a72a701_d20220113_m061004_c001_v0001105_t0029") 2022/01/13 06:11:43 DEBUG : only11: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571cba_d20220113_m060950_c001_v0001109_t0035") 2022/01/13 06:11:43 DEBUG : only12: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10754f32ffeb9970_d20220113_m061118_c001_v0001113_t0058") 2022/01/13 06:11:43 DEBUG : only12: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571f8c_d20220113_m061054_c001_v0001109_t0039") 2022/01/13 06:11:43 DEBUG : only12: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571eed_d20220113_m061041_c001_v0001109_t0000") 2022/01/13 06:11:43 DEBUG : only12: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11544d86b3f876da_d20220113_m061002_c001_v0001038_t0052") 2022/01/13 06:11:43 DEBUG : only12: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571cc9_d20220113_m060951_c001_v0001109_t0034") 2022/01/13 06:11:43 DEBUG : only13: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1186a0d4eb19499b_d20220113_m061118_c001_v0001134_t0036") 2022/01/13 06:11:43 DEBUG : only13: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f116787268062445b_d20220113_m061054_c001_v0001136_t0020") 2022/01/13 06:11:43 DEBUG : only13: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571ef7_d20220113_m061042_c001_v0001109_t0023") 2022/01/13 06:11:43 DEBUG : only13: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f108f64e696fa8c11_d20220113_m061005_c001_v0001145_t0046") 2022/01/13 06:11:43 DEBUG : only13: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571cd7_d20220113_m060952_c001_v0001109_t0040") 2022/01/13 06:11:43 DEBUG : only14: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f108cfdacda50da5b_d20220113_m061119_c001_v0001146_t0042") 2022/01/13 06:11:43 DEBUG : only14: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571f91_d20220113_m061054_c001_v0001109_t0059") 2022/01/13 06:11:43 DEBUG : only14: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571f0a_d20220113_m061043_c001_v0001109_t0022") 2022/01/13 06:11:43 DEBUG : only14: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1096dddec1d72b80_d20220113_m061002_c001_v0001145_t0051") 2022/01/13 06:11:43 DEBUG : only14: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571ce5_d20220113_m060953_c001_v0001109_t0027") 2022/01/13 06:11:44 DEBUG : only15: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1143086c00b7ce0e_d20220113_m061119_c001_v0001130_t0031") 2022/01/13 06:11:44 DEBUG : only15: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571fb0_d20220113_m061056_c001_v0001109_t0021") 2022/01/13 06:11:44 DEBUG : only15: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571f1b_d20220113_m061045_c001_v0001109_t0059") 2022/01/13 06:11:44 DEBUG : only15: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11012dfc3c5962ed_d20220113_m061004_c001_v0001105_t0045") 2022/01/13 06:11:44 DEBUG : only15: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571cf1_d20220113_m060954_c001_v0001109_t0042") 2022/01/13 06:11:44 DEBUG : only16: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1195a57531f29bb3_d20220113_m061119_c001_v0001098_t0028") 2022/01/13 06:11:44 DEBUG : only16: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f115a47e7b6e27a44_d20220113_m061057_c001_v0001098_t0046") 2022/01/13 06:11:44 DEBUG : only16: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571f27_d20220113_m061046_c001_v0001109_t0037") 2022/01/13 06:11:44 DEBUG : only16: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1129b03e7ac82612_d20220113_m061005_c001_v0001105_t0049") 2022/01/13 06:11:44 DEBUG : only16: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571cf8_d20220113_m060955_c001_v0001109_t0039") 2022/01/13 06:11:44 DEBUG : only17: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11984a64293b5716_d20220113_m061120_c001_v0001165_t0023") 2022/01/13 06:11:44 DEBUG : only17: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571f9e_d20220113_m061055_c001_v0001109_t0036") 2022/01/13 06:11:44 DEBUG : only17: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571f35_d20220113_m061048_c001_v0001109_t0024") 2022/01/13 06:11:44 DEBUG : only17: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1067fb5d23628a1a_d20220113_m061003_c001_v0001105_t0055") 2022/01/13 06:11:44 DEBUG : only17: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571d08_d20220113_m060956_c001_v0001109_t0058") 2022/01/13 06:11:44 DEBUG : only18: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f109ae94d1570b0c6_d20220113_m061120_c001_v0001105_t0029") 2022/01/13 06:11:44 DEBUG : only18: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f116787268062445d_d20220113_m061055_c001_v0001136_t0027") 2022/01/13 06:11:44 DEBUG : only18: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571f67_d20220113_m061051_c001_v0001109_t0046") 2022/01/13 06:11:44 DEBUG : only18: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f109424515d982143_d20220113_m061003_c001_v0001097_t0048") 2022/01/13 06:11:44 DEBUG : only18: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571d28_d20220113_m060959_c001_v0001109_t0025") 2022/01/13 06:11:44 DEBUG : only19: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f110e9ec12bcf0440_d20220113_m061121_c001_v0001098_t0023") 2022/01/13 06:11:44 DEBUG : only19: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f115a47e7b6e27a21_d20220113_m061055_c001_v0001098_t0009") 2022/01/13 06:11:44 DEBUG : only19: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571f74_d20220113_m061052_c001_v0001109_t0057") 2022/01/13 06:11:45 DEBUG : only19: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1119d37db2ca2487_d20220113_m061003_c001_v0001038_t0023") 2022/01/13 06:11:45 DEBUG : only19: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571d36_d20220113_m061000_c001_v0001109_t0050") 2022/01/13 06:11:45 DEBUG : only2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f109e240a4140625a_d20220113_m061121_c001_v0001150_t0042") 2022/01/13 06:11:45 DEBUG : only2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571fa4_d20220113_m061055_c001_v0001109_t0041") 2022/01/13 06:11:45 DEBUG : only2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571e26_d20220113_m061026_c001_v0001109_t0015") 2022/01/13 06:11:45 DEBUG : only2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f111b55150ee5df40_d20220113_m061004_c001_v0001165_t0018") 2022/01/13 06:11:45 DEBUG : only2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571c40_d20220113_m060941_c001_v0001109_t0042") 2022/01/13 06:11:45 DEBUG : only3: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f103a7adf630a72e4_d20220113_m061122_c001_v0001161_t0005") 2022/01/13 06:11:45 DEBUG : only3: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f115a47e7b6e27a29_d20220113_m061055_c001_v0001098_t0043") 2022/01/13 06:11:45 DEBUG : only3: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571e5b_d20220113_m061030_c001_v0001109_t0050") 2022/01/13 06:11:45 DEBUG : only3: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11012dfc3c5962d0_d20220113_m061002_c001_v0001105_t0014") 2022/01/13 06:11:45 DEBUG : only3: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571c4b_d20220113_m060942_c001_v0001109_t0028") 2022/01/13 06:11:45 DEBUG : only4: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10066981b928b60b_d20220113_m061122_c001_v0001017_t0033") 2022/01/13 06:11:45 DEBUG : only4: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1058101fe1f7df3e_d20220113_m061056_c001_v0001113_t0023") 2022/01/13 06:11:45 DEBUG : only4: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571e6d_d20220113_m061031_c001_v0001109_t0009") 2022/01/13 06:11:45 DEBUG : only4: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11572d8bdc242a18_d20220113_m061003_c001_v0001097_t0031") 2022/01/13 06:11:45 DEBUG : only4: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571c64_d20220113_m060943_c001_v0001109_t0013") 2022/01/13 06:11:45 DEBUG : only5: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1078abd7df59ed0c_d20220113_m061123_c001_v0001146_t0052") 2022/01/13 06:11:46 DEBUG : only5: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f115a47e7b6e27a2d_d20220113_m061056_c001_v0001098_t0006") 2022/01/13 06:11:46 DEBUG : only5: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571e75_d20220113_m061032_c001_v0001109_t0023") 2022/01/13 06:11:46 DEBUG : only5: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f114072d592fe2e29_d20220113_m061003_c001_v0001131_t0021") 2022/01/13 06:11:46 DEBUG : only5: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571c75_d20220113_m060944_c001_v0001109_t0046") 2022/01/13 06:11:46 DEBUG : only6: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f117560ca827a8668_d20220113_m061124_c001_v0001153_t0025") 2022/01/13 06:11:46 DEBUG : only6: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571fa8_d20220113_m061056_c001_v0001109_t0040") 2022/01/13 06:11:46 DEBUG : only6: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571e80_d20220113_m061033_c001_v0001109_t0050") 2022/01/13 06:11:46 DEBUG : only6: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f106ab0fa065c2019_d20220113_m061005_c001_v0001146_t0055") 2022/01/13 06:11:46 DEBUG : only6: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571c7c_d20220113_m060945_c001_v0001109_t0056") 2022/01/13 06:11:46 DEBUG : only7: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11600f323f88b34f_d20220113_m061124_c001_v0001105_t0045") 2022/01/13 06:11:46 DEBUG : only7: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1167872680624460_d20220113_m061056_c001_v0001136_t0031") 2022/01/13 06:11:46 DEBUG : only7: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571e96_d20220113_m061035_c001_v0001109_t0000") 2022/01/13 06:11:46 DEBUG : only7: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1067fb5d23628a36_d20220113_m061005_c001_v0001105_t0022") 2022/01/13 06:11:46 DEBUG : only7: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571c8e_d20220113_m060946_c001_v0001109_t0039") 2022/01/13 06:11:46 DEBUG : only8: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f108e6cc68c3bec08_d20220113_m061124_c001_v0001131_t0004") 2022/01/13 06:11:46 DEBUG : only8: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f115a47e7b6e27a38_d20220113_m061056_c001_v0001098_t0002") 2022/01/13 06:11:46 DEBUG : only8: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571ea7_d20220113_m061035_c001_v0001109_t0006") 2022/01/13 06:11:46 DEBUG : only8: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11600f323f88a9ea_d20220113_m061002_c001_v0001105_t0022") 2022/01/13 06:11:46 DEBUG : only8: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571c99_d20220113_m060947_c001_v0001109_t0024") 2022/01/13 06:11:46 DEBUG : only9: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10466368c9b38d58_d20220113_m061125_c001_v0001130_t0027") 2022/01/13 06:11:46 DEBUG : only9: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1058101fe1f7df44_d20220113_m061056_c001_v0001113_t0035") 2022/01/13 06:11:47 DEBUG : only9: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571eb5_d20220113_m061037_c001_v0001109_t0010") 2022/01/13 06:11:47 DEBUG : only9: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1190ee20c0d4a623_d20220113_m061003_c001_v0001154_t0022") 2022/01/13 06:11:47 DEBUG : only9: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571ca1_d20220113_m060948_c001_v0001109_t0026") 2022/01/13 06:11:47 DEBUG : potato: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f105926d518782f31_d20220113_m060536_c001_v0001120_t0017") 2022/01/13 06:11:47 DEBUG : potato: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11678726806240e8_d20220113_m060532_c001_v0001136_t0043") 2022/01/13 06:11:47 DEBUG : potato: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f116d48ae605477a8_d20220113_m060530_c001_v0001019_t0021") 2022/01/13 06:11:47 DEBUG : potato: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571124_d20220113_m060527_c001_v0001109_t0014") 2022/01/13 06:11:47 DEBUG : potato: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f119696fb1b9ac1df_d20220113_m060524_c001_v0001097_t0032") 2022/01/13 06:11:47 DEBUG : potato: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11678726806240da_d20220113_m060521_c001_v0001136_t0023") 2022/01/13 06:11:47 DEBUG : potato: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1124da0f4e80508d_d20220113_m060500_c001_v0001038_t0037") 2022/01/13 06:11:47 DEBUG : potato: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570f76_d20220113_m060458_c001_v0001109_t0043") 2022/01/13 06:11:47 DEBUG : potato: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10627b2d93daf030_d20220113_m060454_c001_v0001117_t0010") 2022/01/13 06:11:47 DEBUG : potato: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570f1c_d20220113_m060452_c001_v0001109_t0041") 2022/01/13 06:11:47 DEBUG : potato: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f103b1cf743962565_d20220113_m060449_c001_v0001043_t0039") 2022/01/13 06:11:47 DEBUG : potato: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570ec1_d20220113_m060448_c001_v0001109_t0030") 2022/01/13 06:11:47 DEBUG : potato: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f102b9adbdb9e8a20_d20220113_m060437_c001_v0001043_t0045") 2022/01/13 06:11:47 DEBUG : potato: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570ded_d20220113_m060436_c001_v0001109_t0048") 2022/01/13 06:11:47 DEBUG : potato: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f103c79e6540dbed0_d20220113_m060435_c001_v0001136_t0059") 2022/01/13 06:11:47 DEBUG : potato: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570dbe_d20220113_m060434_c001_v0001109_t0001") 2022/01/13 06:11:47 DEBUG : potato: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f114ee64f3c6b8f57_d20220113_m060433_c001_v0001105_t0030") 2022/01/13 06:11:47 DEBUG : potato: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570da5_d20220113_m060432_c001_v0001109_t0051") 2022/01/13 06:11:48 DEBUG : potato: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570d99_d20220113_m060431_c001_v0001109_t0027") 2022/01/13 06:11:48 DEBUG : potato: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f113f7a07d2b81335_d20220113_m060430_c001_v0001136_t0035") 2022/01/13 06:11:48 DEBUG : potato: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570d80_d20220113_m060429_c001_v0001109_t0008") 2022/01/13 06:11:48 DEBUG : potato: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570d76_d20220113_m060428_c001_v0001109_t0004") 2022/01/13 06:11:48 DEBUG : potato: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f119ce1a3eaa85842_d20220113_m060427_c001_v0001105_t0035") 2022/01/13 06:11:48 DEBUG : potato: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570d55_d20220113_m060425_c001_v0001109_t0050") 2022/01/13 06:11:48 DEBUG : potato2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11145f3723fe996b_d20220113_m060637_c001_v0001144_t0027") 2022/01/13 06:11:48 DEBUG : potato2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f116787268062417c_d20220113_m060636_c001_v0001136_t0029") 2022/01/13 06:11:48 DEBUG : potato2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f108bb259860adb5d_d20220113_m060624_c001_v0001154_t0001") 2022/01/13 06:11:48 DEBUG : potato2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e72785713e9_d20220113_m060619_c001_v0001109_t0017") 2022/01/13 06:11:48 DEBUG : potato2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f102a3eaf5d9250f3_d20220113_m060611_c001_v0001044_t0011") 2022/01/13 06:11:48 DEBUG : potato2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1167872680624135_d20220113_m060605_c001_v0001136_t0014") 2022/01/13 06:11:48 DEBUG : potato2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f110ad2a4187472eb_d20220113_m060556_c001_v0001109_t0041") 2022/01/13 06:11:48 DEBUG : potato2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571269_d20220113_m060548_c001_v0001109_t0029") 2022/01/13 06:11:48 DEBUG : potato2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f119bfb789a7f1d5d_d20220113_m060510_c001_v0001161_t0028") 2022/01/13 06:11:48 DEBUG : potato2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571005_d20220113_m060508_c001_v0001109_t0026") 2022/01/13 06:11:48 DEBUG : potato2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1151c175d357d31d_d20220113_m060506_c001_v0001039_t0055") 2022/01/13 06:11:48 DEBUG : potato2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570fd7_d20220113_m060504_c001_v0001109_t0039") 2022/01/13 06:11:48 DEBUG : potato2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10850e0e1dc1df33_d20220113_m060503_c001_v0001033_t0010") 2022/01/13 06:11:48 DEBUG : potato2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570f83_d20220113_m060459_c001_v0001109_t0001") 2022/01/13 06:11:48 DEBUG : potato2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f110e9ec12bcef877_d20220113_m060457_c001_v0001098_t0036") 2022/01/13 06:11:49 DEBUG : potato2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570f51_d20220113_m060456_c001_v0001109_t0010") 2022/01/13 06:11:49 DEBUG : potato2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f101937d362bf1016_d20220113_m060451_c001_v0001006_t0028") 2022/01/13 06:11:49 DEBUG : potato2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570eeb_d20220113_m060449_c001_v0001109_t0004") 2022/01/13 06:11:49 DEBUG : potato2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1122cd0bb61df249_d20220113_m060438_c001_v0001097_t0017") 2022/01/13 06:11:49 DEBUG : potato2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570e05_d20220113_m060436_c001_v0001109_t0046") 2022/01/13 06:11:49 DEBUG : potato2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f102cd52567ee18ae_d20220113_m060339_c001_v0001117_t0003") 2022/01/13 06:11:49 DEBUG : potato2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570b02_d20220113_m060338_c001_v0001109_t0015") 2022/01/13 06:11:49 DEBUG : potato2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11797b246fcb9ae1_d20220113_m060337_c001_v0001165_t0033") 2022/01/13 06:11:49 DEBUG : potato2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570ae4_d20220113_m060336_c001_v0001109_t0054") 2022/01/13 06:11:49 DEBUG : potato3: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1158e7a8cb8d26c6_d20220113_m060628_c001_v0001165_t0023") 2022/01/13 06:11:49 DEBUG : potato3: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e72785713f8_d20220113_m060621_c001_v0001109_t0044") 2022/01/13 06:11:49 DEBUG : potato3: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11539241ff3cd15e_d20220113_m060611_c001_v0001128_t0057") 2022/01/13 06:11:49 DEBUG : potato3: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1167872680624139_d20220113_m060607_c001_v0001136_t0025") 2022/01/13 06:11:49 DEBUG : potato3: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10790bcbe6ca5e2f_d20220113_m060555_c001_v0001150_t0034") 2022/01/13 06:11:49 DEBUG : potato3: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571280_d20220113_m060549_c001_v0001109_t0042") 2022/01/13 06:11:49 DEBUG : pre-dest1/1: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f107150c010c99e9b_d20220113_m060704_c001_v0001097_t0041") 2022/01/13 06:11:49 DEBUG : pre-dest1/1: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11678726806241b3_d20220113_m060657_c001_v0001136_t0021") 2022/01/13 06:11:49 DEBUG : pre-dest2/2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f111c179e1ac70bb0_d20220113_m060705_c001_v0001093_t0017") 2022/01/13 06:11:49 DEBUG : pre-dest2/2: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e727857158c_d20220113_m060658_c001_v0001109_t0034") 2022/01/13 06:11:50 DEBUG : sizeonly: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1149e9675810030d_d20220113_m060359_c001_v0001098_t0045") 2022/01/13 06:11:50 DEBUG : sizeonly: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570c0d_d20220113_m060357_c001_v0001109_t0056") 2022/01/13 06:11:50 DEBUG : sub dir/hello world: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1017110bee16e08f_d20220113_m060543_c001_v0001117_t0041") 2022/01/13 06:11:50 DEBUG : sub dir/hello world: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571219_d20220113_m060542_c001_v0001109_t0021") 2022/01/13 06:11:50 DEBUG : sub dir/hello world: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f114388878ed4001b_d20220113_m060541_c001_v0001136_t0027") 2022/01/13 06:11:50 DEBUG : sub dir/hello world: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11678726806240fe_d20220113_m060539_c001_v0001136_t0020") 2022/01/13 06:11:50 DEBUG : sub dir/hello world: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f118e1fbaddb2f785_d20220113_m060353_c001_v0001144_t0055") 2022/01/13 06:11:50 DEBUG : sub dir/hello world: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570bbc_d20220113_m060352_c001_v0001109_t0033") 2022/01/13 06:11:50 DEBUG : sub dir/hello world: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1067fb5d23625ede_d20220113_m060351_c001_v0001105_t0058") 2022/01/13 06:11:50 DEBUG : sub dir/hello world: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570ba5_d20220113_m060350_c001_v0001109_t0031") 2022/01/13 06:11:50 DEBUG : sub dir/hello world: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f103deb101d439a7b_d20220113_m060349_c001_v0001165_t0040") 2022/01/13 06:11:50 DEBUG : sub dir/hello world: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570b6e_d20220113_m060346_c001_v0001109_t0048") 2022/01/13 06:11:50 DEBUG : sub dir/hello world: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f114c17c972286322_d20220113_m060345_c001_v0001165_t0048") 2022/01/13 06:11:50 DEBUG : sub dir/hello world: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570b55_d20220113_m060344_c001_v0001109_t0019") 2022/01/13 06:11:50 DEBUG : sub dir/hello world: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f111355f48238b556_d20220113_m060343_c001_v0001128_t0041") 2022/01/13 06:11:50 DEBUG : sub dir/hello world: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570b39_d20220113_m060342_c001_v0001109_t0040") 2022/01/13 06:11:50 DEBUG : sub dir/hello world: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f110e9ec12bcef5c8_d20220113_m060341_c001_v0001098_t0000") 2022/01/13 06:11:50 DEBUG : sub dir/hello world: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570b21_d20220113_m060340_c001_v0001109_t0022") 2022/01/13 06:11:50 DEBUG : sub dir/hello world: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f106dec789ef30566_d20220113_m060329_c001_v0001144_t0048") 2022/01/13 06:11:50 DEBUG : sub dir/hello world: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570a6b_d20220113_m060328_c001_v0001109_t0002") 2022/01/13 06:11:50 DEBUG : sub dir/hello world: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f114eb92a222f3e38_d20220113_m060327_c001_v0001033_t0012") 2022/01/13 06:11:51 DEBUG : sub dir/hello world: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570a50_d20220113_m060326_c001_v0001109_t0056") 2022/01/13 06:11:51 DEBUG : sub dir/hello world: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f112120de76634ad8_d20220113_m060325_c001_v0001098_t0036") 2022/01/13 06:11:51 DEBUG : sub dir/hello world: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570a3d_d20220113_m060324_c001_v0001109_t0008") 2022/01/13 06:11:51 DEBUG : sub dir/hello world: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f116582b72b9cbddf_d20220113_m060322_c001_v0001012_t0036") 2022/01/13 06:11:51 DEBUG : sub dir/hello world: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278570a18_d20220113_m060321_c001_v0001109_t0015") 2022/01/13 06:11:51 DEBUG : sub/yam: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11869e1d9eacfb2b_d20220113_m060534_c001_v0001113_t0006") 2022/01/13 06:11:51 DEBUG : sub/yam: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571176_d20220113_m060532_c001_v0001109_t0054") 2022/01/13 06:11:51 DEBUG : three: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1117a995518327b3_d20220113_m060519_c001_v0001137_t0034") 2022/01/13 06:11:51 DEBUG : three: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e72785710a6_d20220113_m060517_c001_v0001109_t0042") 2022/01/13 06:11:51 DEBUG : three: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e7278571067_d20220113_m060514_c001_v0001109_t0037") 2022/01/13 06:11:51 DEBUG : two: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10140f5efa322bbc_d20220113_m060520_c001_v0001161_t0004") 2022/01/13 06:11:51 DEBUG : two: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11678726806240cb_d20220113_m060516_c001_v0001136_t0048") 2022/01/13 06:11:51 DEBUG : two: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10293e727857105b_d20220113_m060513_c001_v0001109_t0035") 2022/01/13 06:11:51 DEBUG : yam: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1067fb5d23626b76_d20220113_m060536_c001_v0001105_t0035") 2022/01/13 06:11:51 DEBUG : yam: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f101d48d12a361296_d20220113_m060534_c001_v0001105_t0042") 2022/01/13 06:11:51 DEBUG : yam: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f103c202e48afa20d_d20220113_m060529_c001_v0001036_t0015") 2022/01/13 06:11:52 DEBUG : yam: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11678726806240e2_d20220113_m060526_c001_v0001136_t0025") 2022/01/13 06:11:52 DEBUG : yam: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1092860db712842e_d20220113_m060524_c001_v0001161_t0011") 2022/01/13 06:11:52 DEBUG : yam: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1144fbc88177e5ea_d20220113_m060521_c001_v0001150_t0032") 2022/01/13 06:11:52 DEBUG : yaml: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f10352f2dbdae2f29_d20220113_m060531_c001_v0001113_t0039") 2022/01/13 06:11:52 DEBUG : yaml: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f11012dfc3c594683_d20220113_m060528_c001_v0001105_t0023") 2022/01/13 06:11:53 DEBUG : yaml: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f1129b03e7ac8025a_d20220113_m060525_c001_v0001105_t0011") 2022/01/13 06:11:53 DEBUG : yaml: Deleting (id "4_z7f128de3008d5b2b7fe80e1b_f114072d592fe29dc_d20220113_m060523_c001_v0001131_t0033") "./sync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -fast-list" - Finished OK in 8m36.145489288s (try 1/5)