"./sync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Starting (try 1/5)
2022/01/09 05:37:10 DEBUG : Creating backend with remote "TestB2:rclone-test-qitaqow9kikeyam1rokuyik2"
2022/01/09 05:37:10 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2022/01/09 05:37:10 DEBUG : Creating backend with remote "/tmp/rclone1308898890"
=== RUN   TestPipe
--- PASS: TestPipe (0.00s)
=== RUN   TestPipeConcurrent
--- PASS: TestPipeConcurrent (0.02s)
=== RUN   TestPipeOrderBy
=== RUN   TestPipeOrderBy/#00
=== RUN   TestPipeOrderBy/size
=== RUN   TestPipeOrderBy/name
=== RUN   TestPipeOrderBy/modtime
=== RUN   TestPipeOrderBy/size,ascending
=== RUN   TestPipeOrderBy/name,asc
=== RUN   TestPipeOrderBy/modtime,ascending
=== RUN   TestPipeOrderBy/size,descending
=== RUN   TestPipeOrderBy/name,desc
=== RUN   TestPipeOrderBy/modtime,descending
=== RUN   TestPipeOrderBy/size,mixed,50
=== RUN   TestPipeOrderBy/size,mixed,51
--- PASS: TestPipeOrderBy (0.00s)
    --- PASS: TestPipeOrderBy/#00 (0.00s)
    --- PASS: TestPipeOrderBy/size (0.00s)
    --- PASS: TestPipeOrderBy/name (0.00s)
    --- PASS: TestPipeOrderBy/modtime (0.00s)
    --- PASS: TestPipeOrderBy/size,ascending (0.00s)
    --- PASS: TestPipeOrderBy/name,asc (0.00s)
    --- PASS: TestPipeOrderBy/modtime,ascending (0.00s)
    --- PASS: TestPipeOrderBy/size,descending (0.00s)
    --- PASS: TestPipeOrderBy/name,desc (0.00s)
    --- PASS: TestPipeOrderBy/modtime,descending (0.00s)
    --- PASS: TestPipeOrderBy/size,mixed,50 (0.00s)
    --- PASS: TestPipeOrderBy/size,mixed,51 (0.00s)
=== RUN   TestNewLess
=== RUN   TestNewLess/blankOK
=== RUN   TestNewLess/tooManyParts
=== RUN   TestNewLess/tooManyParts2
=== RUN   TestNewLess/badMixed
=== RUN   TestNewLess/unknownComparison
=== RUN   TestNewLess/unknownSortDirection
=== RUN   TestNewLess/size
=== RUN   TestNewLess/name
=== RUN   TestNewLess/modtime
=== RUN   TestNewLess/size,ascending
=== RUN   TestNewLess/name,asc
=== RUN   TestNewLess/modtime,ascending
=== RUN   TestNewLess/size,descending
=== RUN   TestNewLess/name,desc
=== RUN   TestNewLess/modtime,descending
=== RUN   TestNewLess/modtime,mixed
=== RUN   TestNewLess/modtime,mixed,30
--- PASS: TestNewLess (0.00s)
    --- PASS: TestNewLess/blankOK (0.00s)
    --- PASS: TestNewLess/tooManyParts (0.00s)
    --- PASS: TestNewLess/tooManyParts2 (0.00s)
    --- PASS: TestNewLess/badMixed (0.00s)
    --- PASS: TestNewLess/unknownComparison (0.00s)
    --- PASS: TestNewLess/unknownSortDirection (0.00s)
    --- PASS: TestNewLess/size (0.00s)
    --- PASS: TestNewLess/name (0.00s)
    --- PASS: TestNewLess/modtime (0.00s)
    --- PASS: TestNewLess/size,ascending (0.00s)
    --- PASS: TestNewLess/name,asc (0.00s)
    --- PASS: TestNewLess/modtime,ascending (0.00s)
    --- PASS: TestNewLess/size,descending (0.00s)
    --- PASS: TestNewLess/name,desc (0.00s)
    --- PASS: TestNewLess/modtime,descending (0.00s)
    --- PASS: TestNewLess/modtime,mixed (0.00s)
    --- PASS: TestNewLess/modtime,mixed,30 (0.00s)
=== RUN   TestRcCopy
    rc_test.go:16: Skipping test on non local remote
--- SKIP: TestRcCopy (0.00s)
=== RUN   TestRcMove
    rc_test.go:16: Skipping test on non local remote
--- SKIP: TestRcMove (0.00s)
=== RUN   TestRcSync
    rc_test.go:16: Skipping test on non local remote
--- SKIP: TestRcSync (0.00s)
=== RUN   TestCopyWithDryRun
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:37:12 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:37:12 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11)
2022/01/09 05:37:12 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
--- PASS: TestCopyWithDryRun (1.63s)
=== RUN   TestCopy
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:37:12 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:37:12 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:37:14 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK
2022/01/09 05:37:14 INFO  : sub dir/hello world: Copied (new)
--- PASS: TestCopy (2.46s)
=== RUN   TestCopyMissingDirectory
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:37:15 DEBUG : Creating backend with remote "/non-existing"
2022/01/09 05:37:15 ERROR : Local file system at /non-existing: error reading source root directory: directory not found
2022/01/09 05:37:15 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:37:15 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
--- PASS: TestCopyMissingDirectory (0.51s)
=== RUN   TestCopyNoTraverse
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:37:16 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:37:16 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:37:16 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:37:17 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK
2022/01/09 05:37:17 INFO  : sub dir/hello world: Copied (new)
--- PASS: TestCopyNoTraverse (2.58s)
=== RUN   TestCopyCheckFirst
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:37:18 INFO  : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Running all checks before starting transfers
2022/01/09 05:37:18 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:37:18 INFO  : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Checks finished, now starting transfers
2022/01/09 05:37:18 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:37:18 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK
2022/01/09 05:37:18 INFO  : sub dir/hello world: Copied (new)
--- PASS: TestCopyCheckFirst (1.42s)
=== RUN   TestSyncNoTraverse
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:37:19 ERROR : Ignoring --no-traverse with sync
2022/01/09 05:37:19 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:37:19 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:37:20 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK
2022/01/09 05:37:20 INFO  : sub dir/hello world: Copied (new)
2022/01/09 05:37:20 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncNoTraverse (2.16s)
=== RUN   TestCopyWithDepth
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:37:21 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:37:21 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:37:23 DEBUG : hello world2: sha1 = c0bf117f9c93d02c894fe8ffd6e5cecf3545c209 OK
2022/01/09 05:37:23 INFO  : hello world2: Copied (new)
--- PASS: TestCopyWithDepth (3.19s)
=== RUN   TestCopyWithFilesFrom
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:37:24 DEBUG : hello world2: Excluded
2022/01/09 05:37:25 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:37:25 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:37:25 DEBUG : potato2: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK
2022/01/09 05:37:25 INFO  : potato2: Copied (new)
--- PASS: TestCopyWithFilesFrom (2.45s)
=== RUN   TestCopyWithFilesFromAndNoTraverse
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:37:28 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:37:28 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:37:28 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:37:29 DEBUG : potato2: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK
2022/01/09 05:37:29 INFO  : potato2: Copied (new)
--- PASS: TestCopyWithFilesFromAndNoTraverse (2.64s)
=== RUN   TestCopyEmptyDirectories
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:37:30 DEBUG : sub dir2: Making directory
2022/01/09 05:37:30 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:37:30 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:37:30 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK
2022/01/09 05:37:30 INFO  : sub dir/hello world: Copied (new)
2022/01/09 05:37:30 DEBUG : sub dir2: Making directory
2022/01/09 05:37:30 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: copied 1 directories
    fstest.go:251: Filtering empty directory "sub dir2"
--- PASS: TestCopyEmptyDirectories (2.12s)
=== RUN   TestMoveEmptyDirectories
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:37:32 DEBUG : sub dir2: Making directory
2022/01/09 05:37:32 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:37:32 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:37:33 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK
2022/01/09 05:37:33 INFO  : sub dir/hello world: Copied (new)
2022/01/09 05:37:33 INFO  : sub dir/hello world: Deleted
2022/01/09 05:37:33 DEBUG : sub dir: Making directory
2022/01/09 05:37:33 DEBUG : sub dir2: Making directory
2022/01/09 05:37:33 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: copied 2 directories
    fstest.go:251: Filtering empty directory "sub dir2"
--- PASS: TestMoveEmptyDirectories (2.61s)
=== RUN   TestSyncEmptyDirectories
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:37:34 DEBUG : sub dir2: Making directory
2022/01/09 05:37:34 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:37:34 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:37:35 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK
2022/01/09 05:37:35 INFO  : sub dir/hello world: Copied (new)
2022/01/09 05:37:35 DEBUG : sub dir2: Making directory
2022/01/09 05:37:35 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: copied 1 directories
2022/01/09 05:37:35 DEBUG : Waiting for deletions to finish
    fstest.go:251: Filtering empty directory "sub dir2"
--- PASS: TestSyncEmptyDirectories (1.55s)
=== RUN   TestServerSideCopy
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:37:37 DEBUG : Creating backend with remote "TestB2:rclone-test-demapux4kifoguz2kimugot1"
    sync_test.go:275: Server side copy (if possible) B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 -> B2 bucket rclone-test-demapux4kifoguz2kimugot1
2022/01/09 05:37:38 DEBUG : B2 bucket rclone-test-demapux4kifoguz2kimugot1: Waiting for checks to finish
2022/01/09 05:37:38 DEBUG : B2 bucket rclone-test-demapux4kifoguz2kimugot1: Waiting for transfers to finish
2022/01/09 05:37:42 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK
2022/01/09 05:37:42 INFO  : sub dir/hello world: Copied (server-side copy)
2022/01/09 05:37:43 DEBUG : B2 bucket rclone-test-demapux4kifoguz2kimugot1: Purge remote
2022/01/09 05:37:43 DEBUG : sub dir/hello world: Deleting (id "4_z6f629da3507d3bdb7fe80e1b_f106321a72f0807ee_d20220109_m053739_c001_v0001090_t0024")
--- PASS: TestServerSideCopy (8.89s)
=== RUN   TestCopyAfterDelete
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:37:47 ERROR : : error listing: directory not found
2022/01/09 05:37:47 DEBUG : Local file system at /tmp/rclone1308898890: Making directory
2022/01/09 05:37:47 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:37:47 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
--- PASS: TestCopyAfterDelete (3.60s)
=== RUN   TestCopyRedownload
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:37:49 DEBUG : Local file system at /tmp/rclone1308898890: Waiting for checks to finish
2022/01/09 05:37:49 DEBUG : Local file system at /tmp/rclone1308898890: Waiting for transfers to finish
2022/01/09 05:37:50 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK
2022/01/09 05:37:50 INFO  : sub dir/hello world: Copied (new)
--- PASS: TestCopyRedownload (2.56s)
=== RUN   TestSyncBasedOnCheckSum
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:37:51 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:37:51 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:37:52 DEBUG : check sum: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK
2022/01/09 05:37:52 INFO  : check sum: Copied (new)
2022/01/09 05:37:52 DEBUG : Waiting for deletions to finish
2022/01/09 05:37:52 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:37:52 DEBUG : check sum: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK
2022/01/09 05:37:52 DEBUG : check sum: Size and sha1 of src and dst objects identical
2022/01/09 05:37:52 DEBUG : check sum: Unchanged skipping
2022/01/09 05:37:52 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:37:52 DEBUG : Waiting for deletions to finish
2022/01/09 05:37:52 INFO  : There was nothing to transfer
--- PASS: TestSyncBasedOnCheckSum (3.65s)
=== RUN   TestSyncSizeOnly
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:37:55 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:37:55 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:37:55 DEBUG : sizeonly: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK
2022/01/09 05:37:55 INFO  : sizeonly: Copied (new)
2022/01/09 05:37:55 DEBUG : Waiting for deletions to finish
2022/01/09 05:37:55 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:37:55 DEBUG : sizeonly: Sizes identical
2022/01/09 05:37:55 DEBUG : sizeonly: Unchanged skipping
2022/01/09 05:37:55 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:37:55 DEBUG : Waiting for deletions to finish
2022/01/09 05:37:55 INFO  : There was nothing to transfer
--- PASS: TestSyncSizeOnly (1.73s)
=== RUN   TestSyncIgnoreSize
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:37:56 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:37:56 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:37:57 DEBUG : ignore-size: sha1 = 4a756ca07e9487f482465a99e8286abc86ba4dc7 OK
2022/01/09 05:37:57 INFO  : ignore-size: Copied (new)
2022/01/09 05:37:57 DEBUG : Waiting for deletions to finish
2022/01/09 05:37:58 DEBUG : ignore-size: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:37:58 DEBUG : ignore-size: Unchanged skipping
2022/01/09 05:37:58 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:37:58 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:37:58 DEBUG : Waiting for deletions to finish
2022/01/09 05:37:58 INFO  : There was nothing to transfer
--- PASS: TestSyncIgnoreSize (2.69s)
=== RUN   TestSyncIgnoreTimes
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:38:00 DEBUG : existing: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:38:00 DEBUG : existing: Unchanged skipping
2022/01/09 05:38:00 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:38:00 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:38:00 DEBUG : Waiting for deletions to finish
2022/01/09 05:38:00 INFO  : There was nothing to transfer
2022/01/09 05:38:00 DEBUG : existing: Transferring unconditionally as --ignore-times is in use
2022/01/09 05:38:00 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:38:00 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:38:01 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK
2022/01/09 05:38:01 INFO  : existing: Copied (replaced existing)
2022/01/09 05:38:01 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncIgnoreTimes (2.98s)
=== RUN   TestSyncIgnoreExisting
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:38:02 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:38:02 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:38:03 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK
2022/01/09 05:38:03 INFO  : existing: Copied (new)
2022/01/09 05:38:03 DEBUG : Waiting for deletions to finish
2022/01/09 05:38:04 DEBUG : existing: Destination exists, skipping
2022/01/09 05:38:04 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:38:04 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:38:04 DEBUG : Waiting for deletions to finish
2022/01/09 05:38:04 INFO  : There was nothing to transfer
--- PASS: TestSyncIgnoreExisting (2.49s)
=== RUN   TestSyncIgnoreErrors
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:38:06 DEBUG : d: Making directory
    fstest.go:251: Filtering empty directory "d"
2022/01/09 05:38:06 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2022/01/09 05:38:06 DEBUG : c/non empty space: Unchanged skipping
2022/01/09 05:38:06 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:38:06 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:38:08 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK
2022/01/09 05:38:08 INFO  : a/potato2: Copied (new)
2022/01/09 05:38:08 DEBUG : Waiting for deletions to finish
2022/01/09 05:38:08 INFO  : b/potato: Deleted
--- PASS: TestSyncIgnoreErrors (5.59s)
=== RUN   TestSyncAfterChangingModtimeOnly
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:38:12 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:38: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/09 05:38:12 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK
2022/01/09 05:38:12 NOTICE: empty space: Skipped update modification time as --dry-run is set (size 1)
2022/01/09 05:38:12 DEBUG : empty space: Unchanged skipping
2022/01/09 05:38:12 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:38:12 DEBUG : Waiting for deletions to finish
2022/01/09 05:38:12 INFO  : There was nothing to transfer
2022/01/09 05:38:13 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/09 05:38:13 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:38:13 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK
2022/01/09 05:38:14 INFO  : empty space: Updated modification time in destination
2022/01/09 05:38:14 DEBUG : empty space: Unchanged skipping
2022/01/09 05:38:14 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:38:14 DEBUG : Waiting for deletions to finish
2022/01/09 05:38:14 INFO  : There was nothing to transfer
--- PASS: TestSyncAfterChangingModtimeOnly (5.57s)
=== RUN   TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:38:17 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/09 05:38:17 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:38:17 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK
2022/01/09 05:38:17 DEBUG : empty space: Unchanged skipping
2022/01/09 05:38:17 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:38:17 DEBUG : Waiting for deletions to finish
2022/01/09 05:38:17 INFO  : There was nothing to transfer
--- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (3.99s)
=== RUN   TestSyncDoesntUpdateModtime
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:38:21 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/09 05:38:21 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:38:21 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 (Local file system at /tmp/rclone1308898890)
2022/01/09 05:38:21 DEBUG : foo: sha1 = 62cdb7020ff920e5aa642c3d4066950dd1f01f4d (B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2)
2022/01/09 05:38:21 DEBUG : foo: sha1 differ
2022/01/09 05:38:21 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:38:21 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 OK
2022/01/09 05:38:21 INFO  : foo: Copied (replaced existing)
2022/01/09 05:38:21 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncDoesntUpdateModtime (4.84s)
=== RUN   TestSyncAfterAddingAFile
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:38:26 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2022/01/09 05:38:26 DEBUG : empty space: Unchanged skipping
2022/01/09 05:38:26 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:38:26 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:38:27 DEBUG : potato: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK
2022/01/09 05:38:27 INFO  : potato: Copied (new)
2022/01/09 05:38:27 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncAfterAddingAFile (5.23s)
=== RUN   TestSyncAfterChangingFilesSizeOnly
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:38:36 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:38:36 DEBUG : potato: Sizes differ (src 21 vs dst 60)
2022/01/09 05:38:36 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:38:36 DEBUG : potato: sha1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f OK
2022/01/09 05:38:36 INFO  : potato: Copied (replaced existing)
2022/01/09 05:38:36 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncAfterChangingFilesSizeOnly (7.82s)
=== RUN   TestSyncAfterChangingContentsOnly
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:38:38 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/09 05:38:38 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:38:38 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f (Local file system at /tmp/rclone1308898890)
2022/01/09 05:38:38 DEBUG : potato: sha1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f (B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2)
2022/01/09 05:38:38 DEBUG : potato: sha1 differ
2022/01/09 05:38:38 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:38:40 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f OK
2022/01/09 05:38:40 INFO  : potato: Copied (replaced existing)
2022/01/09 05:38:40 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncAfterChangingContentsOnly (5.51s)
=== RUN   TestSyncAfterRemovingAFileAndAddingAFileDryRun
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:38:46 NOTICE: potato2: Skipped copy as --dry-run is set (size 60)
2022/01/09 05:38:46 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:38:46 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2022/01/09 05:38:46 DEBUG : empty space: Unchanged skipping
2022/01/09 05:38:46 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:38:46 DEBUG : Waiting for deletions to finish
2022/01/09 05:38:46 NOTICE: potato: Skipped delete as --dry-run is set (size 21)
--- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (4.14s)
=== RUN   TestSyncAfterRemovingAFileAndAddingAFile
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:38:50 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2022/01/09 05:38:50 DEBUG : empty space: Unchanged skipping
2022/01/09 05:38:50 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:38:50 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:38:51 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK
2022/01/09 05:38:51 INFO  : potato2: Copied (new)
2022/01/09 05:38:51 DEBUG : Waiting for deletions to finish
2022/01/09 05:38:52 INFO  : potato: Deleted
--- PASS: TestSyncAfterRemovingAFileAndAddingAFile (6.84s)
=== RUN   TestSyncAfterRemovingAFileAndAddingAFileSubDir
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:38:56 DEBUG : d: Making directory
2022/01/09 05:38:56 DEBUG : d/e: Making directory
    fstest.go:251: Filtering empty directory "d"
    fstest.go:251: Filtering empty directory "d/e"
2022/01/09 05:38:57 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2022/01/09 05:38:57 DEBUG : c/non empty space: Unchanged skipping
2022/01/09 05:38:57 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:38:57 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:38:58 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK
2022/01/09 05:38:58 INFO  : a/potato2: Copied (new)
2022/01/09 05:38:58 DEBUG : Waiting for deletions to finish
2022/01/09 05:38:58 INFO  : b/potato: Deleted
--- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (6.17s)
=== RUN   TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:39:02 DEBUG : d: Making directory
    fstest.go:251: Filtering empty directory "d"
2022/01/09 05:39:03 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2022/01/09 05:39:03 DEBUG : c/non empty space: Unchanged skipping
2022/01/09 05:39:03 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:39:03 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:39:03 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK
2022/01/09 05:39:03 INFO  : a/potato2: Copied (new)
2022/01/09 05:39:03 ERROR : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: not deleting files as there were IO errors
2022/01/09 05:39:03 ERROR : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: not deleting directories as there were IO errors
    fstest.go:251: Filtering empty directory "d"
--- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (5.39s)
=== RUN   TestSyncDeleteAfter
--- PASS: TestSyncDeleteAfter (0.00s)
=== RUN   TestSyncDeleteDuring
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:39:07 DEBUG : Waiting for deletions to finish
2022/01/09 05:39:07 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2022/01/09 05:39:07 DEBUG : empty space: Unchanged skipping
2022/01/09 05:39:07 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:39:07 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:39:08 INFO  : potato: Deleted
2022/01/09 05:39:09 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK
2022/01/09 05:39:09 INFO  : potato2: Copied (new)
--- PASS: TestSyncDeleteDuring (4.64s)
=== RUN   TestSyncDeleteBefore
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:39:12 DEBUG : Waiting for deletions to finish
2022/01/09 05:39:12 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:39:12 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:39:12 INFO  : potato: Deleted
2022/01/09 05:39:13 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2022/01/09 05:39:13 DEBUG : empty space: Unchanged skipping
2022/01/09 05:39:13 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:39:13 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:39:13 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK
2022/01/09 05:39:13 INFO  : potato2: Copied (new)
--- PASS: TestSyncDeleteBefore (5.03s)
=== RUN   TestCopyDeleteBefore
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:39:16 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:39:16 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:39:16 DEBUG : potato2: sha1 = 810274f0df19dab60a894a562b7a8ff04c072623 OK
2022/01/09 05:39:16 INFO  : potato2: Copied (new)
--- PASS: TestCopyDeleteBefore (5.40s)
=== RUN   TestSyncWithExclude
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:39:22 DEBUG : enormous: Excluded
2022/01/09 05:39:22 DEBUG : potato2: Excluded
2022/01/09 05:39:22 DEBUG : potato2: Excluded
2022/01/09 05:39:22 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:39:22 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2022/01/09 05:39:22 DEBUG : empty space: Unchanged skipping
2022/01/09 05:39:22 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:39:22 DEBUG : Waiting for deletions to finish
2022/01/09 05:39:22 INFO  : There was nothing to transfer
2022/01/09 05:39:22 DEBUG : enormous: Excluded
2022/01/09 05:39:22 DEBUG : potato2: Excluded
2022/01/09 05:39:22 DEBUG : potato2: Excluded
2022/01/09 05:39:22 DEBUG : empty space: Size and modification time the same (differ by 456.789µs, within tolerance 1ms)
2022/01/09 05:39:22 DEBUG : empty space: Unchanged skipping
2022/01/09 05:39:22 DEBUG : Local file system at /tmp/rclone1308898890: Waiting for checks to finish
2022/01/09 05:39:22 DEBUG : Local file system at /tmp/rclone1308898890: Waiting for transfers to finish
2022/01/09 05:39:22 DEBUG : Waiting for deletions to finish
2022/01/09 05:39:22 INFO  : There was nothing to transfer
--- PASS: TestSyncWithExclude (3.16s)
=== RUN   TestSyncWithExcludeAndDeleteExcluded
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:39:27 DEBUG : enormous: Excluded
2022/01/09 05:39:27 DEBUG : potato2: Excluded
2022/01/09 05:39:27 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2022/01/09 05:39:27 DEBUG : empty space: Unchanged skipping
2022/01/09 05:39:27 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:39:27 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:39:27 DEBUG : Waiting for deletions to finish
2022/01/09 05:39:27 INFO  : enormous: Deleted
2022/01/09 05:39:28 INFO  : potato2: Deleted
2022/01/09 05:39:28 INFO  : There was nothing to transfer
2022/01/09 05:39:28 DEBUG : empty space: Size and modification time the same (differ by 456.789µs, within tolerance 1ms)
2022/01/09 05:39:28 DEBUG : empty space: Unchanged skipping
2022/01/09 05:39:28 DEBUG : Local file system at /tmp/rclone1308898890: Waiting for checks to finish
2022/01/09 05:39:28 DEBUG : Local file system at /tmp/rclone1308898890: Waiting for transfers to finish
2022/01/09 05:39:28 DEBUG : Waiting for deletions to finish
2022/01/09 05:39:28 INFO  : potato2: Deleted
2022/01/09 05:39:28 INFO  : enormous: Deleted
2022/01/09 05:39:28 INFO  : There was nothing to transfer
--- PASS: TestSyncWithExcludeAndDeleteExcluded (5.31s)
=== RUN   TestSyncWithUpdateOlder
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:39:32 DEBUG : four: Sizes differ (src 4 vs dst 8)
2022/01/09 05:39:32 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring
2022/01/09 05:39:32 DEBUG : one: Destination is newer than source, skipping
2022/01/09 05:39:32 DEBUG : three: Sizes identical
2022/01/09 05:39:32 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping
2022/01/09 05:39:32 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:39:32 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b (Local file system at /tmp/rclone1308898890)
2022/01/09 05:39:32 DEBUG : two: sha1 = b10e0da85e90399abfec36c7376b20aa4596461b (B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2)
2022/01/09 05:39:32 DEBUG : two: sha1 differ
2022/01/09 05:39:32 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:39:34 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK
2022/01/09 05:39:34 INFO  : four: Copied (replaced existing)
2022/01/09 05:39:34 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK
2022/01/09 05:39:34 INFO  : five: Copied (new)
2022/01/09 05:39:34 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK
2022/01/09 05:39:34 INFO  : two: Copied (replaced existing)
2022/01/09 05:39:34 DEBUG : Waiting for deletions to finish
2022/01/09 05:39:34 DEBUG : one: Destination is newer than source, skipping
2022/01/09 05:39:34 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:39:34 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK
2022/01/09 05:39:34 DEBUG : five: Size and sha1 of src and dst objects identical
2022/01/09 05:39:34 DEBUG : five: Destination mod time is within 1s of source and files identical, skipping
2022/01/09 05:39:34 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK
2022/01/09 05:39:34 DEBUG : two: Size and sha1 of src and dst objects identical
2022/01/09 05:39:34 DEBUG : two: Destination mod time is within 1s of source and files identical, skipping
2022/01/09 05:39:34 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb (Local file system at /tmp/rclone1308898890)
2022/01/09 05:39:34 DEBUG : three: sha1 = 03731cad13f4cf7b59703c77529381cdec1632e5 (B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2)
2022/01/09 05:39:34 DEBUG : three: sha1 differ
2022/01/09 05:39:34 DEBUG : three: Destination mod time is within 1s of source but files differ, transferring
2022/01/09 05:39:34 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK
2022/01/09 05:39:34 DEBUG : four: Size and sha1 of src and dst objects identical
2022/01/09 05:39:34 DEBUG : four: Destination mod time is within 1s of source and files identical, skipping
2022/01/09 05:39:34 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:39:35 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK
2022/01/09 05:39:35 INFO  : three: Copied (replaced existing)
2022/01/09 05:39:35 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncWithUpdateOlder (11.95s)
=== 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-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
    sync_test.go:1058: Can track renames: true
2022/01/09 05:39:41 INFO  : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Making map for --track-renames
2022/01/09 05:39:41 INFO  : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Finished making map for --track-renames
2022/01/09 05:39:41 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:39:41 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for renames to finish
2022/01/09 05:39:41 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:39:42 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK
2022/01/09 05:39:42 INFO  : yam: Copied (new)
2022/01/09 05:39:43 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK
2022/01/09 05:39:43 INFO  : potato: Copied (new)
2022/01/09 05:39:43 DEBUG : Waiting for deletions to finish
2022/01/09 05:39:43 INFO  : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Making map for --track-renames
2022/01/09 05:39:43 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:39:43 DEBUG : potato: Unchanged skipping
2022/01/09 05:39:43 INFO  : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Finished making map for --track-renames
2022/01/09 05:39:43 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:39:43 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for renames to finish
2022/01/09 05:39:44 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:39:44 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK
2022/01/09 05:39:44 INFO  : yam: Copied (server-side copy) to: yaml
2022/01/09 05:39:45 INFO  : yam: Deleted
2022/01/09 05:39:45 INFO  : yaml: Renamed from "yam"
2022/01/09 05:39:45 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:39:45 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncWithTrackRenames (6.13s)
=== RUN   TestParseRenamesStrategyModtime
--- PASS: TestParseRenamesStrategyModtime (0.00s)
=== RUN   TestRenamesStrategyModtime
--- PASS: TestRenamesStrategyModtime (0.00s)
=== RUN   TestSyncWithTrackRenamesStrategyModtime
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
    sync_test.go:1127: Can track renames: true
2022/01/09 05:39:47 INFO  : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Making map for --track-renames
2022/01/09 05:39:47 INFO  : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Finished making map for --track-renames
2022/01/09 05:39:47 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:39:47 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for renames to finish
2022/01/09 05:39:47 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:39:47 DEBUG : yam: Clearing upload URL because of error: Post "https://pod-000-1033-18.backblaze.com/b2api/v1/b2_upload_file/bf923d13507d3bdb7fe80e1b/c001_v0001033_t0004": EOF
2022/01/09 05:39:47 DEBUG : pacer: low level retry 1/1 (error Post "https://pod-000-1033-18.backblaze.com/b2api/v1/b2_upload_file/bf923d13507d3bdb7fe80e1b/c001_v0001033_t0004": EOF)
2022/01/09 05:39:47 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2022/01/09 05:39:47 DEBUG : yam: Received error: Post "https://pod-000-1033-18.backblaze.com/b2api/v1/b2_upload_file/bf923d13507d3bdb7fe80e1b/c001_v0001033_t0004": EOF - low level retry 1/10
2022/01/09 05:39:48 DEBUG : pacer: Reducing sleep to 10ms
2022/01/09 05:39:48 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK
2022/01/09 05:39:48 INFO  : yam: Copied (new)
2022/01/09 05:39:49 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK
2022/01/09 05:39:49 INFO  : potato: Copied (new)
2022/01/09 05:39:49 DEBUG : Waiting for deletions to finish
2022/01/09 05:39:49 INFO  : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Making map for --track-renames
2022/01/09 05:39:49 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:39:49 DEBUG : potato: Unchanged skipping
2022/01/09 05:39:49 INFO  : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Finished making map for --track-renames
2022/01/09 05:39:49 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:39:49 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for renames to finish
2022/01/09 05:39:50 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:39:50 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK
2022/01/09 05:39:50 INFO  : yam: Copied (server-side copy) to: yaml
2022/01/09 05:39:50 INFO  : yam: Deleted
2022/01/09 05:39:50 INFO  : yaml: Renamed from "yam"
2022/01/09 05:39:50 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:39:50 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncWithTrackRenamesStrategyModtime (5.43s)
=== RUN   TestSyncWithTrackRenamesStrategyLeaf
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
    sync_test.go:1163: Can track renames: true
2022/01/09 05:39:53 INFO  : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Making map for --track-renames
2022/01/09 05:39:53 INFO  : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Finished making map for --track-renames
2022/01/09 05:39:53 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:39:53 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for renames to finish
2022/01/09 05:39:53 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:39:53 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK
2022/01/09 05:39:53 INFO  : potato: Copied (new)
2022/01/09 05:39:53 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK
2022/01/09 05:39:53 INFO  : sub/yam: Copied (new)
2022/01/09 05:39:53 DEBUG : Waiting for deletions to finish
2022/01/09 05:39:54 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:39:54 DEBUG : potato: Unchanged skipping
2022/01/09 05:39:54 INFO  : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Making map for --track-renames
2022/01/09 05:39:54 INFO  : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Finished making map for --track-renames
2022/01/09 05:39:54 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:39:54 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for renames to finish
2022/01/09 05:39:54 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:39:55 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK
2022/01/09 05:39:55 INFO  : sub/yam: Copied (server-side copy) to: yam
2022/01/09 05:39:56 INFO  : sub/yam: Deleted
2022/01/09 05:39:56 INFO  : yam: Renamed from "sub/yam"
2022/01/09 05:39:56 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:39:56 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncWithTrackRenamesStrategyLeaf (5.92s)
=== RUN   TestMoveWithDeleteEmptySrcDirs
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:39:59 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:39:59 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:40:00 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK
2022/01/09 05:40:00 INFO  : nested/sub dir/file: Copied (new)
2022/01/09 05:40:00 INFO  : nested/sub dir/file: Deleted
2022/01/09 05:40:02 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK
2022/01/09 05:40:02 INFO  : sub dir/hello world: Copied (new)
2022/01/09 05:40:02 INFO  : sub dir/hello world: Deleted
2022/01/09 05:40:02 INFO  : sub dir: Removing directory
2022/01/09 05:40:02 INFO  : nested/sub dir: Removing directory
2022/01/09 05:40:02 INFO  : nested: Removing directory
2022/01/09 05:40:02 DEBUG : Local file system at /tmp/rclone1308898890: deleted 3 directories
--- PASS: TestMoveWithDeleteEmptySrcDirs (6.20s)
=== RUN   TestMoveWithoutDeleteEmptySrcDirs
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:40:05 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:40:05 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:40:05 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK
2022/01/09 05:40:05 INFO  : nested/sub dir/file: Copied (new)
2022/01/09 05:40:05 INFO  : nested/sub dir/file: Deleted
2022/01/09 05:40:08 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK
2022/01/09 05:40:08 INFO  : sub dir/hello world: Copied (new)
2022/01/09 05:40:08 INFO  : sub dir/hello world: Deleted
--- PASS: TestMoveWithoutDeleteEmptySrcDirs (5.15s)
=== RUN   TestMoveWithIgnoreExisting
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:40:10 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:40:10 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:40:10 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK
2022/01/09 05:40:10 INFO  : existing: Copied (new)
2022/01/09 05:40:10 INFO  : existing: Deleted
2022/01/09 05:40:13 DEBUG : existing-b: sha1 = 321f6b7e8bf7f29aab89c5e41a555b1b0baa41a9 OK
2022/01/09 05:40:13 INFO  : existing-b: Copied (new)
2022/01/09 05:40:13 INFO  : existing-b: Deleted
2022/01/09 05:40:13 DEBUG : existing: Destination exists, skipping
2022/01/09 05:40:13 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:40:13 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set
2022/01/09 05:40:13 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:40:13 INFO  : There was nothing to transfer
--- PASS: TestMoveWithIgnoreExisting (4.56s)
=== RUN   TestServerSideMove
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:40:14 DEBUG : Creating backend with remote "TestB2:rclone-test-pocupoz1cezuwiy3tifezaj1"
    sync_test.go:1215: Server side move (if possible) B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 -> B2 bucket rclone-test-pocupoz1cezuwiy3tifezaj1
2022/01/09 05:40:20 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ms)
2022/01/09 05:40:20 DEBUG : empty space: Unchanged skipping
2022/01/09 05:40:20 DEBUG : potato3: Sizes differ (src 68 vs dst 60)
2022/01/09 05:40:20 DEBUG : B2 bucket rclone-test-pocupoz1cezuwiy3tifezaj1: Waiting for checks to finish
2022/01/09 05:40:20 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK
2022/01/09 05:40:20 INFO  : potato2: Copied (server-side copy)
2022/01/09 05:40:20 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK
2022/01/09 05:40:20 INFO  : potato3: Copied (server-side copy)
2022/01/09 05:40:20 INFO  : empty space: Deleted
2022/01/09 05:40:20 DEBUG : B2 bucket rclone-test-pocupoz1cezuwiy3tifezaj1: Waiting for transfers to finish
2022/01/09 05:40:21 INFO  : potato2: Deleted
2022/01/09 05:40:21 INFO  : potato3: Deleted
2022/01/09 05:40:22 DEBUG : Creating backend with remote "TestB2:rclone-test-jafigut0zonohuw2quwozup3"
2022/01/09 05:40:23 DEBUG : B2 bucket rclone-test-jafigut0zonohuw2quwozup3: Waiting for checks to finish
2022/01/09 05:40:23 DEBUG : B2 bucket rclone-test-jafigut0zonohuw2quwozup3: Waiting for transfers to finish
2022/01/09 05:40:23 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK
2022/01/09 05:40:23 INFO  : empty space: Copied (server-side copy)
2022/01/09 05:40:24 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK
2022/01/09 05:40:24 INFO  : potato2: Copied (server-side copy)
2022/01/09 05:40:24 INFO  : potato2: Deleted
2022/01/09 05:40:24 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK
2022/01/09 05:40:24 INFO  : potato3: Copied (server-side copy)
2022/01/09 05:40:25 INFO  : empty space: Deleted
2022/01/09 05:40:25 INFO  : potato3: Deleted
2022/01/09 05:40:25 DEBUG : B2 bucket rclone-test-jafigut0zonohuw2quwozup3: Purge remote
2022/01/09 05:40:26 DEBUG : empty space: Deleting (id "4_zcf621dd350ad3bdb7fe80e1b_f108b8d00d068d398_d20220109_m054023_c001_v0001091_t0028")
2022/01/09 05:40:26 DEBUG : potato2: Deleting (id "4_zcf621dd350ad3bdb7fe80e1b_f103d8649929b3893_d20220109_m054023_c001_v0001131_t0049")
2022/01/09 05:40:26 DEBUG : potato3: Deleting (id "4_zcf621dd350ad3bdb7fe80e1b_f119a34e4caa1384c_d20220109_m054023_c001_v0001105_t0040")
2022/01/09 05:40:26 DEBUG : B2 bucket rclone-test-pocupoz1cezuwiy3tifezaj1: Purge remote
2022/01/09 05:40:26 DEBUG : empty space: Deleting (id "4_z0fa20da350ad3bdb7fe80e1b_f1023c2556aed2a76_d20220109_m054024_c001_v0001105_t0059")
2022/01/09 05:40:26 DEBUG : empty space: Deleting (id "4_z0fa20da350ad3bdb7fe80e1b_f100a3104363b9809_d20220109_m054019_c001_v0001165_t0030")
2022/01/09 05:40:26 DEBUG : potato2: Deleting (id "4_z0fa20da350ad3bdb7fe80e1b_f11235e16960be0de_d20220109_m054024_c001_v0001109_t0019")
2022/01/09 05:40:26 DEBUG : potato2: Deleting (id "4_z0fa20da350ad3bdb7fe80e1b_f11820a6e375e671e_d20220109_m054020_c001_v0001033_t0033")
2022/01/09 05:40:26 DEBUG : potato3: Deleting (id "4_z0fa20da350ad3bdb7fe80e1b_f115bda7f6cee837d_d20220109_m054025_c001_v0001153_t0007")
2022/01/09 05:40:26 DEBUG : potato3: Deleting (id "4_z0fa20da350ad3bdb7fe80e1b_f107cb0bbdd30bbe9_d20220109_m054020_c001_v0001157_t0022")
2022/01/09 05:40:26 DEBUG : potato3: Deleting (id "4_z0fa20da350ad3bdb7fe80e1b_f100a3104363b980d_d20220109_m054019_c001_v0001165_t0051")
--- PASS: TestServerSideMove (13.13s)
=== RUN   TestServerSideMoveWithFilter
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:40:28 DEBUG : Creating backend with remote "TestB2:rclone-test-dowiday1zuliwis5xaceyep6"
    sync_test.go:1215: Server side move (if possible) B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 -> B2 bucket rclone-test-dowiday1zuliwis5xaceyep6
2022/01/09 05:40:38 DEBUG : empty space: Excluded
2022/01/09 05:40:38 DEBUG : empty space: Excluded
2022/01/09 05:40:38 DEBUG : potato3: Sizes differ (src 68 vs dst 60)
2022/01/09 05:40:38 DEBUG : B2 bucket rclone-test-dowiday1zuliwis5xaceyep6: Waiting for checks to finish
2022/01/09 05:40:38 DEBUG : B2 bucket rclone-test-dowiday1zuliwis5xaceyep6: Waiting for transfers to finish
2022/01/09 05:40:39 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK
2022/01/09 05:40:39 INFO  : potato3: Copied (server-side copy)
2022/01/09 05:40:39 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK
2022/01/09 05:40:39 INFO  : potato2: Copied (server-side copy)
2022/01/09 05:40:39 INFO  : potato3: Deleted
2022/01/09 05:40:39 INFO  : potato2: Deleted
2022/01/09 05:40:40 DEBUG : Creating backend with remote "TestB2:rclone-test-lugosil3kefemas4voxidop0"
2022/01/09 05:40:41 DEBUG : empty space: Excluded
2022/01/09 05:40:41 DEBUG : B2 bucket rclone-test-lugosil3kefemas4voxidop0: Waiting for checks to finish
2022/01/09 05:40:41 DEBUG : B2 bucket rclone-test-lugosil3kefemas4voxidop0: Waiting for transfers to finish
2022/01/09 05:40:42 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK
2022/01/09 05:40:42 INFO  : potato3: Copied (server-side copy)
2022/01/09 05:40:42 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK
2022/01/09 05:40:42 INFO  : potato2: Copied (server-side copy)
2022/01/09 05:40:42 INFO  : potato3: Deleted
2022/01/09 05:40:43 INFO  : potato2: Deleted
2022/01/09 05:40:43 DEBUG : B2 bucket rclone-test-lugosil3kefemas4voxidop0: Purge remote
2022/01/09 05:40:43 DEBUG : potato2: Deleting (id "4_zffb26d4350ad3bdb7fe80e1b_f11324ceb57a7b688_d20220109_m054041_c001_v0001105_t0021")
2022/01/09 05:40:43 DEBUG : potato3: Deleting (id "4_zffb26d4350ad3bdb7fe80e1b_f1113cf246c96d29e_d20220109_m054042_c001_v0001109_t0028")
2022/01/09 05:40:44 DEBUG : B2 bucket rclone-test-dowiday1zuliwis5xaceyep6: Purge remote
2022/01/09 05:40:44 DEBUG : empty space: Deleting (id "4_z9f124dc350ad3bdb7fe80e1b_f104da4b21c88da18_d20220109_m054036_c001_v0001105_t0038")
2022/01/09 05:40:44 DEBUG : potato2: Deleting (id "4_z9f124dc350ad3bdb7fe80e1b_f11217e5e69a6f8b5_d20220109_m054043_c001_v0001018_t0037")
2022/01/09 05:40:44 DEBUG : potato2: Deleting (id "4_z9f124dc350ad3bdb7fe80e1b_f116b1f0707591535_d20220109_m054039_c001_v0001097_t0008")
2022/01/09 05:40:44 DEBUG : potato3: Deleting (id "4_z9f124dc350ad3bdb7fe80e1b_f1012959da0e1d4d0_d20220109_m054042_c001_v0001136_t0020")
2022/01/09 05:40:44 DEBUG : potato3: Deleting (id "4_z9f124dc350ad3bdb7fe80e1b_f10592cd27ee7f2ab_d20220109_m054039_c001_v0001134_t0040")
2022/01/09 05:40:44 DEBUG : potato3: Deleting (id "4_z9f124dc350ad3bdb7fe80e1b_f104da4b21c88da30_d20220109_m054037_c001_v0001105_t0003")
--- PASS: TestServerSideMoveWithFilter (19.18s)
=== RUN   TestServerSideMoveDeleteEmptySourceDirs
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:40:47 DEBUG : Creating backend with remote "TestB2:rclone-test-zuheser1vohayon4hocohog3"
2022/01/09 05:40:50 DEBUG : tomatoDir: Making directory
    sync_test.go:1215: Server side move (if possible) B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 -> B2 bucket rclone-test-zuheser1vohayon4hocohog3
2022/01/09 05:40:53 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ms)
2022/01/09 05:40:53 DEBUG : empty space: Unchanged skipping
2022/01/09 05:40:53 DEBUG : potato3: Sizes differ (src 68 vs dst 60)
2022/01/09 05:40:53 DEBUG : B2 bucket rclone-test-zuheser1vohayon4hocohog3: Waiting for checks to finish
2022/01/09 05:40:53 INFO  : empty space: Deleted
2022/01/09 05:40:53 DEBUG : B2 bucket rclone-test-zuheser1vohayon4hocohog3: Waiting for transfers to finish
2022/01/09 05:40:54 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK
2022/01/09 05:40:54 INFO  : potato3: Copied (server-side copy)
2022/01/09 05:40:54 INFO  : potato3: Deleted
2022/01/09 05:40:54 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK
2022/01/09 05:40:54 INFO  : potato2: Copied (server-side copy)
2022/01/09 05:40:55 INFO  : potato2: Deleted
2022/01/09 05:40:56 DEBUG : Creating backend with remote "TestB2:rclone-test-kegusaf4foseluk3havujux4"
2022/01/09 05:40:56 DEBUG : tomatoDir: Making directory
2022/01/09 05:40:56 DEBUG : B2 bucket rclone-test-kegusaf4foseluk3havujux4: Waiting for checks to finish
2022/01/09 05:40:56 DEBUG : B2 bucket rclone-test-kegusaf4foseluk3havujux4: Waiting for transfers to finish
2022/01/09 05:40:58 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK
2022/01/09 05:40:58 INFO  : potato2: Copied (server-side copy)
2022/01/09 05:40:58 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK
2022/01/09 05:40:58 INFO  : empty space: Copied (server-side copy)
2022/01/09 05:40:58 INFO  : potato2: Deleted
2022/01/09 05:40:58 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK
2022/01/09 05:40:58 INFO  : potato3: Copied (server-side copy)
2022/01/09 05:40:59 INFO  : empty space: Deleted
2022/01/09 05:40:59 INFO  : potato3: Deleted
2022/01/09 05:40:59 DEBUG : B2 bucket rclone-test-kegusaf4foseluk3havujux4: Purge remote
2022/01/09 05:40:59 DEBUG : empty space: Deleting (id "4_zaf82ad2350ad3bdb7fe80e1b_f1061497dd46d22d7_d20220109_m054058_c001_v0001137_t0002")
2022/01/09 05:40:59 DEBUG : potato2: Deleting (id "4_zaf82ad2350ad3bdb7fe80e1b_f113f27961683d65a_d20220109_m054058_c001_v0001150_t0054")
2022/01/09 05:40:59 DEBUG : potato3: Deleting (id "4_zaf82ad2350ad3bdb7fe80e1b_f113acb748eed117b_d20220109_m054058_c001_v0001145_t0055")
2022/01/09 05:41:00 DEBUG : B2 bucket rclone-test-zuheser1vohayon4hocohog3: Purge remote
2022/01/09 05:41:00 DEBUG : empty space: Deleting (id "4_z5f428da350ad3bdb7fe80e1b_f1171221208d6ab8a_d20220109_m054058_c001_v0001039_t0013")
2022/01/09 05:41:00 DEBUG : empty space: Deleting (id "4_z5f428da350ad3bdb7fe80e1b_f11938a53e8d2b632_d20220109_m054052_c001_v0001144_t0028")
2022/01/09 05:41:00 DEBUG : potato2: Deleting (id "4_z5f428da350ad3bdb7fe80e1b_f116ce3b6b66d67ee_d20220109_m054058_c001_v0001153_t0023")
2022/01/09 05:41:00 DEBUG : potato2: Deleting (id "4_z5f428da350ad3bdb7fe80e1b_f109166ca1e12b121_d20220109_m054053_c001_v0001105_t0038")
2022/01/09 05:41:00 DEBUG : potato3: Deleting (id "4_z5f428da350ad3bdb7fe80e1b_f11845873c1508866_d20220109_m054058_c001_v0001165_t0038")
2022/01/09 05:41:00 DEBUG : potato3: Deleting (id "4_z5f428da350ad3bdb7fe80e1b_f11404ec9653dcc8d_d20220109_m054053_c001_v0001105_t0027")
2022/01/09 05:41:00 DEBUG : potato3: Deleting (id "4_z5f428da350ad3bdb7fe80e1b_f11938a53e8d2b635_d20220109_m054052_c001_v0001144_t0024")
--- PASS: TestServerSideMoveDeleteEmptySourceDirs (14.53s)
=== RUN   TestServerSideMoveOverlap
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:41:01 DEBUG : Creating backend with remote "TestB2:rclone-test-qitaqow9kikeyam1rokuyik2/rclone-move-test"
2022/01/09 05:41:03 DEBUG : Couldn't decode error response: EOF
--- PASS: TestServerSideMoveOverlap (4.93s)
=== RUN   TestSyncOverlap
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:41:06 DEBUG : Creating backend with remote "TestB2:rclone-test-qitaqow9kikeyam1rokuyik2/rclone-sync-test"
2022/01/09 05:41:07 DEBUG : Couldn't decode error response: EOF
--- PASS: TestSyncOverlap (0.75s)
=== RUN   TestSyncCompareDest
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:41:07 DEBUG : Creating backend with remote "TestB2:rclone-test-qitaqow9kikeyam1rokuyik2/dst"
2022/01/09 05:41:07 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:41:07 DEBUG : Creating backend with remote "TestB2:rclone-test-qitaqow9kikeyam1rokuyik2/CompareDest"
2022/01/09 05:41:08 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:41:08 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:41:08 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for checks to finish
2022/01/09 05:41:08 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for transfers to finish
2022/01/09 05:41:10 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK
2022/01/09 05:41:10 INFO  : one: Copied (new)
2022/01/09 05:41:10 DEBUG : Waiting for deletions to finish
2022/01/09 05:41:11 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for checks to finish
2022/01/09 05:41:11 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:41:11 DEBUG : one: Sizes differ (src 5 vs dst 3)
2022/01/09 05:41:11 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for transfers to finish
2022/01/09 05:41:12 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK
2022/01/09 05:41:12 INFO  : one: Copied (replaced existing)
2022/01/09 05:41:12 DEBUG : Waiting for deletions to finish
2022/01/09 05:41:15 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for checks to finish
2022/01/09 05:41:15 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2022/01/09 05:41:15 DEBUG : one: Destination found in --compare-dest, skipping
2022/01/09 05:41:15 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for transfers to finish
2022/01/09 05:41:15 DEBUG : Waiting for deletions to finish
2022/01/09 05:41:15 INFO  : There was nothing to transfer
2022/01/09 05:41:16 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2022/01/09 05:41:16 DEBUG : two: Destination found in --compare-dest, skipping
2022/01/09 05:41:16 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for checks to finish
2022/01/09 05:41:17 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2022/01/09 05:41:17 DEBUG : one: Destination found in --compare-dest, skipping
2022/01/09 05:41:17 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for transfers to finish
2022/01/09 05:41:17 DEBUG : Waiting for deletions to finish
2022/01/09 05:41:17 INFO  : There was nothing to transfer
2022/01/09 05:41:17 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2022/01/09 05:41:17 DEBUG : two: Destination found in --compare-dest, skipping
2022/01/09 05:41:17 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for checks to finish
2022/01/09 05:41:17 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2022/01/09 05:41:17 DEBUG : one: Destination found in --compare-dest, skipping
2022/01/09 05:41:17 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for transfers to finish
2022/01/09 05:41:17 DEBUG : Waiting for deletions to finish
2022/01/09 05:41:17 INFO  : There was nothing to transfer
2022/01/09 05:41:18 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/09 05:41:18 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK
2022/01/09 05:41:18 DEBUG : two: Destination found in --compare-dest, skipping
2022/01/09 05:41:18 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for checks to finish
2022/01/09 05:41:18 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2022/01/09 05:41:18 DEBUG : one: Destination found in --compare-dest, skipping
2022/01/09 05:41:18 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for transfers to finish
2022/01/09 05:41:18 DEBUG : Waiting for deletions to finish
2022/01/09 05:41:18 INFO  : There was nothing to transfer
2022/01/09 05:41:19 DEBUG : two: Sizes differ (src 5 vs dst 3)
2022/01/09 05:41:19 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for checks to finish
2022/01/09 05:41:19 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2022/01/09 05:41:19 DEBUG : one: Destination found in --compare-dest, skipping
2022/01/09 05:41:19 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for transfers to finish
2022/01/09 05:41:21 DEBUG : two: sha1 = a4be8877ad88f3109a6411985a1f359e10e2d930 OK
2022/01/09 05:41:21 INFO  : two: Copied (new)
2022/01/09 05:41:21 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncCompareDest (18.47s)
=== RUN   TestSyncMultipleCompareDest
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:41:27 DEBUG : Creating backend with remote "TestB2:rclone-test-qitaqow9kikeyam1rokuyik2/dest"
2022/01/09 05:41:29 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:41:29 DEBUG : Creating backend with remote "TestB2:rclone-test-qitaqow9kikeyam1rokuyik2/pre-dest1"
2022/01/09 05:41:29 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:41:29 DEBUG : Creating backend with remote "TestB2:rclone-test-qitaqow9kikeyam1rokuyik2/pre-dest2"
2022/01/09 05:41:30 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:41:30 DEBUG : 1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:41:30 DEBUG : 1: Destination found in --compare-dest, skipping
2022/01/09 05:41:31 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:41:31 DEBUG : 2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:41:31 DEBUG : 2: Destination found in --compare-dest, skipping
2022/01/09 05:41:31 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:41:31 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:41:31 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dest: Waiting for checks to finish
2022/01/09 05:41:31 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dest: Waiting for transfers to finish
2022/01/09 05:41:33 DEBUG : 3: sha1 = 77de68daecd823babbb58edb1c8e14d7106e83bb OK
2022/01/09 05:41:33 INFO  : 3: Copied (new)
2022/01/09 05:41:33 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncMultipleCompareDest (12.18s)
=== RUN   TestSyncCopyDest
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:41:38 DEBUG : Creating backend with remote "TestB2:rclone-test-qitaqow9kikeyam1rokuyik2/dst"
2022/01/09 05:41:39 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:41:39 DEBUG : Creating backend with remote "TestB2:rclone-test-qitaqow9kikeyam1rokuyik2/CopyDest"
2022/01/09 05:41:39 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:41:40 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:41:40 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for checks to finish
2022/01/09 05:41:40 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for transfers to finish
2022/01/09 05:41:41 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK
2022/01/09 05:41:41 INFO  : one: Copied (new)
2022/01/09 05:41:41 DEBUG : Waiting for deletions to finish
2022/01/09 05:41:42 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for checks to finish
2022/01/09 05:41:42 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:41:42 DEBUG : one: Sizes differ (src 5 vs dst 3)
2022/01/09 05:41:42 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for transfers to finish
2022/01/09 05:41:43 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK
2022/01/09 05:41:43 INFO  : one: Copied (replaced existing)
2022/01/09 05:41:43 DEBUG : Waiting for deletions to finish
2022/01/09 05:41:46 DEBUG : Creating backend with remote "TestB2:rclone-test-qitaqow9kikeyam1rokuyik2/BackupDir"
2022/01/09 05:41:47 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:41:47 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for checks to finish
2022/01/09 05:41:47 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2022/01/09 05:41:47 DEBUG : one: Sizes differ (src 5 vs dst 3)
2022/01/09 05:41:48 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:41:49 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK
2022/01/09 05:41:49 INFO  : one: Copied (server-side copy)
2022/01/09 05:41:50 INFO  : one: Deleted
2022/01/09 05:41:50 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK
2022/01/09 05:41:50 INFO  : one: Copied (server-side copy)
2022/01/09 05:41:50 DEBUG : one: Destination found in --copy-dest, using server-side copy
2022/01/09 05:41:50 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for transfers to finish
2022/01/09 05:41:50 DEBUG : Waiting for deletions to finish
2022/01/09 05:41:55 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2022/01/09 05:41:59 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK
2022/01/09 05:41:59 INFO  : two: Copied (server-side copy)
2022/01/09 05:41:59 DEBUG : two: Destination found in --copy-dest, using server-side copy
2022/01/09 05:41:59 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for checks to finish
2022/01/09 05:41:59 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2022/01/09 05:41:59 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2022/01/09 05:41:59 DEBUG : one: Unchanged skipping
2022/01/09 05:41:59 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for transfers to finish
2022/01/09 05:41:59 DEBUG : Waiting for deletions to finish
2022/01/09 05:41:59 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for checks to finish
2022/01/09 05:41:59 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2022/01/09 05:41:59 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2022/01/09 05:41:59 DEBUG : one: Unchanged skipping
2022/01/09 05:41:59 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2022/01/09 05:41:59 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2022/01/09 05:41:59 DEBUG : two: Unchanged skipping
2022/01/09 05:41:59 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for transfers to finish
2022/01/09 05:41:59 DEBUG : Waiting for deletions to finish
2022/01/09 05:41:59 INFO  : There was nothing to transfer
2022/01/09 05:42:04 DEBUG : three: Sizes differ (src 7 vs dst 5)
2022/01/09 05:42:04 DEBUG : three: Destination not found in --copy-dest
2022/01/09 05:42:04 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for checks to finish
2022/01/09 05:42:04 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2022/01/09 05:42:04 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2022/01/09 05:42:04 DEBUG : one: Unchanged skipping
2022/01/09 05:42:04 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2022/01/09 05:42:04 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2022/01/09 05:42:04 DEBUG : two: Unchanged skipping
2022/01/09 05:42:04 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for transfers to finish
2022/01/09 05:42:05 DEBUG : three: sha1 = 370e613335f3cf2f19b2a2d35a86402f55c659f8 OK
2022/01/09 05:42:05 INFO  : three: Copied (new)
2022/01/09 05:42:05 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncCopyDest (34.62s)
=== RUN   TestSyncBackupDir
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:42:16 DEBUG : Creating backend with remote "TestB2:rclone-test-qitaqow9kikeyam1rokuyik2/dst"
2022/01/09 05:42:17 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:42:17 DEBUG : Creating backend with remote "TestB2:rclone-test-qitaqow9kikeyam1rokuyik2/backup"
2022/01/09 05:42:17 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:42:17 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:42:17 DEBUG : two: Unchanged skipping
2022/01/09 05:42:17 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for checks to finish
2022/01/09 05:42:17 DEBUG : one: Sizes differ (src 4 vs dst 3)
2022/01/09 05:42:18 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:42:19 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK
2022/01/09 05:42:19 INFO  : one: Copied (server-side copy)
2022/01/09 05:42:20 INFO  : one: Deleted
2022/01/09 05:42:20 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for transfers to finish
2022/01/09 05:42:21 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK
2022/01/09 05:42:21 INFO  : one: Copied (new)
2022/01/09 05:42:21 DEBUG : Waiting for deletions to finish
2022/01/09 05:42:21 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:42:21 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK
2022/01/09 05:42:21 INFO  : three.txt: Copied (server-side copy)
2022/01/09 05:42:22 INFO  : three.txt: Deleted
2022/01/09 05:42:22 INFO  : three.txt: Moved into backup dir
2022/01/09 05:42:24 DEBUG : one: Sizes differ (src 5 vs dst 4)
2022/01/09 05:42:24 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:42:24 DEBUG : two: Unchanged skipping
2022/01/09 05:42:24 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for checks to finish
2022/01/09 05:42:26 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK
2022/01/09 05:42:26 INFO  : one: Copied (server-side copy)
2022/01/09 05:42:27 INFO  : one: Deleted
2022/01/09 05:42:27 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for transfers to finish
2022/01/09 05:42:28 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK
2022/01/09 05:42:28 INFO  : one: Copied (new)
2022/01/09 05:42:28 DEBUG : Waiting for deletions to finish
2022/01/09 05:42:29 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK
2022/01/09 05:42:29 INFO  : three.txt: Copied (server-side copy)
2022/01/09 05:42:29 INFO  : three.txt: Deleted
2022/01/09 05:42:29 INFO  : three.txt: Moved into backup dir
--- PASS: TestSyncBackupDir (19.59s)
=== RUN   TestSyncBackupDirWithSuffix
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:42:36 DEBUG : Creating backend with remote "TestB2:rclone-test-qitaqow9kikeyam1rokuyik2/dst"
2022/01/09 05:42:38 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:42:38 DEBUG : Creating backend with remote "TestB2:rclone-test-qitaqow9kikeyam1rokuyik2/backup"
2022/01/09 05:42:38 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:42:39 DEBUG : one: Sizes differ (src 4 vs dst 3)
2022/01/09 05:42:39 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:42:39 DEBUG : two: Unchanged skipping
2022/01/09 05:42:39 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for checks to finish
2022/01/09 05:42:39 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:42:40 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK
2022/01/09 05:42:40 INFO  : one: Copied (server-side copy) to: one.bak
2022/01/09 05:42:40 INFO  : one: Deleted
2022/01/09 05:42:40 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for transfers to finish
2022/01/09 05:42:42 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK
2022/01/09 05:42:42 INFO  : one: Copied (new)
2022/01/09 05:42:42 DEBUG : Waiting for deletions to finish
2022/01/09 05:42:42 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:42:43 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK
2022/01/09 05:42:43 INFO  : three.txt: Copied (server-side copy) to: three.txt.bak
2022/01/09 05:42:43 INFO  : three.txt: Deleted
2022/01/09 05:42:43 INFO  : three.txt: Moved into backup dir
2022/01/09 05:42:44 DEBUG : one: Sizes differ (src 5 vs dst 4)
2022/01/09 05:42:44 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:42:44 DEBUG : two: Unchanged skipping
2022/01/09 05:42:44 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for checks to finish
2022/01/09 05:42:45 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK
2022/01/09 05:42:45 INFO  : one: Copied (server-side copy) to: one.bak
2022/01/09 05:42:46 INFO  : one: Deleted
2022/01/09 05:42:46 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for transfers to finish
2022/01/09 05:42:46 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK
2022/01/09 05:42:46 INFO  : one: Copied (new)
2022/01/09 05:42:46 DEBUG : Waiting for deletions to finish
2022/01/09 05:42:47 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK
2022/01/09 05:42:47 INFO  : three.txt: Copied (server-side copy) to: three.txt.bak
2022/01/09 05:42:48 INFO  : three.txt: Deleted
2022/01/09 05:42:48 INFO  : three.txt: Moved into backup dir
--- PASS: TestSyncBackupDirWithSuffix (18.47s)
=== RUN   TestSyncBackupDirWithSuffixKeepExtension
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:42:54 DEBUG : Creating backend with remote "TestB2:rclone-test-qitaqow9kikeyam1rokuyik2/dst"
2022/01/09 05:42:56 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:42:56 DEBUG : Creating backend with remote "TestB2:rclone-test-qitaqow9kikeyam1rokuyik2/backup"
2022/01/09 05:42:56 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:42:56 DEBUG : one: Sizes differ (src 4 vs dst 3)
2022/01/09 05:42:56 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:42:56 DEBUG : two: Unchanged skipping
2022/01/09 05:42:56 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for checks to finish
2022/01/09 05:42:57 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:43:00 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK
2022/01/09 05:43:00 INFO  : one: Copied (server-side copy) to: one-2019-01-01
2022/01/09 05:43:01 INFO  : one: Deleted
2022/01/09 05:43:01 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for transfers to finish
2022/01/09 05:43:02 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK
2022/01/09 05:43:02 INFO  : one: Copied (new)
2022/01/09 05:43:02 DEBUG : Waiting for deletions to finish
2022/01/09 05:43:03 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:43:04 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK
2022/01/09 05:43:04 INFO  : three.txt: Copied (server-side copy) to: three-2019-01-01.txt
2022/01/09 05:43:05 INFO  : three.txt: Deleted
2022/01/09 05:43:05 INFO  : three.txt: Moved into backup dir
2022/01/09 05:43:06 DEBUG : one: Sizes differ (src 5 vs dst 4)
2022/01/09 05:43:06 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:43:06 DEBUG : two: Unchanged skipping
2022/01/09 05:43:06 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for checks to finish
2022/01/09 05:43:07 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK
2022/01/09 05:43:07 INFO  : one: Copied (server-side copy) to: one-2019-01-01
2022/01/09 05:43:08 INFO  : one: Deleted
2022/01/09 05:43:08 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for transfers to finish
2022/01/09 05:43:09 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK
2022/01/09 05:43:09 INFO  : one: Copied (new)
2022/01/09 05:43:09 DEBUG : Waiting for deletions to finish
2022/01/09 05:43:10 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK
2022/01/09 05:43:10 INFO  : three.txt: Copied (server-side copy) to: three-2019-01-01.txt
2022/01/09 05:43:10 INFO  : three.txt: Deleted
2022/01/09 05:43:10 INFO  : three.txt: Moved into backup dir
--- PASS: TestSyncBackupDirWithSuffixKeepExtension (24.19s)
=== RUN   TestSyncBackupDirSuffixOnly
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:43:18 DEBUG : Creating backend with remote "TestB2:rclone-test-qitaqow9kikeyam1rokuyik2/dst"
2022/01/09 05:43:20 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:43:20 DEBUG : one: Sizes differ (src 4 vs dst 3)
2022/01/09 05:43:20 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:43:20 DEBUG : two: Unchanged skipping
2022/01/09 05:43:20 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for checks to finish
2022/01/09 05:43:20 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:43:21 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK
2022/01/09 05:43:21 INFO  : one: Copied (server-side copy) to: one.bak
2022/01/09 05:43:21 INFO  : one: Deleted
2022/01/09 05:43:21 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for transfers to finish
2022/01/09 05:43:22 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK
2022/01/09 05:43:22 INFO  : one: Copied (new)
2022/01/09 05:43:22 DEBUG : Waiting for deletions to finish
2022/01/09 05:43:22 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:43:23 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK
2022/01/09 05:43:23 INFO  : three.txt: Copied (server-side copy) to: three.txt.bak
2022/01/09 05:43:23 INFO  : three.txt: Deleted
2022/01/09 05:43:23 INFO  : three.txt: Moved into backup dir
2022/01/09 05:43:25 DEBUG : one.bak: Excluded
2022/01/09 05:43:25 DEBUG : three.txt.bak: Excluded
2022/01/09 05:43:25 DEBUG : one: Sizes differ (src 5 vs dst 4)
2022/01/09 05:43:25 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:43:25 DEBUG : two: Unchanged skipping
2022/01/09 05:43:25 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for checks to finish
2022/01/09 05:43:27 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK
2022/01/09 05:43:27 INFO  : one: Copied (server-side copy) to: one.bak
2022/01/09 05:43:28 INFO  : one: Deleted
2022/01/09 05:43:28 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2 path dst: Waiting for transfers to finish
2022/01/09 05:43:28 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK
2022/01/09 05:43:28 INFO  : one: Copied (new)
2022/01/09 05:43:28 DEBUG : Waiting for deletions to finish
2022/01/09 05:43:29 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK
2022/01/09 05:43:29 INFO  : three.txt: Copied (server-side copy) to: three.txt.bak
2022/01/09 05:43:30 INFO  : three.txt: Deleted
2022/01/09 05:43:30 INFO  : three.txt: Moved into backup dir
--- PASS: TestSyncBackupDirSuffixOnly (22.70s)
=== RUN   TestSyncSuffix
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:43:40 DEBUG : Creating backend with remote "TestB2:rclone-test-qitaqow9kikeyam1rokuyik2/dst"
2022/01/09 05:43:42 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:43:42 DEBUG : one: Sizes differ (src 4 vs dst 3)
2022/01/09 05:43:42 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:43:44 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK
2022/01/09 05:43:44 INFO  : one: Copied (server-side copy) to: one.bak
2022/01/09 05:43:44 INFO  : one: Deleted
2022/01/09 05:43:46 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK
2022/01/09 05:43:46 INFO  : one: Copied (new)
2022/01/09 05:43:46 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:43:46 DEBUG : two: Unchanged skipping
2022/01/09 05:43:46 DEBUG : three.txt: Sizes differ (src 6 vs dst 5)
2022/01/09 05:43:46 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:43:47 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK
2022/01/09 05:43:47 INFO  : three.txt: Copied (server-side copy) to: three.txt.bak
2022/01/09 05:43:48 INFO  : three.txt: Deleted
2022/01/09 05:43:49 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK
2022/01/09 05:43:49 INFO  : three.txt: Copied (new)
2022/01/09 05:43:49 DEBUG : one: Sizes differ (src 5 vs dst 4)
2022/01/09 05:43:51 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK
2022/01/09 05:43:51 INFO  : one: Copied (server-side copy) to: one.bak
2022/01/09 05:43:52 INFO  : one: Deleted
2022/01/09 05:43:53 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK
2022/01/09 05:43:53 INFO  : one: Copied (new)
2022/01/09 05:43:53 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:43:53 DEBUG : two: Unchanged skipping
2022/01/09 05:43:53 DEBUG : three.txt: Sizes differ (src 19 vs dst 6)
2022/01/09 05:43:54 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK
2022/01/09 05:43:54 INFO  : three.txt: Copied (server-side copy) to: three.txt.bak
2022/01/09 05:43:56 INFO  : three.txt: Deleted
2022/01/09 05:43:57 DEBUG : three.txt: sha1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK
2022/01/09 05:43:57 INFO  : three.txt: Copied (new)
--- PASS: TestSyncSuffix (23.31s)
=== RUN   TestSyncSuffixKeepExtension
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:44:04 DEBUG : Creating backend with remote "TestB2:rclone-test-qitaqow9kikeyam1rokuyik2/dst"
2022/01/09 05:44:06 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:44:06 DEBUG : one: Sizes differ (src 4 vs dst 3)
2022/01/09 05:44:06 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:44:07 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK
2022/01/09 05:44:07 INFO  : one: Copied (server-side copy) to: one-2019-01-01
2022/01/09 05:44:09 INFO  : one: Deleted
2022/01/09 05:44:10 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK
2022/01/09 05:44:10 INFO  : one: Copied (new)
2022/01/09 05:44:10 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:44:10 DEBUG : two: Unchanged skipping
2022/01/09 05:44:10 DEBUG : three.txt: Sizes differ (src 6 vs dst 5)
2022/01/09 05:44:10 DEBUG : Couldn't decode error response: EOF
2022/01/09 05:44:11 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK
2022/01/09 05:44:11 INFO  : three.txt: Copied (server-side copy) to: three-2019-01-01.txt
2022/01/09 05:44:12 INFO  : three.txt: Deleted
2022/01/09 05:44:12 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK
2022/01/09 05:44:12 INFO  : three.txt: Copied (new)
2022/01/09 05:44:13 DEBUG : one: Sizes differ (src 5 vs dst 4)
2022/01/09 05:44:13 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK
2022/01/09 05:44:13 INFO  : one: Copied (server-side copy) to: one-2019-01-01
2022/01/09 05:44:14 INFO  : one: Deleted
2022/01/09 05:44:14 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK
2022/01/09 05:44:14 INFO  : one: Copied (new)
2022/01/09 05:44:15 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:44:15 DEBUG : two: Unchanged skipping
2022/01/09 05:44:15 DEBUG : three.txt: Sizes differ (src 19 vs dst 6)
2022/01/09 05:44:16 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK
2022/01/09 05:44:16 INFO  : three.txt: Copied (server-side copy) to: three-2019-01-01.txt
2022/01/09 05:44:17 INFO  : three.txt: Deleted
2022/01/09 05:44:18 DEBUG : three.txt: sha1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK
2022/01/09 05:44:18 INFO  : three.txt: Copied (new)
--- PASS: TestSyncSuffixKeepExtension (22.53s)
=== RUN   TestSyncUTFNorm
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:44:26 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:44:26 DEBUG : Testêé: Sizes differ (src 14 vs dst 18)
2022/01/09 05:44:26 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:44:29 DEBUG : Testêé: sha1 = a54d88e06612d820bc3be72877c74f257b561b19 OK
2022/01/09 05:44:29 INFO  : Testêé: Copied (replaced existing) to: Testêé
2022/01/09 05:44:29 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncUTFNorm (6.83s)
=== RUN   TestSyncImmutable
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:44:30 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:44:30 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:44:30 DEBUG : existing: Clearing upload URL because of error: Post "https://pod-000-1105-02.backblaze.com/b2api/v1/b2_upload_file/bf923d13507d3bdb7fe80e1b/c001_v0001105_t0045": EOF
2022/01/09 05:44:30 DEBUG : pacer: low level retry 1/1 (error Post "https://pod-000-1105-02.backblaze.com/b2api/v1/b2_upload_file/bf923d13507d3bdb7fe80e1b/c001_v0001105_t0045": EOF)
2022/01/09 05:44:30 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2022/01/09 05:44:30 DEBUG : existing: Received error: Post "https://pod-000-1105-02.backblaze.com/b2api/v1/b2_upload_file/bf923d13507d3bdb7fe80e1b/c001_v0001105_t0045": EOF - low level retry 1/10
2022/01/09 05:44:31 DEBUG : pacer: Reducing sleep to 10ms
2022/01/09 05:44:31 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK
2022/01/09 05:44:31 INFO  : existing: Copied (new)
2022/01/09 05:44:31 DEBUG : Waiting for deletions to finish
2022/01/09 05:44:32 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:44:32 DEBUG : existing: Sizes differ (src 8 vs dst 6)
2022/01/09 05:44:32 ERROR : existing: Source and destination exist but do not match: immutable file modified
2022/01/09 05:44:32 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:44:32 ERROR : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: not deleting files as there were IO errors
2022/01/09 05:44:32 ERROR : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: not deleting directories as there were IO errors
--- PASS: TestSyncImmutable (2.69s)
=== RUN   TestSyncIgnoreCase
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:44:33 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:44:33 DEBUG : existing: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:44:33 DEBUG : existing: Unchanged skipping
2022/01/09 05:44:33 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:44:33 DEBUG : Waiting for deletions to finish
2022/01/09 05:44:33 INFO  : There was nothing to transfer
--- PASS: TestSyncIgnoreCase (3.01s)
=== RUN   TestMaxTransfer
=== RUN   TestMaxTransfer/Hard
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
    sync_test.go:1989: This test only runs on local
=== RUN   TestMaxTransfer/Soft
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
    sync_test.go:1989: This test only runs on local
=== RUN   TestMaxTransfer/Cautious
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", 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-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:45:17 DEBUG : both0: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:45:17 DEBUG : both0: Unchanged skipping
2022/01/09 05:45:17 DEBUG : both1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:45:17 DEBUG : both1: Unchanged skipping
2022/01/09 05:45:17 DEBUG : both11: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:45:17 DEBUG : both12: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:45:17 DEBUG : both12: Unchanged skipping
2022/01/09 05:45:17 DEBUG : both13: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:45:17 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:45:17 DEBUG : both11: Unchanged skipping
2022/01/09 05:45:17 DEBUG : both15: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:45:17 DEBUG : both15: Unchanged skipping
2022/01/09 05:45:17 DEBUG : both14: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:45:17 DEBUG : both16: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:45:17 DEBUG : both16: Unchanged skipping
2022/01/09 05:45:17 DEBUG : both17: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:45:17 DEBUG : both17: Unchanged skipping
2022/01/09 05:45:17 DEBUG : both13: Unchanged skipping
2022/01/09 05:45:17 DEBUG : both19: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:45:17 DEBUG : both19: Unchanged skipping
2022/01/09 05:45:17 DEBUG : both2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:45:17 DEBUG : both2: Unchanged skipping
2022/01/09 05:45:17 DEBUG : both3: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:45:17 DEBUG : both3: Unchanged skipping
2022/01/09 05:45:17 DEBUG : both4: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:45:17 DEBUG : both4: Unchanged skipping
2022/01/09 05:45:17 DEBUG : both5: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:45:17 DEBUG : both5: Unchanged skipping
2022/01/09 05:45:17 DEBUG : both6: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:45:17 DEBUG : both6: Unchanged skipping
2022/01/09 05:45:17 DEBUG : both7: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:45:17 DEBUG : both7: Unchanged skipping
2022/01/09 05:45:17 DEBUG : both8: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:45:17 DEBUG : both8: Unchanged skipping
2022/01/09 05:45:17 DEBUG : both9: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:45:17 DEBUG : both9: Unchanged skipping
2022/01/09 05:45:17 DEBUG : both10: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:45:17 DEBUG : both10: Unchanged skipping
2022/01/09 05:45:17 DEBUG : both18: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:45:17 DEBUG : both18: Unchanged skipping
2022/01/09 05:45:17 DEBUG : both14: Unchanged skipping
2022/01/09 05:45:17 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:45:17 DEBUG : Waiting for deletions to finish
2022/01/09 05:45:18 INFO  : only11: Deleted
2022/01/09 05:45:18 INFO  : only6: Deleted
2022/01/09 05:45:19 INFO  : only2: Deleted
2022/01/09 05:45:19 INFO  : only10: Deleted
2022/01/09 05:45:19 INFO  : only8: Deleted
2022/01/09 05:45:19 INFO  : only0: Deleted
2022/01/09 05:45:19 INFO  : only12: Deleted
2022/01/09 05:45:19 INFO  : only5: Deleted
2022/01/09 05:45:19 INFO  : only18: Deleted
2022/01/09 05:45:19 INFO  : only16: Deleted
2022/01/09 05:45:20 INFO  : only4: Deleted
2022/01/09 05:45:20 INFO  : only13: Deleted
2022/01/09 05:45:20 INFO  : only9: Deleted
2022/01/09 05:45:21 INFO  : only1: Deleted
2022/01/09 05:45:21 INFO  : only14: Deleted
2022/01/09 05:45:21 INFO  : only17: Deleted
2022/01/09 05:45:22 INFO  : only7: Deleted
2022/01/09 05:45:22 INFO  : only19: Deleted
2022/01/09 05:45:22 INFO  : only15: Deleted
2022/01/09 05:45:23 INFO  : only3: Deleted
2022/01/09 05:45:23 INFO  : There was nothing to transfer
--- PASS: TestSyncConcurrentDelete (65.09s)
=== RUN   TestSyncConcurrentTruncate
    run.go:181: Remote "B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2", Local "Local file system at /tmp/rclone1308898890", Modify Window "1ms"
2022/01/09 05:46:14 DEBUG : both0: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:46:14 DEBUG : both0: Unchanged skipping
2022/01/09 05:46:14 DEBUG : both1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:46:14 DEBUG : both1: Unchanged skipping
2022/01/09 05:46:14 DEBUG : both10: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:46:14 DEBUG : both10: Unchanged skipping
2022/01/09 05:46:14 DEBUG : both11: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:46:14 DEBUG : both11: Unchanged skipping
2022/01/09 05:46:14 DEBUG : both12: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:46:14 DEBUG : both12: Unchanged skipping
2022/01/09 05:46:14 DEBUG : both13: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:46:14 DEBUG : both13: Unchanged skipping
2022/01/09 05:46:14 DEBUG : both14: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:46:14 DEBUG : both14: Unchanged skipping
2022/01/09 05:46:14 DEBUG : both15: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:46:14 DEBUG : both15: Unchanged skipping
2022/01/09 05:46:14 DEBUG : both16: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:46:14 DEBUG : both16: Unchanged skipping
2022/01/09 05:46:14 DEBUG : both17: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:46:14 DEBUG : both17: Unchanged skipping
2022/01/09 05:46:14 DEBUG : both18: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:46:14 DEBUG : both18: Unchanged skipping
2022/01/09 05:46:14 DEBUG : both19: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:46:14 DEBUG : both19: Unchanged skipping
2022/01/09 05:46:14 DEBUG : both2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:46:14 DEBUG : both2: Unchanged skipping
2022/01/09 05:46:14 DEBUG : both3: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:46:14 DEBUG : both3: Unchanged skipping
2022/01/09 05:46:14 DEBUG : both4: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:46:14 DEBUG : both4: Unchanged skipping
2022/01/09 05:46:14 DEBUG : both5: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:46:14 DEBUG : both5: Unchanged skipping
2022/01/09 05:46:14 DEBUG : both6: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:46:14 DEBUG : both6: Unchanged skipping
2022/01/09 05:46:14 DEBUG : both7: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:46:14 DEBUG : both7: Unchanged skipping
2022/01/09 05:46:14 DEBUG : both8: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:46:14 DEBUG : both8: Unchanged skipping
2022/01/09 05:46:14 DEBUG : both9: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2022/01/09 05:46:14 DEBUG : both9: Unchanged skipping
2022/01/09 05:46:14 DEBUG : only0: Sizes differ (src 0 vs dst 6)
2022/01/09 05:46:14 DEBUG : only1: Sizes differ (src 0 vs dst 6)
2022/01/09 05:46:14 DEBUG : only10: Sizes differ (src 0 vs dst 6)
2022/01/09 05:46:14 DEBUG : only11: Sizes differ (src 0 vs dst 6)
2022/01/09 05:46:14 DEBUG : only12: Sizes differ (src 0 vs dst 6)
2022/01/09 05:46:14 DEBUG : only13: Sizes differ (src 0 vs dst 6)
2022/01/09 05:46:14 DEBUG : only14: Sizes differ (src 0 vs dst 6)
2022/01/09 05:46:14 DEBUG : only15: Sizes differ (src 0 vs dst 6)
2022/01/09 05:46:14 DEBUG : only16: Sizes differ (src 0 vs dst 6)
2022/01/09 05:46:14 DEBUG : only17: Sizes differ (src 0 vs dst 6)
2022/01/09 05:46:14 DEBUG : only18: Sizes differ (src 0 vs dst 6)
2022/01/09 05:46:14 DEBUG : only19: Sizes differ (src 0 vs dst 6)
2022/01/09 05:46:14 DEBUG : only2: Sizes differ (src 0 vs dst 6)
2022/01/09 05:46:14 DEBUG : only3: Sizes differ (src 0 vs dst 6)
2022/01/09 05:46:14 DEBUG : only4: Sizes differ (src 0 vs dst 6)
2022/01/09 05:46:14 DEBUG : only5: Sizes differ (src 0 vs dst 6)
2022/01/09 05:46:14 DEBUG : only6: Sizes differ (src 0 vs dst 6)
2022/01/09 05:46:14 DEBUG : only7: Sizes differ (src 0 vs dst 6)
2022/01/09 05:46:14 DEBUG : only8: Sizes differ (src 0 vs dst 6)
2022/01/09 05:46:14 DEBUG : only9: Sizes differ (src 0 vs dst 6)
2022/01/09 05:46:14 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for checks to finish
2022/01/09 05:46:14 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Waiting for transfers to finish
2022/01/09 05:46:15 DEBUG : only0: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2022/01/09 05:46:15 INFO  : only0: Copied (replaced existing)
2022/01/09 05:46:16 DEBUG : only12: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2022/01/09 05:46:16 INFO  : only12: Copied (replaced existing)
2022/01/09 05:46:16 DEBUG : only10: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2022/01/09 05:46:16 INFO  : only10: Copied (replaced existing)
2022/01/09 05:46:16 DEBUG : only1: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2022/01/09 05:46:16 INFO  : only1: Copied (replaced existing)
2022/01/09 05:46:16 DEBUG : only13: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2022/01/09 05:46:16 INFO  : only13: Copied (replaced existing)
2022/01/09 05:46:17 DEBUG : only11: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2022/01/09 05:46:17 INFO  : only11: Copied (replaced existing)
2022/01/09 05:46:17 DEBUG : only15: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2022/01/09 05:46:17 INFO  : only15: Copied (replaced existing)
2022/01/09 05:46:17 DEBUG : only16: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2022/01/09 05:46:17 INFO  : only16: Copied (replaced existing)
2022/01/09 05:46:17 DEBUG : only17: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2022/01/09 05:46:17 INFO  : only17: Copied (replaced existing)
2022/01/09 05:46:18 DEBUG : only14: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2022/01/09 05:46:18 INFO  : only14: Copied (replaced existing)
2022/01/09 05:46:18 DEBUG : only2: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2022/01/09 05:46:18 INFO  : only2: Copied (replaced existing)
2022/01/09 05:46:19 DEBUG : only3: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2022/01/09 05:46:19 INFO  : only3: Copied (replaced existing)
2022/01/09 05:46:19 DEBUG : only4: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2022/01/09 05:46:19 INFO  : only4: Copied (replaced existing)
2022/01/09 05:46:19 DEBUG : only18: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2022/01/09 05:46:19 INFO  : only18: Copied (replaced existing)
2022/01/09 05:46:19 DEBUG : only19: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2022/01/09 05:46:19 INFO  : only19: Copied (replaced existing)
2022/01/09 05:46:20 DEBUG : only5: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2022/01/09 05:46:20 INFO  : only5: Copied (replaced existing)
2022/01/09 05:46:20 DEBUG : only7: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2022/01/09 05:46:20 INFO  : only7: Copied (replaced existing)
2022/01/09 05:46:20 DEBUG : only8: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2022/01/09 05:46:20 INFO  : only8: Copied (replaced existing)
2022/01/09 05:46:20 DEBUG : only6: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2022/01/09 05:46:20 INFO  : only6: Copied (replaced existing)
2022/01/09 05:46:21 DEBUG : only9: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2022/01/09 05:46:21 INFO  : only9: Copied (replaced existing)
2022/01/09 05:46:21 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncConcurrentTruncate (73.70s)
PASS
2022/01/09 05:46:55 DEBUG : B2 bucket rclone-test-qitaqow9kikeyam1rokuyik2: Purge remote
2022/01/09 05:46:56 DEBUG : BackupDir/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11432a10e629f23c_d20220109_m054205_c001_v0001146_t0045")
2022/01/09 05:46:56 DEBUG : BackupDir/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f116da232b9596508_d20220109_m054149_c001_v0001154_t0016")
2022/01/09 05:46:56 DEBUG : CompareDest/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f10280bfeb67d80d9_d20220109_m054121_c001_v0001157_t0027")
2022/01/09 05:46:56 DEBUG : CompareDest/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed2e82_d20220109_m054114_c001_v0001105_t0052")
2022/01/09 05:46:56 DEBUG : CompareDest/two: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f107d4ee4ca5ab60b_d20220109_m054124_c001_v0001165_t0034")
2022/01/09 05:46:56 DEBUG : CompareDest/two: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e17a_d20220109_m054115_c001_v0001043_t0052")
2022/01/09 05:46:56 DEBUG : CopyDest/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f114ef823dbe6a998_d20220109_m054205_c001_v0001161_t0006")
2022/01/09 05:46:56 DEBUG : CopyDest/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e1aa_d20220109_m054145_c001_v0001043_t0050")
2022/01/09 05:46:56 DEBUG : CopyDest/three: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11344afe85c22e8d_d20220109_m054206_c001_v0001165_t0049")
2022/01/09 05:46:56 DEBUG : CopyDest/three: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e1b9_d20220109_m054200_c001_v0001043_t0005")
2022/01/09 05:46:56 DEBUG : CopyDest/two: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f10388caaece20d59_d20220109_m054206_c001_v0001113_t0005")
2022/01/09 05:46:57 DEBUG : CopyDest/two: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed3182_d20220109_m054153_c001_v0001105_t0045")
2022/01/09 05:46:57 DEBUG : EXISTING: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f108da3d2babbfc59_d20220109_m054434_c001_v0001044_t0052")
2022/01/09 05:46:57 DEBUG : EXISTING: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e2ba_d20220109_m054433_c001_v0001043_t0022")
2022/01/09 05:46:57 DEBUG : Testêé: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f115129af22b54cdc_d20220109_m054429_c001_v0001165_t0040")
2022/01/09 05:46:57 DEBUG : Testêé: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e2a5_d20220109_m054426_c001_v0001043_t0059")
2022/01/09 05:46:57 DEBUG : Testêé: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed4303_d20220109_m054424_c001_v0001105_t0024")
2022/01/09 05:46:57 DEBUG : a/potato2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1044753747229dcb_d20220109_m053903_c001_v0001092_t0030")
2022/01/09 05:46:57 DEBUG : a/potato2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed2348_d20220109_m053902_c001_v0001105_t0017")
2022/01/09 05:46:57 DEBUG : a/potato2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11374fa12527cdc7_d20220109_m053859_c001_v0001113_t0058")
2022/01/09 05:46:57 DEBUG : a/potato2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed22bf_d20220109_m053856_c001_v0001105_t0050")
2022/01/09 05:46:57 DEBUG : a/potato2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11324ceb57a7a90c_d20220109_m053809_c001_v0001105_t0036")
2022/01/09 05:46:57 DEBUG : a/potato2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed1e22_d20220109_m053806_c001_v0001105_t0049")
2022/01/09 05:46:57 DEBUG : b/potato: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f108674e8ebde677b_d20220109_m053904_c001_v0001098_t0041")
2022/01/09 05:46:57 DEBUG : b/potato: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed231f_d20220109_m053900_c001_v0001105_t0041")
2022/01/09 05:46:57 DEBUG : b/potato: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f114afb2c96fd5496_d20220109_m053858_c001_v0001117_t0007")
2022/01/09 05:46:57 DEBUG : b/potato: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed2282_d20220109_m053854_c001_v0001105_t0054")
2022/01/09 05:46:57 DEBUG : b/potato: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1197e4c55f5ab3f4_d20220109_m053808_c001_v0001130_t0014")
2022/01/09 05:46:57 DEBUG : b/potato: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed1dfb_d20220109_m053805_c001_v0001105_t0001")
2022/01/09 05:46:57 DEBUG : backup/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f101fcaabbfaddea6_d20220109_m054230_c001_v0001150_t0046")
2022/01/09 05:46:58 DEBUG : backup/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f111d1384e8dffd5a_d20220109_m054224_c001_v0001044_t0017")
2022/01/09 05:46:58 DEBUG : backup/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f116aaecfc0095375_d20220109_m054219_c001_v0001117_t0001")
2022/01/09 05:46:58 DEBUG : backup/one-2019-01-01: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f105322318daa4b7f_d20220109_m054311_c001_v0001146_t0049")
2022/01/09 05:46:58 DEBUG : backup/one-2019-01-01: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f106795f3f37e2aef_d20220109_m054306_c001_v0001041_t0033")
2022/01/09 05:46:58 DEBUG : backup/one-2019-01-01: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f106ae8fb6ef1b84d_d20220109_m054259_c001_v0001029_t0033")
2022/01/09 05:46:58 DEBUG : backup/one.bak: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1018f30ad197cd57_d20220109_m054248_c001_v0001130_t0009")
2022/01/09 05:46:58 DEBUG : backup/one.bak: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f103f154bb709e6fa_d20220109_m054245_c001_v0001032_t0040")
2022/01/09 05:46:58 DEBUG : backup/one.bak: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f118af404f9d2f6de_d20220109_m054240_c001_v0001001_t0019")
2022/01/09 05:46:58 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1161b7047dbb0737_d20220109_m054311_c001_v0001161_t0019")
2022/01/09 05:46:58 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1144958662544411_d20220109_m054310_c001_v0001015_t0002")
2022/01/09 05:46:58 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1061497dd46d2352_d20220109_m054303_c001_v0001137_t0003")
2022/01/09 05:46:58 DEBUG : backup/three.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11526f0079d90549_d20220109_m054230_c001_v0001161_t0002")
2022/01/09 05:46:58 DEBUG : backup/three.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1102dd3799dca1d6_d20220109_m054228_c001_v0001032_t0010")
2022/01/09 05:46:58 DEBUG : backup/three.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f105bf56e96ef519b_d20220109_m054221_c001_v0001165_t0005")
2022/01/09 05:46:58 DEBUG : backup/three.txt.bak: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f118950505b637057_d20220109_m054248_c001_v0001154_t0012")
2022/01/09 05:46:58 DEBUG : backup/three.txt.bak: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1012959da0e1d5f9_d20220109_m054247_c001_v0001136_t0005")
2022/01/09 05:46:58 DEBUG : backup/three.txt.bak: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f105706456ae3bd7e_d20220109_m054242_c001_v0001097_t0039")
2022/01/09 05:46:58 DEBUG : both0: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1100d629fad51174_d20220109_m054622_c001_v0001098_t0029")
2022/01/09 05:46:58 DEBUG : both0: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e396_d20220109_m054542_c001_v0001043_t0023")
2022/01/09 05:46:58 DEBUG : both0: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f118d18a9c6e34073_d20220109_m054523_c001_v0001150_t0007")
2022/01/09 05:46:59 DEBUG : both0: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e2c3_d20220109_m054437_c001_v0001043_t0040")
2022/01/09 05:46:59 DEBUG : both1: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11374fa12527d7af_d20220109_m054623_c001_v0001113_t0009")
2022/01/09 05:46:59 DEBUG : both1: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e3a1_d20220109_m054544_c001_v0001043_t0001")
2022/01/09 05:46:59 DEBUG : both1: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1006923104ca9988_d20220109_m054524_c001_v0001137_t0039")
2022/01/09 05:46:59 DEBUG : both1: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e2ce_d20220109_m054441_c001_v0001043_t0059")
2022/01/09 05:46:59 DEBUG : both10: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f104cab6884cccec2_d20220109_m054625_c001_v0001093_t0000")
2022/01/09 05:46:59 DEBUG : both10: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e3e7_d20220109_m054558_c001_v0001043_t0031")
2022/01/09 05:46:59 DEBUG : both10: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f10748e3f96940839_d20220109_m054525_c001_v0001109_t0004")
2022/01/09 05:46:59 DEBUG : both10: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e30c_d20220109_m054451_c001_v0001043_t0021")
2022/01/09 05:46:59 DEBUG : both11: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f101506c543465ffd_d20220109_m054626_c001_v0001098_t0048")
2022/01/09 05:46:59 DEBUG : both11: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e3ec_d20220109_m054600_c001_v0001043_t0047")
2022/01/09 05:46:59 DEBUG : both11: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f106965b35b7ac66f_d20220109_m054526_c001_v0001161_t0050")
2022/01/09 05:46:59 DEBUG : both11: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e319_d20220109_m054454_c001_v0001043_t0003")
2022/01/09 05:46:59 DEBUG : both12: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f10748e3f96940ac5_d20220109_m054626_c001_v0001109_t0045")
2022/01/09 05:46:59 DEBUG : both12: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e3f4_d20220109_m054601_c001_v0001043_t0049")
2022/01/09 05:46:59 DEBUG : both12: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1026c4cce0fb1bbc_d20220109_m054526_c001_v0001120_t0017")
2022/01/09 05:46:59 DEBUG : both12: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e322_d20220109_m054457_c001_v0001043_t0020")
2022/01/09 05:46:59 DEBUG : both13: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1144d0f544559d80_d20220109_m054628_c001_v0001120_t0057")
2022/01/09 05:46:59 DEBUG : both13: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e3fc_d20220109_m054603_c001_v0001043_t0059")
2022/01/09 05:47:00 DEBUG : both13: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f106ceeaedda9e5a0_d20220109_m054527_c001_v0001136_t0027")
2022/01/09 05:47:00 DEBUG : both13: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e32a_d20220109_m054458_c001_v0001043_t0049")
2022/01/09 05:47:00 DEBUG : both14: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f112336291dc7b7f9_d20220109_m054628_c001_v0001146_t0014")
2022/01/09 05:47:00 DEBUG : both14: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e403_d20220109_m054605_c001_v0001043_t0041")
2022/01/09 05:47:00 DEBUG : both14: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1051572f2f8c4e01_d20220109_m054527_c001_v0001150_t0030")
2022/01/09 05:47:00 DEBUG : both14: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e331_d20220109_m054502_c001_v0001043_t0018")
2022/01/09 05:47:00 DEBUG : both15: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f110416a5b2de92df_d20220109_m054631_c001_v0001144_t0021")
2022/01/09 05:47:00 DEBUG : both15: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e409_d20220109_m054605_c001_v0001043_t0013")
2022/01/09 05:47:00 DEBUG : both15: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f108a985fc87db5b4_d20220109_m054528_c001_v0001136_t0046")
2022/01/09 05:47:00 DEBUG : both15: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e335_d20220109_m054503_c001_v0001043_t0059")
2022/01/09 05:47:00 DEBUG : both16: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1166226c93638fd2_d20220109_m054632_c001_v0001150_t0018")
2022/01/09 05:47:00 DEBUG : both16: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e40f_d20220109_m054609_c001_v0001043_t0045")
2022/01/09 05:47:00 DEBUG : both16: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f117fb0061c9eba78_d20220109_m054528_c001_v0001090_t0043")
2022/01/09 05:47:00 DEBUG : both16: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e33c_d20220109_m054507_c001_v0001043_t0006")
2022/01/09 05:47:00 DEBUG : both17: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1167741a99ebf7a6_d20220109_m054632_c001_v0001144_t0036")
2022/01/09 05:47:00 DEBUG : both17: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e41a_d20220109_m054611_c001_v0001043_t0018")
2022/01/09 05:47:00 DEBUG : both17: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11892c8869775bdf_d20220109_m054529_c001_v0001105_t0037")
2022/01/09 05:47:01 DEBUG : both17: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e345_d20220109_m054510_c001_v0001043_t0023")
2022/01/09 05:47:01 DEBUG : both18: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1061e71a0153b48e_d20220109_m054633_c001_v0001105_t0000")
2022/01/09 05:47:01 DEBUG : both18: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e41e_d20220109_m054612_c001_v0001043_t0027")
2022/01/09 05:47:01 DEBUG : both18: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1061e71a0153ac09_d20220109_m054530_c001_v0001105_t0040")
2022/01/09 05:47:01 DEBUG : both18: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e34c_d20220109_m054512_c001_v0001043_t0004")
2022/01/09 05:47:01 DEBUG : both19: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11118750fb03ba49_d20220109_m054633_c001_v0001165_t0000")
2022/01/09 05:47:01 DEBUG : both19: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e425_d20220109_m054612_c001_v0001043_t0026")
2022/01/09 05:47:01 DEBUG : both19: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f108fd1b81fa10de5_d20220109_m054532_c001_v0001105_t0004")
2022/01/09 05:47:01 DEBUG : both19: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e354_d20220109_m054515_c001_v0001043_t0051")
2022/01/09 05:47:01 DEBUG : both2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f119a34e4caa1643f_d20220109_m054634_c001_v0001105_t0049")
2022/01/09 05:47:01 DEBUG : both2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e3a6_d20220109_m054545_c001_v0001043_t0006")
2022/01/09 05:47:01 DEBUG : both2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11404ec9653dee73_d20220109_m054533_c001_v0001105_t0050")
2022/01/09 05:47:01 DEBUG : both2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e2d7_d20220109_m054442_c001_v0001043_t0011")
2022/01/09 05:47:01 DEBUG : both3: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f109e38700490fd1b_d20220109_m054634_c001_v0001120_t0049")
2022/01/09 05:47:01 DEBUG : both3: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e3ab_d20220109_m054546_c001_v0001043_t0046")
2022/01/09 05:47:01 DEBUG : both3: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f108a7f69c929050a_d20220109_m054534_c001_v0001146_t0030")
2022/01/09 05:47:01 DEBUG : both3: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e2e0_d20220109_m054444_c001_v0001043_t0023")
2022/01/09 05:47:01 DEBUG : both4: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f10750865ae60d489_d20220109_m054635_c001_v0001134_t0028")
2022/01/09 05:47:01 DEBUG : both4: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e3b3_d20220109_m054547_c001_v0001043_t0030")
2022/01/09 05:47:02 DEBUG : both4: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f10924072e6b96bfb_d20220109_m054534_c001_v0001039_t0030")
2022/01/09 05:47:02 DEBUG : both4: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e2e6_d20220109_m054445_c001_v0001043_t0034")
2022/01/09 05:47:02 DEBUG : both5: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f110fbfb90b7f2fa9_d20220109_m054635_c001_v0001165_t0045")
2022/01/09 05:47:02 DEBUG : both5: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e3bb_d20220109_m054549_c001_v0001043_t0040")
2022/01/09 05:47:02 DEBUG : both5: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f106d07b7d8bf6c4a_d20220109_m054539_c001_v0001131_t0057")
2022/01/09 05:47:02 DEBUG : both5: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e2ea_d20220109_m054445_c001_v0001043_t0020")
2022/01/09 05:47:02 DEBUG : both6: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11994fc7df49129f_d20220109_m054636_c001_v0001036_t0032")
2022/01/09 05:47:02 DEBUG : both6: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e3c2_d20220109_m054551_c001_v0001043_t0019")
2022/01/09 05:47:02 DEBUG : both6: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f111c1f855f719e3a_d20220109_m054539_c001_v0001105_t0026")
2022/01/09 05:47:02 DEBUG : both6: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e2f0_d20220109_m054446_c001_v0001043_t0018")
2022/01/09 05:47:02 DEBUG : both7: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f109e783ad639d3ec_d20220109_m054636_c001_v0001037_t0036")
2022/01/09 05:47:02 DEBUG : both7: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e3ca_d20220109_m054552_c001_v0001043_t0048")
2022/01/09 05:47:02 DEBUG : both7: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1166189179cb9577_d20220109_m054540_c001_v0001037_t0058")
2022/01/09 05:47:02 DEBUG : both7: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e2f9_d20220109_m054448_c001_v0001043_t0007")
2022/01/09 05:47:02 DEBUG : both8: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f10033ab0f932eacf_d20220109_m054637_c001_v0001157_t0013")
2022/01/09 05:47:02 DEBUG : both8: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e3d7_d20220109_m054556_c001_v0001043_t0019")
2022/01/09 05:47:02 DEBUG : both8: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f119463e98010d3a3_d20220109_m054541_c001_v0001165_t0011")
2022/01/09 05:47:02 DEBUG : both8: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e301_d20220109_m054449_c001_v0001043_t0016")
2022/01/09 05:47:02 DEBUG : both9: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f117d23ded47f4f16_d20220109_m054637_c001_v0001117_t0032")
2022/01/09 05:47:02 DEBUG : both9: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e3e2_d20220109_m054557_c001_v0001043_t0027")
2022/01/09 05:47:03 DEBUG : both9: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f114ab84754f8ef8f_d20220109_m054541_c001_v0001038_t0009")
2022/01/09 05:47:03 DEBUG : both9: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e306_d20220109_m054450_c001_v0001043_t0007")
2022/01/09 05:47:03 DEBUG : c/non empty space: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1173eac76733d6dd_d20220109_m053905_c001_v0001105_t0059")
2022/01/09 05:47:03 DEBUG : c/non empty space: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed232f_d20220109_m053901_c001_v0001105_t0048")
2022/01/09 05:47:03 DEBUG : c/non empty space: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f112060208c634520_d20220109_m053900_c001_v0001165_t0005")
2022/01/09 05:47:03 DEBUG : c/non empty space: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed229e_d20220109_m053855_c001_v0001105_t0034")
2022/01/09 05:47:03 DEBUG : c/non empty space: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f10999d380b7c5d3a_d20220109_m053810_c001_v0001092_t0009")
2022/01/09 05:47:03 DEBUG : c/non empty space: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed1e06_d20220109_m053805_c001_v0001105_t0047")
2022/01/09 05:47:03 DEBUG : check sum: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11404ec9653dbc4f_d20220109_m053753_c001_v0001105_t0054")
2022/01/09 05:47:03 DEBUG : check sum: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed1ca7_d20220109_m053751_c001_v0001105_t0043")
2022/01/09 05:47:03 DEBUG : dest/3: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1018fc5e19027b8f_d20220109_m054134_c001_v0001008_t0038")
2022/01/09 05:47:03 DEBUG : dest/3: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f108a726b21014af1_d20220109_m054132_c001_v0001144_t0019")
2022/01/09 05:47:03 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1139c78149dd1081_d20220109_m054418_c001_v0001131_t0047")
2022/01/09 05:47:03 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f113acb748eed147d_d20220109_m054414_c001_v0001145_t0052")
2022/01/09 05:47:03 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f10867995d9920bde_d20220109_m054413_c001_v0001117_t0032")
2022/01/09 05:47:03 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f113acb748eed145a_d20220109_m054409_c001_v0001145_t0042")
2022/01/09 05:47:03 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f10748e3f9694050e_d20220109_m054408_c001_v0001109_t0056")
2022/01/09 05:47:03 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e283_d20220109_m054401_c001_v0001043_t0021")
2022/01/09 05:47:03 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f102593e55587b9a0_d20220109_m054357_c001_v0001091_t0029")
2022/01/09 05:47:03 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1158ae4d455055be_d20220109_m054352_c001_v0001036_t0049")
2022/01/09 05:47:04 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f114c1ddfcb82d276_d20220109_m054351_c001_v0001154_t0009")
2022/01/09 05:47:04 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1158ae4d455055a3_d20220109_m054345_c001_v0001036_t0053")
2022/01/09 05:47:04 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1076d8349a01d648_d20220109_m054344_c001_v0001098_t0002")
2022/01/09 05:47:04 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed3cb2_d20220109_m054338_c001_v0001105_t0038")
2022/01/09 05:47:04 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1026c4cce0fb18a7_d20220109_m054330_c001_v0001120_t0027")
2022/01/09 05:47:04 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11845873c150928e_d20220109_m054328_c001_v0001165_t0010")
2022/01/09 05:47:04 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1175c6b3a1ed562f_d20220109_m054327_c001_v0001150_t0052")
2022/01/09 05:47:04 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11845873c1509237_d20220109_m054322_c001_v0001165_t0029")
2022/01/09 05:47:04 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1083ccef48ab8f46_d20220109_m054321_c001_v0001165_t0019")
2022/01/09 05:47:04 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed39ca_d20220109_m054315_c001_v0001105_t0011")
2022/01/09 05:47:04 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f111e1b488fa813ba_d20220109_m054312_c001_v0001113_t0057")
2022/01/09 05:47:04 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f119c990099a13063_d20220109_m054308_c001_v0001044_t0024")
2022/01/09 05:47:04 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1039eba8c30ff7f0_d20220109_m054307_c001_v0001109_t0034")
2022/01/09 05:47:04 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f119c990099a13057_d20220109_m054301_c001_v0001044_t0044")
2022/01/09 05:47:04 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f104be2dc8d0c0926_d20220109_m054300_c001_v0001018_t0017")
2022/01/09 05:47:04 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed36a9_d20220109_m054251_c001_v0001105_t0026")
2022/01/09 05:47:04 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f114ef823dbe6ab18_d20220109_m054249_c001_v0001161_t0004")
2022/01/09 05:47:04 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1166189179cb9196_d20220109_m054246_c001_v0001037_t0004")
2022/01/09 05:47:04 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1126fc7257f4ba64_d20220109_m054245_c001_v0001105_t0030")
2022/01/09 05:47:05 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1166189179cb9188_d20220109_m054241_c001_v0001037_t0038")
2022/01/09 05:47:05 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1169412230e025d5_d20220109_m054240_c001_v0001165_t0035")
2022/01/09 05:47:05 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed34d8_d20220109_m054232_c001_v0001105_t0038")
2022/01/09 05:47:05 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11345db2be368f29_d20220109_m054231_c001_v0001001_t0002")
2022/01/09 05:47:05 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11118750fb03ab0e_d20220109_m054228_c001_v0001165_t0016")
2022/01/09 05:47:05 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11169fa0cfc79382_d20220109_m054226_c001_v0001029_t0037")
2022/01/09 05:47:05 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11118750fb03aab2_d20220109_m054220_c001_v0001165_t0039")
2022/01/09 05:47:05 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f101ac33087596dba_d20220109_m054219_c001_v0001157_t0011")
2022/01/09 05:47:05 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed333e_d20220109_m054213_c001_v0001105_t0017")
2022/01/09 05:47:05 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1118ae82a938a4f6_d20220109_m054211_c001_v0001157_t0014")
2022/01/09 05:47:05 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f118429dda0fe928c_d20220109_m054150_c001_v0001144_t0025")
2022/01/09 05:47:05 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f104dc2250f821b8e_d20220109_m054149_c001_v0001097_t0022")
2022/01/09 05:47:05 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed3106_d20220109_m054144_c001_v0001105_t0024")
2022/01/09 05:47:05 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f109f1eb0726f53dc_d20220109_m054142_c001_v0001144_t0019")
2022/01/09 05:47:05 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f109f1eb0726f53c4_d20220109_m054141_c001_v0001144_t0005")
2022/01/09 05:47:05 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f118950505b636ffd_d20220109_m054124_c001_v0001154_t0021")
2022/01/09 05:47:05 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e177_d20220109_m054112_c001_v0001043_t0047")
2022/01/09 05:47:06 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f100ece48e02777cc_d20220109_m054111_c001_v0001128_t0036")
2022/01/09 05:47:06 DEBUG : dst/one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f100ece48e02777c7_d20220109_m054109_c001_v0001128_t0042")
2022/01/09 05:47:06 DEBUG : dst/one-2019-01-01: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11431f0f168877b1_d20220109_m054419_c001_v0001098_t0043")
2022/01/09 05:47:06 DEBUG : dst/one-2019-01-01: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1063a5687d09b7bd_d20220109_m054413_c001_v0001165_t0011")
2022/01/09 05:47:06 DEBUG : dst/one-2019-01-01: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f119f2f43eca4d9b6_d20220109_m054407_c001_v0001098_t0050")
2022/01/09 05:47:06 DEBUG : dst/one.bak: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11584255d18ac3fb_d20220109_m054358_c001_v0001109_t0009")
2022/01/09 05:47:06 DEBUG : dst/one.bak: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f10210de24d69f7c7_d20220109_m054349_c001_v0001109_t0009")
2022/01/09 05:47:06 DEBUG : dst/one.bak: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f119d719b3e26a1b6_d20220109_m054343_c001_v0001039_t0024")
2022/01/09 05:47:06 DEBUG : dst/one.bak: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f104400939d9e720e_d20220109_m054331_c001_v0001113_t0033")
2022/01/09 05:47:06 DEBUG : dst/one.bak: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f102056a4d21c7563_d20220109_m054327_c001_v0001031_t0021")
2022/01/09 05:47:06 DEBUG : dst/one.bak: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1097c8d0251ad615_d20220109_m054321_c001_v0001022_t0056")
2022/01/09 05:47:06 DEBUG : dst/three: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1153fcd79297e99f_d20220109_m054211_c001_v0001029_t0043")
2022/01/09 05:47:06 DEBUG : dst/three: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f109f1eb0726f5493_d20220109_m054204_c001_v0001144_t0025")
2022/01/09 05:47:06 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1173f4e205a2e643_d20220109_m054419_c001_v0001042_t0035")
2022/01/09 05:47:06 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1134126cb6c355ae_d20220109_m054415_c001_v0001144_t0034")
2022/01/09 05:47:06 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1061e71a0153a0da_d20220109_m054411_c001_v0001105_t0059")
2022/01/09 05:47:06 DEBUG : dst/three.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f107f9728f65e7423_d20220109_m054422_c001_v0001113_t0022")
2022/01/09 05:47:06 DEBUG : dst/three.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f113acb748eed1498_d20220109_m054417_c001_v0001145_t0007")
2022/01/09 05:47:07 DEBUG : dst/three.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1007301b396eb753_d20220109_m054416_c001_v0001109_t0017")
2022/01/09 05:47:07 DEBUG : dst/three.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f113acb748eed1469_d20220109_m054412_c001_v0001145_t0013")
2022/01/09 05:47:07 DEBUG : dst/three.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1041fcbf01a315c2_d20220109_m054411_c001_v0001144_t0043")
2022/01/09 05:47:07 DEBUG : dst/three.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e286_d20220109_m054403_c001_v0001043_t0026")
2022/01/09 05:47:07 DEBUG : dst/three.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1063a5687d09b61b_d20220109_m054359_c001_v0001165_t0051")
2022/01/09 05:47:07 DEBUG : dst/three.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1158ae4d455055d1_d20220109_m054356_c001_v0001036_t0021")
2022/01/09 05:47:07 DEBUG : dst/three.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f109f1eb0726f589a_d20220109_m054354_c001_v0001144_t0034")
2022/01/09 05:47:07 DEBUG : dst/three.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1158ae4d455055b6_d20220109_m054348_c001_v0001036_t0013")
2022/01/09 05:47:07 DEBUG : dst/three.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f119b34d480f7edf1_d20220109_m054347_c001_v0001120_t0029")
2022/01/09 05:47:07 DEBUG : dst/three.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed3cf7_d20220109_m054340_c001_v0001105_t0031")
2022/01/09 05:47:07 DEBUG : dst/three.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1083ccef48ab8fd3_d20220109_m054330_c001_v0001165_t0030")
2022/01/09 05:47:07 DEBUG : dst/three.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e239_d20220109_m054324_c001_v0001043_t0020")
2022/01/09 05:47:07 DEBUG : dst/three.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1017d26647141082_d20220109_m054323_c001_v0001026_t0001")
2022/01/09 05:47:07 DEBUG : dst/three.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed3a18_d20220109_m054318_c001_v0001105_t0012")
2022/01/09 05:47:07 DEBUG : dst/three.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f104e7390df3acaeb_d20220109_m054310_c001_v0001098_t0053")
2022/01/09 05:47:07 DEBUG : dst/three.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e214_d20220109_m054305_c001_v0001043_t0059")
2022/01/09 05:47:07 DEBUG : dst/three.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1197c0d01a5ce964_d20220109_m054304_c001_v0001038_t0003")
2022/01/09 05:47:07 DEBUG : dst/three.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed36e0_d20220109_m054253_c001_v0001105_t0007")
2022/01/09 05:47:07 DEBUG : dst/three.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f100b040917964226_d20220109_m054247_c001_v0001144_t0014")
2022/01/09 05:47:08 DEBUG : dst/three.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e1f4_d20220109_m054244_c001_v0001043_t0028")
2022/01/09 05:47:08 DEBUG : dst/three.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1097a8627f866840_d20220109_m054243_c001_v0001157_t0036")
2022/01/09 05:47:08 DEBUG : dst/three.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed350a_d20220109_m054235_c001_v0001105_t0029")
2022/01/09 05:47:08 DEBUG : dst/three.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11656c86b60f2fa3_d20220109_m054229_c001_v0001128_t0030")
2022/01/09 05:47:08 DEBUG : dst/three.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e1dd_d20220109_m054223_c001_v0001043_t0001")
2022/01/09 05:47:08 DEBUG : dst/three.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f119b34d480f7ec4d_d20220109_m054221_c001_v0001120_t0002")
2022/01/09 05:47:08 DEBUG : dst/three.txt: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed3363_d20220109_m054215_c001_v0001105_t0029")
2022/01/09 05:47:08 DEBUG : dst/three.txt.bak: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1148b4cb5b1bffd6_d20220109_m054359_c001_v0001136_t0045")
2022/01/09 05:47:08 DEBUG : dst/three.txt.bak: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f105d3df9cb86dd0c_d20220109_m054353_c001_v0001117_t0002")
2022/01/09 05:47:08 DEBUG : dst/three.txt.bak: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f10210de24d69f7a0_d20220109_m054346_c001_v0001109_t0040")
2022/01/09 05:47:08 DEBUG : dst/three.txt.bak: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f104da4b21c88e9db_d20220109_m054334_c001_v0001105_t0029")
2022/01/09 05:47:08 DEBUG : dst/three.txt.bak: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1143ce8e61ea7342_d20220109_m054329_c001_v0001144_t0022")
2022/01/09 05:47:08 DEBUG : dst/three.txt.bak: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f113a802a97dfe543_d20220109_m054322_c001_v0001157_t0048")
2022/01/09 05:47:08 DEBUG : dst/two: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f108bed83088f0880_d20220109_m054422_c001_v0001130_t0035")
2022/01/09 05:47:08 DEBUG : dst/two: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed4010_d20220109_m054402_c001_v0001105_t0036")
2022/01/09 05:47:08 DEBUG : dst/two: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11845873c150944f_d20220109_m054400_c001_v0001165_t0030")
2022/01/09 05:47:08 DEBUG : dst/two: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e252_d20220109_m054339_c001_v0001043_t0028")
2022/01/09 05:47:08 DEBUG : dst/two: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1137c17db3005173_d20220109_m054335_c001_v0001109_t0025")
2022/01/09 05:47:08 DEBUG : dst/two: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e229_d20220109_m054317_c001_v0001043_t0042")
2022/01/09 05:47:09 DEBUG : dst/two: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f104e5074f2e7ca53_d20220109_m054313_c001_v0001117_t0017")
2022/01/09 05:47:09 DEBUG : dst/two: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e1fd_d20220109_m054252_c001_v0001043_t0043")
2022/01/09 05:47:09 DEBUG : dst/two: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1137c17db3004fc8_d20220109_m054249_c001_v0001109_t0041")
2022/01/09 05:47:09 DEBUG : dst/two: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e1eb_d20220109_m054234_c001_v0001043_t0058")
2022/01/09 05:47:09 DEBUG : dst/two: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f102813eb516a0797_d20220109_m054231_c001_v0001030_t0017")
2022/01/09 05:47:09 DEBUG : dst/two: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e1d0_d20220109_m054214_c001_v0001043_t0030")
2022/01/09 05:47:09 DEBUG : dst/two: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f101f4d76cc5eeb73_d20220109_m054212_c001_v0001161_t0025")
2022/01/09 05:47:09 DEBUG : dst/two: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f103c3a1c2868e5e7_d20220109_m054157_c001_v0001117_t0056")
2022/01/09 05:47:09 DEBUG : dst/two: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f119b1ccbd3d7aebd_d20220109_m054124_c001_v0001109_t0029")
2022/01/09 05:47:09 DEBUG : dst/two: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f100ece48e02777eb_d20220109_m054120_c001_v0001128_t0049")
2022/01/09 05:47:09 DEBUG : empty space: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f119b1ccbd3d7ae2a_d20220109_m054053_c001_v0001109_t0051")
2022/01/09 05:47:09 DEBUG : empty space: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed2c8f_d20220109_m054049_c001_v0001105_t0058")
2022/01/09 05:47:09 DEBUG : empty space: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11404ec9653dcbec_d20220109_m054045_c001_v0001105_t0020")
2022/01/09 05:47:09 DEBUG : empty space: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e157_d20220109_m054031_c001_v0001043_t0003")
2022/01/09 05:47:09 DEBUG : empty space: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f10146917c3f23fe9_d20220109_m054020_c001_v0001109_t0050")
2022/01/09 05:47:09 DEBUG : empty space: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed29d0_d20220109_m054016_c001_v0001105_t0049")
2022/01/09 05:47:10 DEBUG : empty space: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f108a35199e3c4cab_d20220109_m053928_c001_v0001145_t0023")
2022/01/09 05:47:10 DEBUG : empty space: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed2571_d20220109_m053925_c001_v0001105_t0013")
2022/01/09 05:47:10 DEBUG : empty space: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11324ceb57a7b038_d20220109_m053923_c001_v0001105_t0058")
2022/01/09 05:47:10 DEBUG : empty space: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed24fd_d20220109_m053921_c001_v0001105_t0014")
2022/01/09 05:47:10 DEBUG : empty space: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f115104ff947fd51f_d20220109_m053914_c001_v0001039_t0039")
2022/01/09 05:47:10 DEBUG : empty space: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed2407_d20220109_m053911_c001_v0001105_t0005")
2022/01/09 05:47:10 DEBUG : empty space: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f111c1f855f716f7f_d20220109_m053909_c001_v0001105_t0026")
2022/01/09 05:47:10 DEBUG : empty space: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed239f_d20220109_m053906_c001_v0001105_t0038")
2022/01/09 05:47:10 DEBUG : empty space: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f113bd8aa7e3d7ce5_d20220109_m053852_c001_v0001098_t0057")
2022/01/09 05:47:10 DEBUG : empty space: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed2201_d20220109_m053848_c001_v0001105_t0059")
2022/01/09 05:47:10 DEBUG : empty space: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1104fcab35355558_d20220109_m053846_c001_v0001097_t0039")
2022/01/09 05:47:10 DEBUG : empty space: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed21a5_d20220109_m053845_c001_v0001105_t0021")
2022/01/09 05:47:10 DEBUG : empty space: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1052f65e84ca99fc_d20220109_m053827_c001_v0001105_t0054")
2022/01/09 05:47:10 DEBUG : empty space: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed1fde_d20220109_m053824_c001_v0001105_t0045")
2022/01/09 05:47:10 DEBUG : empty space: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1079c3142434fc04_d20220109_m053818_c001_v0001041_t0054")
2022/01/09 05:47:10 DEBUG : empty space: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed1f0f_d20220109_m053816_c001_v0001105_t0024")
2022/01/09 05:47:10 DEBUG : empty space: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1113a5b1f606b628_d20220109_m053815_c001_v0001144_t0018")
2022/01/09 05:47:11 DEBUG : empty space: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1126e7eaa4d9caec_d20220109_m053814_c001_v0001040_t0022")
2022/01/09 05:47:11 DEBUG : empty space: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed1e72_d20220109_m053810_c001_v0001105_t0021")
2022/01/09 05:47:11 DEBUG : enormous: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f102c0d0f2259ecb6_d20220109_m053927_c001_v0001117_t0012")
2022/01/09 05:47:11 DEBUG : enormous: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed257b_d20220109_m053926_c001_v0001105_t0021")
2022/01/09 05:47:11 DEBUG : existing: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1035529052e6d4d6_d20220109_m054432_c001_v0001165_t0058")
2022/01/09 05:47:11 DEBUG : existing: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e2b2_d20220109_m054430_c001_v0001043_t0001")
2022/01/09 05:47:11 DEBUG : existing: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1047ef235b0f9095_d20220109_m054014_c001_v0001165_t0011")
2022/01/09 05:47:11 DEBUG : existing: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e140_d20220109_m054010_c001_v0001043_t0027")
2022/01/09 05:47:11 DEBUG : existing: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f115129af22b5304c_d20220109_m053804_c001_v0001165_t0029")
2022/01/09 05:47:11 DEBUG : existing: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed1dc2_d20220109_m053802_c001_v0001105_t0034")
2022/01/09 05:47:11 DEBUG : existing: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f118429dda0fe8da4_d20220109_m053801_c001_v0001144_t0004")
2022/01/09 05:47:11 DEBUG : existing: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed1d9a_d20220109_m053800_c001_v0001105_t0021")
2022/01/09 05:47:11 DEBUG : existing: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed1d8e_d20220109_m053759_c001_v0001105_t0022")
2022/01/09 05:47:11 DEBUG : existing-b: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1089a54c17603d10_d20220109_m054014_c001_v0001150_t0029")
2022/01/09 05:47:11 DEBUG : existing-b: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed2976_d20220109_m054012_c001_v0001105_t0045")
2022/01/09 05:47:11 DEBUG : five: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1052f65e84caa0e9_d20220109_m053935_c001_v0001105_t0012")
2022/01/09 05:47:11 DEBUG : five: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed2625_d20220109_m053932_c001_v0001105_t0031")
2022/01/09 05:47:11 DEBUG : foo: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f117b4a66f8f7b4fe_d20220109_m053822_c001_v0001131_t0052")
2022/01/09 05:47:11 DEBUG : foo: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed1f88_d20220109_m053821_c001_v0001105_t0029")
2022/01/09 05:47:11 DEBUG : foo: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed1f77_d20220109_m053820_c001_v0001105_t0006")
2022/01/09 05:47:12 DEBUG : four: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1045584eba9ed1de_d20220109_m053937_c001_v0001145_t0026")
2022/01/09 05:47:12 DEBUG : four: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e121_d20220109_m053933_c001_v0001043_t0008")
2022/01/09 05:47:12 DEBUG : four: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed260f_d20220109_m053932_c001_v0001105_t0024")
2022/01/09 05:47:12 DEBUG : hello world2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f106a49ea4376e448_d20220109_m053724_c001_v0001144_t0056")
2022/01/09 05:47:12 DEBUG : hello world2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed19cf_d20220109_m053722_c001_v0001105_t0038")
2022/01/09 05:47:12 DEBUG : ignore-size: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f101aa57aceca7c4c_d20220109_m053758_c001_v0001105_t0040")
2022/01/09 05:47:12 DEBUG : ignore-size: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed1d4a_d20220109_m053757_c001_v0001105_t0019")
2022/01/09 05:47:12 DEBUG : nested/sub dir/file: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed2943_d20220109_m054008_c001_v0001105_t0033")
2022/01/09 05:47:12 DEBUG : nested/sub dir/file: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e13a_d20220109_m054005_c001_v0001043_t0026")
2022/01/09 05:47:12 DEBUG : nested/sub dir/file: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1127e85c3d45545a_d20220109_m054002_c001_v0001044_t0025")
2022/01/09 05:47:12 DEBUG : nested/sub dir/file: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed28a7_d20220109_m053959_c001_v0001105_t0009")
2022/01/09 05:47:12 DEBUG : one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f10398a40241c3f92_d20220109_m053938_c001_v0001105_t0006")
2022/01/09 05:47:12 DEBUG : one: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed25da_d20220109_m053929_c001_v0001105_t0007")
2022/01/09 05:47:12 DEBUG : only0: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f102f3483d2d5c857_d20220109_m054638_c001_v0001113_t0049")
2022/01/09 05:47:12 DEBUG : only0: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e42d_d20220109_m054615_c001_v0001043_t0040")
2022/01/09 05:47:13 DEBUG : only0: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e39a_d20220109_m054543_c001_v0001043_t0059")
2022/01/09 05:47:13 DEBUG : only0: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f116d4b89009518c5_d20220109_m054518_c001_v0001105_t0014")
2022/01/09 05:47:13 DEBUG : only0: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e2cc_d20220109_m054440_c001_v0001043_t0039")
2022/01/09 05:47:13 DEBUG : only1: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f115df0265ca7e4c8_d20220109_m054639_c001_v0001137_t0039")
2022/01/09 05:47:13 DEBUG : only1: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1040bbbd73dbe7c8_d20220109_m054615_c001_v0001120_t0005")
2022/01/09 05:47:13 DEBUG : only1: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e3a4_d20220109_m054545_c001_v0001043_t0005")
2022/01/09 05:47:13 DEBUG : only1: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11324ceb57a7d62a_d20220109_m054519_c001_v0001105_t0030")
2022/01/09 05:47:13 DEBUG : only1: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e2d3_d20220109_m054442_c001_v0001043_t0024")
2022/01/09 05:47:13 DEBUG : only10: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11697179ad9b4e88_d20220109_m054640_c001_v0001137_t0054")
2022/01/09 05:47:13 DEBUG : only10: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f10398ebc251e2dc9_d20220109_m054615_c001_v0001097_t0028")
2022/01/09 05:47:13 DEBUG : only10: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e3e9_d20220109_m054558_c001_v0001043_t0001")
2022/01/09 05:47:13 DEBUG : only10: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f100b040917964743_d20220109_m054518_c001_v0001144_t0032")
2022/01/09 05:47:13 DEBUG : only10: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e313_d20220109_m054453_c001_v0001043_t0040")
2022/01/09 05:47:13 DEBUG : only11: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f108fd1b81fa117ae_d20220109_m054641_c001_v0001105_t0050")
2022/01/09 05:47:13 DEBUG : only11: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1100a579a9c41832_d20220109_m054616_c001_v0001105_t0010")
2022/01/09 05:47:13 DEBUG : only11: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e3f0_d20220109_m054601_c001_v0001043_t0046")
2022/01/09 05:47:13 DEBUG : only11: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f101aa57acecaab61_d20220109_m054517_c001_v0001105_t0042")
2022/01/09 05:47:13 DEBUG : only11: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e31d_d20220109_m054456_c001_v0001043_t0039")
2022/01/09 05:47:13 DEBUG : only12: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11169fa0cfc794f7_d20220109_m054642_c001_v0001029_t0031")
2022/01/09 05:47:13 DEBUG : only12: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e432_d20220109_m054615_c001_v0001043_t0026")
2022/01/09 05:47:14 DEBUG : only12: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e3fa_d20220109_m054602_c001_v0001043_t0047")
2022/01/09 05:47:14 DEBUG : only12: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1110b319bb1c8d16_d20220109_m054519_c001_v0001161_t0004")
2022/01/09 05:47:14 DEBUG : only12: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e327_d20220109_m054457_c001_v0001043_t0016")
2022/01/09 05:47:14 DEBUG : only13: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f112e66993a236c9e_d20220109_m054643_c001_v0001037_t0045")
2022/01/09 05:47:14 DEBUG : only13: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e434_d20220109_m054616_c001_v0001043_t0051")
2022/01/09 05:47:14 DEBUG : only13: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e3ff_d20220109_m054604_c001_v0001043_t0016")
2022/01/09 05:47:14 DEBUG : only13: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f10975851e3a3038a_d20220109_m054520_c001_v0001098_t0001")
2022/01/09 05:47:14 DEBUG : only13: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e32e_d20220109_m054459_c001_v0001043_t0053")
2022/01/09 05:47:14 DEBUG : only14: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11892c8869776763_d20220109_m054644_c001_v0001105_t0055")
2022/01/09 05:47:14 DEBUG : only14: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f10398ebc251e2dd1_d20220109_m054616_c001_v0001097_t0002")
2022/01/09 05:47:14 DEBUG : only14: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e406_d20220109_m054605_c001_v0001043_t0051")
2022/01/09 05:47:14 DEBUG : only14: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f106bb871ba8702d1_d20220109_m054520_c001_v0001157_t0044")
2022/01/09 05:47:14 DEBUG : only14: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e333_d20220109_m054502_c001_v0001043_t0037")
2022/01/09 05:47:14 DEBUG : only15: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1151c71e1a8bb874_d20220109_m054646_c001_v0001144_t0039")
2022/01/09 05:47:14 DEBUG : only15: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1040bbbd73dbe7d4_d20220109_m054616_c001_v0001120_t0017")
2022/01/09 05:47:14 DEBUG : only15: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e40c_d20220109_m054608_c001_v0001043_t0031")
2022/01/09 05:47:15 DEBUG : only15: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f111f37600a67a55e_d20220109_m054522_c001_v0001039_t0009")
2022/01/09 05:47:15 DEBUG : only15: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e339_d20220109_m054506_c001_v0001043_t0056")
2022/01/09 05:47:15 DEBUG : only16: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11248307a97b51eb_d20220109_m054646_c001_v0001097_t0037")
2022/01/09 05:47:15 DEBUG : only16: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e437_d20220109_m054616_c001_v0001043_t0003")
2022/01/09 05:47:15 DEBUG : only16: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e412_d20220109_m054610_c001_v0001043_t0051")
2022/01/09 05:47:15 DEBUG : only16: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f104e5dcd3093d286_d20220109_m054519_c001_v0001150_t0024")
2022/01/09 05:47:15 DEBUG : only16: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e340_d20220109_m054509_c001_v0001043_t0031")
2022/01/09 05:47:15 DEBUG : only17: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f101c62c3cae4bb79_d20220109_m054647_c001_v0001165_t0026")
2022/01/09 05:47:15 DEBUG : only17: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1100a579a9c41852_d20220109_m054617_c001_v0001105_t0026")
2022/01/09 05:47:15 DEBUG : only17: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e41c_d20220109_m054611_c001_v0001043_t0034")
2022/01/09 05:47:15 DEBUG : only17: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1176d1ee6a1cbd1b_d20220109_m054521_c001_v0001120_t0059")
2022/01/09 05:47:15 DEBUG : only17: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e348_d20220109_m054510_c001_v0001043_t0050")
2022/01/09 05:47:15 DEBUG : only18: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1061e71a0153b6b6_d20220109_m054647_c001_v0001105_t0008")
2022/01/09 05:47:15 DEBUG : only18: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1040bbbd73dbe7dc_d20220109_m054617_c001_v0001120_t0059")
2022/01/09 05:47:15 DEBUG : only18: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e422_d20220109_m054612_c001_v0001043_t0020")
2022/01/09 05:47:15 DEBUG : only18: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f101f4d76cc5ef1fa_d20220109_m054519_c001_v0001161_t0058")
2022/01/09 05:47:15 DEBUG : only18: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e351_d20220109_m054514_c001_v0001043_t0017")
2022/01/09 05:47:15 DEBUG : only19: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11344afe85c23cdb_d20220109_m054648_c001_v0001165_t0056")
2022/01/09 05:47:16 DEBUG : only19: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e439_d20220109_m054617_c001_v0001043_t0038")
2022/01/09 05:47:16 DEBUG : only19: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e428_d20220109_m054613_c001_v0001043_t0050")
2022/01/09 05:47:16 DEBUG : only19: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1013cde3c8741a82_d20220109_m054521_c001_v0001117_t0026")
2022/01/09 05:47:16 DEBUG : only19: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e357_d20220109_m054516_c001_v0001043_t0051")
2022/01/09 05:47:16 DEBUG : only2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f106c802af8a904ef_d20220109_m054648_c001_v0001109_t0025")
2022/01/09 05:47:16 DEBUG : only2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1100a579a9c41881_d20220109_m054617_c001_v0001105_t0054")
2022/01/09 05:47:16 DEBUG : only2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e3a9_d20220109_m054546_c001_v0001043_t0039")
2022/01/09 05:47:16 DEBUG : only2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1068945c9406adb4_d20220109_m054518_c001_v0001120_t0036")
2022/01/09 05:47:16 DEBUG : only2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e2dc_d20220109_m054443_c001_v0001043_t0009")
2022/01/09 05:47:16 DEBUG : only3: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f104c1f7326b96614_d20220109_m054648_c001_v0001157_t0003")
2022/01/09 05:47:16 DEBUG : only3: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f10398ebc251e2dec_d20220109_m054618_c001_v0001097_t0011")
2022/01/09 05:47:16 DEBUG : only3: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e3ad_d20220109_m054547_c001_v0001043_t0027")
2022/01/09 05:47:16 DEBUG : only3: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11105ca0f766111e_d20220109_m054521_c001_v0001036_t0037")
2022/01/09 05:47:16 DEBUG : only3: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e2e4_d20220109_m054444_c001_v0001043_t0016")
2022/01/09 05:47:16 DEBUG : only4: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f103a9c332a50b96e_d20220109_m054649_c001_v0001098_t0045")
2022/01/09 05:47:16 DEBUG : only4: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1100a579a9c41895_d20220109_m054618_c001_v0001105_t0015")
2022/01/09 05:47:16 DEBUG : only4: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e3b6_d20220109_m054548_c001_v0001043_t0001")
2022/01/09 05:47:16 DEBUG : only4: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f106c802af8a90191_d20220109_m054519_c001_v0001109_t0029")
2022/01/09 05:47:16 DEBUG : only4: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e2e8_d20220109_m054445_c001_v0001043_t0057")
2022/01/09 05:47:17 DEBUG : only5: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11404ec9653df9f5_d20220109_m054650_c001_v0001105_t0007")
2022/01/09 05:47:17 DEBUG : only5: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f10398ebc251e2dfc_d20220109_m054619_c001_v0001097_t0058")
2022/01/09 05:47:17 DEBUG : only5: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e3bd_d20220109_m054550_c001_v0001043_t0044")
2022/01/09 05:47:17 DEBUG : only5: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11938a53e8d2bd49_d20220109_m054519_c001_v0001144_t0016")
2022/01/09 05:47:17 DEBUG : only5: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e2ee_d20220109_m054446_c001_v0001043_t0037")
2022/01/09 05:47:17 DEBUG : only6: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f117726ae371485fb_d20220109_m054653_c001_v0001044_t0043")
2022/01/09 05:47:17 DEBUG : only6: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1100a579a9c418c9_d20220109_m054619_c001_v0001105_t0015")
2022/01/09 05:47:17 DEBUG : only6: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e3c5_d20220109_m054551_c001_v0001043_t0034")
2022/01/09 05:47:17 DEBUG : only6: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11831f10c5132f20_d20220109_m054518_c001_v0001157_t0034")
2022/01/09 05:47:17 DEBUG : only6: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e2f3_d20220109_m054447_c001_v0001043_t0027")
2022/01/09 05:47:17 DEBUG : only7: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f111c1f855f71a94d_d20220109_m054654_c001_v0001105_t0054")
2022/01/09 05:47:17 DEBUG : only7: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1040bbbd73dbe7f1_d20220109_m054619_c001_v0001120_t0012")
2022/01/09 05:47:17 DEBUG : only7: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e3d0_d20220109_m054554_c001_v0001043_t0057")
2022/01/09 05:47:17 DEBUG : only7: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1084d341376a94da_d20220109_m054520_c001_v0001042_t0000")
2022/01/09 05:47:17 DEBUG : only7: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e2fe_d20220109_m054449_c001_v0001043_t0036")
2022/01/09 05:47:17 DEBUG : only8: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f115129af22b55bd8_d20220109_m054654_c001_v0001165_t0024")
2022/01/09 05:47:18 DEBUG : only8: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e43e_d20220109_m054620_c001_v0001043_t0052")
2022/01/09 05:47:18 DEBUG : only8: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e3dc_d20220109_m054556_c001_v0001043_t0014")
2022/01/09 05:47:18 DEBUG : only8: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f110c2e946cbe1e4a_d20220109_m054518_c001_v0001117_t0027")
2022/01/09 05:47:18 DEBUG : only8: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e304_d20220109_m054449_c001_v0001043_t0008")
2022/01/09 05:47:18 DEBUG : only9: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f110850e1fccda3e0_d20220109_m054655_c001_v0001136_t0049")
2022/01/09 05:47:18 DEBUG : only9: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f10398ebc251e2e0d_d20220109_m054620_c001_v0001097_t0032")
2022/01/09 05:47:18 DEBUG : only9: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e3e4_d20220109_m054558_c001_v0001043_t0030")
2022/01/09 05:47:18 DEBUG : only9: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f107636234985a486_d20220109_m054520_c001_v0001017_t0027")
2022/01/09 05:47:18 DEBUG : only9: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e308_d20220109_m054451_c001_v0001043_t0028")
2022/01/09 05:47:18 DEBUG : potato: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f102c0d0f2259ede1_d20220109_m053956_c001_v0001117_t0042")
2022/01/09 05:47:18 DEBUG : potato: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e134_d20220109_m053953_c001_v0001043_t0035")
2022/01/09 05:47:18 DEBUG : potato: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1176d1ee6a1cb557_d20220109_m053951_c001_v0001120_t0050")
2022/01/09 05:47:18 DEBUG : potato: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e130_d20220109_m053948_c001_v0001043_t0003")
2022/01/09 05:47:18 DEBUG : potato: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11892c886977339e_d20220109_m053945_c001_v0001105_t0053")
2022/01/09 05:47:18 DEBUG : potato: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed2724_d20220109_m053942_c001_v0001105_t0003")
2022/01/09 05:47:18 DEBUG : potato: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1055e19e4b607b65_d20220109_m053917_c001_v0001098_t0027")
2022/01/09 05:47:19 DEBUG : potato: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed2459_d20220109_m053915_c001_v0001105_t0051")
2022/01/09 05:47:19 DEBUG : potato: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f108674e8ebde67b8_d20220109_m053912_c001_v0001098_t0052")
2022/01/09 05:47:19 DEBUG : potato: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed23ff_d20220109_m053910_c001_v0001105_t0005")
2022/01/09 05:47:19 DEBUG : potato: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f108a7f69c928fd7b_d20220109_m053908_c001_v0001146_t0050")
2022/01/09 05:47:19 DEBUG : potato: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed2388_d20220109_m053906_c001_v0001105_t0022")
2022/01/09 05:47:19 DEBUG : potato: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed2236_d20220109_m053851_c001_v0001105_t0057")
2022/01/09 05:47:19 DEBUG : potato: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed21e4_d20220109_m053848_c001_v0001105_t0039")
2022/01/09 05:47:19 DEBUG : potato: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1158453bbebea844_d20220109_m053847_c001_v0001009_t0033")
2022/01/09 05:47:19 DEBUG : potato: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed2178_d20220109_m053843_c001_v0001105_t0040")
2022/01/09 05:47:19 DEBUG : potato: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1008eef61a782fe2_d20220109_m053840_c001_v0001113_t0050")
2022/01/09 05:47:19 DEBUG : potato: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed2105_d20220109_m053839_c001_v0001105_t0001")
2022/01/09 05:47:19 DEBUG : potato: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed20f0_d20220109_m053838_c001_v0001105_t0013")
2022/01/09 05:47:19 DEBUG : potato: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f106c802af8a8f5e7_d20220109_m053837_c001_v0001109_t0036")
2022/01/09 05:47:19 DEBUG : potato: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed20c5_d20220109_m053836_c001_v0001105_t0028")
2022/01/09 05:47:19 DEBUG : potato: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed2061_d20220109_m053832_c001_v0001105_t0045")
2022/01/09 05:47:19 DEBUG : potato: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11324ceb57a7ab0b_d20220109_m053828_c001_v0001105_t0027")
2022/01/09 05:47:20 DEBUG : potato: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed1ffe_d20220109_m053826_c001_v0001105_t0056")
2022/01/09 05:47:20 DEBUG : potato2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11504ef7a4f5521a_d20220109_m054105_c001_v0001044_t0023")
2022/01/09 05:47:20 DEBUG : potato2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed2d89_d20220109_m054103_c001_v0001105_t0009")
2022/01/09 05:47:20 DEBUG : potato2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f108fd1b81fa0ee2c_d20220109_m054054_c001_v0001105_t0027")
2022/01/09 05:47:20 DEBUG : potato2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e160_d20220109_m054048_c001_v0001043_t0025")
2022/01/09 05:47:20 DEBUG : potato2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f101c62c3cae4a41a_d20220109_m054039_c001_v0001165_t0057")
2022/01/09 05:47:20 DEBUG : potato2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed2ade_d20220109_m054029_c001_v0001105_t0053")
2022/01/09 05:47:20 DEBUG : potato2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f109cb07d12e966e0_d20220109_m054020_c001_v0001032_t0059")
2022/01/09 05:47:20 DEBUG : potato2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e147_d20220109_m054015_c001_v0001043_t0029")
2022/01/09 05:47:20 DEBUG : potato2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1151fe7c9c4d67b5_d20220109_m053927_c001_v0001117_t0048")
2022/01/09 05:47:20 DEBUG : potato2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed2532_d20220109_m053924_c001_v0001105_t0049")
2022/01/09 05:47:20 DEBUG : potato2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11404ec9653dc503_d20220109_m053923_c001_v0001105_t0052")
2022/01/09 05:47:20 DEBUG : potato2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed24eb_d20220109_m053921_c001_v0001105_t0050")
2022/01/09 05:47:20 DEBUG : potato2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f100bba7e7949d8e3_d20220109_m053919_c001_v0001117_t0056")
2022/01/09 05:47:20 DEBUG : potato2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed246b_d20220109_m053916_c001_v0001105_t0050")
2022/01/09 05:47:20 DEBUG : potato2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f101aa57aceca835c_d20220109_m053915_c001_v0001105_t0008")
2022/01/09 05:47:20 DEBUG : potato2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed2420_d20220109_m053913_c001_v0001105_t0055")
2022/01/09 05:47:20 DEBUG : potato2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1047ef235b0f8e7b_d20220109_m053910_c001_v0001165_t0026")
2022/01/09 05:47:20 DEBUG : potato2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed23c5_d20220109_m053908_c001_v0001105_t0047")
2022/01/09 05:47:20 DEBUG : potato2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1094d0886d6b5915_d20220109_m053853_c001_v0001117_t0002")
2022/01/09 05:47:21 DEBUG : potato2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed2221_d20220109_m053850_c001_v0001105_t0035")
2022/01/09 05:47:21 DEBUG : potato2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f105bf56e96ef495d_d20220109_m053729_c001_v0001165_t0040")
2022/01/09 05:47:21 DEBUG : potato2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed1a53_d20220109_m053728_c001_v0001105_t0020")
2022/01/09 05:47:21 DEBUG : potato2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1078648c07cbb29d_d20220109_m053726_c001_v0001097_t0010")
2022/01/09 05:47:21 DEBUG : potato2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed1a15_d20220109_m053725_c001_v0001105_t0058")
2022/01/09 05:47:21 DEBUG : potato3: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1041fcbf01a30f88_d20220109_m054054_c001_v0001144_t0059")
2022/01/09 05:47:21 DEBUG : potato3: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e162_d20220109_m054050_c001_v0001043_t0053")
2022/01/09 05:47:21 DEBUG : potato3: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1137c17db3004d3e_d20220109_m054039_c001_v0001109_t0021")
2022/01/09 05:47:21 DEBUG : potato3: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed2b34_d20220109_m054033_c001_v0001105_t0030")
2022/01/09 05:47:21 DEBUG : potato3: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f104da4b21c88d8ef_d20220109_m054021_c001_v0001105_t0038")
2022/01/09 05:47:21 DEBUG : potato3: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e14a_d20220109_m054017_c001_v0001043_t0046")
2022/01/09 05:47:21 DEBUG : pre-dest1/1: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11343be70d789ff7_d20220109_m054134_c001_v0001039_t0004")
2022/01/09 05:47:21 DEBUG : pre-dest1/1: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed2f8d_d20220109_m054126_c001_v0001105_t0050")
2022/01/09 05:47:21 DEBUG : pre-dest2/2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f116b1f07075916ce_d20220109_m054137_c001_v0001097_t0009")
2022/01/09 05:47:21 DEBUG : pre-dest2/2: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e18b_d20220109_m054127_c001_v0001043_t0007")
2022/01/09 05:47:21 DEBUG : sizeonly: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f104c022888c65bdd_d20220109_m053756_c001_v0001131_t0019")
2022/01/09 05:47:22 DEBUG : sizeonly: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed1d17_d20220109_m053755_c001_v0001105_t0044")
2022/01/09 05:47:22 DEBUG : sub dir/hello world: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f10061adbdbbdf66e_d20220109_m054009_c001_v0001105_t0056")
2022/01/09 05:47:22 DEBUG : sub dir/hello world: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed2904_d20220109_m054005_c001_v0001105_t0038")
2022/01/09 05:47:22 DEBUG : sub dir/hello world: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f103a9c332a50ac66_d20220109_m054004_c001_v0001098_t0033")
2022/01/09 05:47:22 DEBUG : sub dir/hello world: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e136_d20220109_m053959_c001_v0001043_t0029")
2022/01/09 05:47:22 DEBUG : sub dir/hello world: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1139edc3bee29f53_d20220109_m053750_c001_v0001130_t0041")
2022/01/09 05:47:22 DEBUG : sub dir/hello world: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed1c59_d20220109_m053748_c001_v0001105_t0015")
2022/01/09 05:47:22 DEBUG : sub dir/hello world: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f104e74e31a3dc5f2_d20220109_m053747_c001_v0001109_t0048")
2022/01/09 05:47:22 DEBUG : sub dir/hello world: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed1c1d_d20220109_m053745_c001_v0001105_t0012")
2022/01/09 05:47:22 DEBUG : sub dir/hello world: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1126fc7257f4a053_d20220109_m053744_c001_v0001105_t0046")
2022/01/09 05:47:22 DEBUG : sub dir/hello world: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed1b27_d20220109_m053737_c001_v0001105_t0053")
2022/01/09 05:47:22 DEBUG : sub dir/hello world: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f111402c0ceb3075c_d20220109_m053736_c001_v0001131_t0038")
2022/01/09 05:47:23 DEBUG : sub dir/hello world: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed1b06_d20220109_m053735_c001_v0001105_t0053")
2022/01/09 05:47:23 DEBUG : sub dir/hello world: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f10436720750b02d4_d20220109_m053733_c001_v0001040_t0016")
2022/01/09 05:47:23 DEBUG : sub dir/hello world: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed1ace_d20220109_m053732_c001_v0001105_t0041")
2022/01/09 05:47:23 DEBUG : sub dir/hello world: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1151fe7c9c4d6389_d20220109_m053731_c001_v0001117_t0041")
2022/01/09 05:47:23 DEBUG : sub dir/hello world: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed1a92_d20220109_m053730_c001_v0001105_t0031")
2022/01/09 05:47:23 DEBUG : sub dir/hello world: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f105f4a5660c67c53_d20220109_m053721_c001_v0001109_t0055")
2022/01/09 05:47:23 DEBUG : sub dir/hello world: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed1999_d20220109_m053720_c001_v0001105_t0013")
2022/01/09 05:47:23 DEBUG : sub dir/hello world: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11118750fb039f0d_d20220109_m053719_c001_v0001165_t0033")
2022/01/09 05:47:23 DEBUG : sub dir/hello world: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed197c_d20220109_m053718_c001_v0001105_t0026")
2022/01/09 05:47:23 DEBUG : sub dir/hello world: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f111c1f855f7163e8_d20220109_m053717_c001_v0001105_t0034")
2022/01/09 05:47:23 DEBUG : sub dir/hello world: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed194e_d20220109_m053716_c001_v0001105_t0010")
2022/01/09 05:47:23 DEBUG : sub dir/hello world: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1100d629fad4fd1c_d20220109_m053714_c001_v0001098_t0038")
2022/01/09 05:47:23 DEBUG : sub dir/hello world: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed1914_d20220109_m053713_c001_v0001105_t0049")
2022/01/09 05:47:23 DEBUG : sub/yam: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f109166ca1e12ac9f_d20220109_m053955_c001_v0001105_t0015")
2022/01/09 05:47:23 DEBUG : sub/yam: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed2813_d20220109_m053953_c001_v0001105_t0017")
2022/01/09 05:47:23 DEBUG : three: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f101506c5434652b2_d20220109_m053938_c001_v0001098_t0043")
2022/01/09 05:47:24 DEBUG : three: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1115a00857d6e123_d20220109_m053934_c001_v0001043_t0041")
2022/01/09 05:47:24 DEBUG : three: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed25f3_d20220109_m053930_c001_v0001105_t0030")
2022/01/09 05:47:24 DEBUG : two: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11584255d18abdbd_d20220109_m053939_c001_v0001109_t0031")
2022/01/09 05:47:24 DEBUG : two: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11820a6e375e66e2_d20220109_m053933_c001_v0001033_t0036")
2022/01/09 05:47:24 DEBUG : two: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed25e6_d20220109_m053930_c001_v0001105_t0022")
2022/01/09 05:47:24 DEBUG : yam: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11943c2391491493_d20220109_m053958_c001_v0001015_t0024")
2022/01/09 05:47:24 DEBUG : yam: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f103191feb14b5802_d20220109_m053954_c001_v0001161_t0022")
2022/01/09 05:47:24 DEBUG : yam: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f114ba4b6d457c93f_d20220109_m053950_c001_v0001131_t0023")
2022/01/09 05:47:24 DEBUG : yam: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1023c2556aed27b6_d20220109_m053947_c001_v0001105_t0049")
2022/01/09 05:47:24 DEBUG : yam: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f100bba7e7949d9f9_d20220109_m053944_c001_v0001117_t0056")
2022/01/09 05:47:24 DEBUG : yam: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11820a6e375e66ef_d20220109_m053942_c001_v0001033_t0058")
2022/01/09 05:47:24 DEBUG : yaml: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f1142972158ad77f4_d20220109_m053952_c001_v0001019_t0009")
2022/01/09 05:47:24 DEBUG : yaml: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11344afe85c22a75_d20220109_m053950_c001_v0001165_t0039")
2022/01/09 05:47:24 DEBUG : yaml: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f104da4b21c88d66a_d20220109_m053946_c001_v0001105_t0047")
2022/01/09 05:47:24 DEBUG : yaml: Deleting (id "4_zbf923d13507d3bdb7fe80e1b_f11092b2ccc6636d1_d20220109_m053944_c001_v0001043_t0017")
"./sync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Finished OK in 10m15.959579596s (try 1/5)