"./sync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -fast-list" - Starting (try 1/5) 2021/12/13 05:55:51 DEBUG : Creating backend with remote "TestB2:rclone-test-yopedoj9vafihuc7rokesod7" 2021/12/13 05:55:51 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2021/12/13 05:55:51 DEBUG : Creating backend with remote "/tmp/rclone940314831" === RUN TestPipe --- PASS: TestPipe (0.00s) === RUN TestPipeConcurrent --- PASS: TestPipeConcurrent (0.03s) === RUN TestPipeOrderBy === RUN TestPipeOrderBy/#00 === RUN TestPipeOrderBy/size === RUN TestPipeOrderBy/name === RUN TestPipeOrderBy/modtime === RUN TestPipeOrderBy/size,ascending === RUN TestPipeOrderBy/name,asc === RUN TestPipeOrderBy/modtime,ascending === RUN TestPipeOrderBy/size,descending === RUN TestPipeOrderBy/name,desc === RUN TestPipeOrderBy/modtime,descending === RUN TestPipeOrderBy/size,mixed,50 === RUN TestPipeOrderBy/size,mixed,51 --- PASS: TestPipeOrderBy (0.00s) --- PASS: TestPipeOrderBy/#00 (0.00s) --- PASS: TestPipeOrderBy/size (0.00s) --- PASS: TestPipeOrderBy/name (0.00s) --- PASS: TestPipeOrderBy/modtime (0.00s) --- PASS: TestPipeOrderBy/size,ascending (0.00s) --- PASS: TestPipeOrderBy/name,asc (0.00s) --- PASS: TestPipeOrderBy/modtime,ascending (0.00s) --- PASS: TestPipeOrderBy/size,descending (0.00s) --- PASS: TestPipeOrderBy/name,desc (0.00s) --- PASS: TestPipeOrderBy/modtime,descending (0.00s) --- PASS: TestPipeOrderBy/size,mixed,50 (0.00s) --- PASS: TestPipeOrderBy/size,mixed,51 (0.00s) === RUN TestNewLess === RUN TestNewLess/blankOK === RUN TestNewLess/tooManyParts === RUN TestNewLess/tooManyParts2 === RUN TestNewLess/badMixed === RUN TestNewLess/unknownComparison === RUN TestNewLess/unknownSortDirection === RUN TestNewLess/size === RUN TestNewLess/name === RUN TestNewLess/modtime === RUN TestNewLess/size,ascending === RUN TestNewLess/name,asc === RUN TestNewLess/modtime,ascending === RUN TestNewLess/size,descending === RUN TestNewLess/name,desc === RUN TestNewLess/modtime,descending === RUN TestNewLess/modtime,mixed === RUN TestNewLess/modtime,mixed,30 --- PASS: TestNewLess (0.00s) --- PASS: TestNewLess/blankOK (0.00s) --- PASS: TestNewLess/tooManyParts (0.00s) --- PASS: TestNewLess/tooManyParts2 (0.00s) --- PASS: TestNewLess/badMixed (0.00s) --- PASS: TestNewLess/unknownComparison (0.00s) --- PASS: TestNewLess/unknownSortDirection (0.00s) --- PASS: TestNewLess/size (0.00s) --- PASS: TestNewLess/name (0.00s) --- PASS: TestNewLess/modtime (0.00s) --- PASS: TestNewLess/size,ascending (0.00s) --- PASS: TestNewLess/name,asc (0.00s) --- PASS: TestNewLess/modtime,ascending (0.00s) --- PASS: TestNewLess/size,descending (0.00s) --- PASS: TestNewLess/name,desc (0.00s) --- PASS: TestNewLess/modtime,descending (0.00s) --- PASS: TestNewLess/modtime,mixed (0.00s) --- PASS: TestNewLess/modtime,mixed,30 (0.00s) === RUN TestRcCopy rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcCopy (0.00s) === RUN TestRcMove rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcMove (0.00s) === RUN TestRcSync rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcSync (0.00s) === RUN TestCopyWithDryRun run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:55:52 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) 2021/12/13 05:55:52 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:55:52 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish --- PASS: TestCopyWithDryRun (1.56s) === RUN TestCopy run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:55:53 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:55:53 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:55:54 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/12/13 05:55:54 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopy (2.29s) === RUN TestCopyMissingDirectory run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:55:55 DEBUG : Creating backend with remote "/non-existing" 2021/12/13 05:55:55 ERROR : Local file system at /non-existing: error reading source root directory: directory not found 2021/12/13 05:55:55 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:55:55 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish --- PASS: TestCopyMissingDirectory (0.50s) === RUN TestCopyNoTraverse run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:55:56 DEBUG : Couldn't decode error response: EOF 2021/12/13 05:55:56 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:55:56 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:55:57 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/12/13 05:55:57 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoTraverse (4.08s) === RUN TestCopyCheckFirst run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:56:00 INFO : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Running all checks before starting transfers 2021/12/13 05:56:00 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:56:00 INFO : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Checks finished, now starting transfers 2021/12/13 05:56:00 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:56:00 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/12/13 05:56:00 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyCheckFirst (1.33s) === RUN TestSyncNoTraverse run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:56:01 ERROR : Ignoring --no-traverse with sync 2021/12/13 05:56:01 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:56:01 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:56:02 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/12/13 05:56:02 INFO : sub dir/hello world: Copied (new) 2021/12/13 05:56:02 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoTraverse (1.93s) === RUN TestCopyWithDepth run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:56:03 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:56:03 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:56:04 DEBUG : hello world2: sha1 = c0bf117f9c93d02c894fe8ffd6e5cecf3545c209 OK 2021/12/13 05:56:04 INFO : hello world2: Copied (new) --- PASS: TestCopyWithDepth (2.04s) === RUN TestCopyWithFilesFrom run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:56:05 DEBUG : hello world2: Excluded 2021/12/13 05:56:05 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:56:05 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:56:06 DEBUG : potato2: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/12/13 05:56:06 INFO : potato2: Copied (new) --- PASS: TestCopyWithFilesFrom (1.70s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:56:07 DEBUG : Couldn't decode error response: EOF 2021/12/13 05:56:07 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:56:07 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:56:08 DEBUG : potato2: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/12/13 05:56:08 INFO : potato2: Copied (new) --- PASS: TestCopyWithFilesFromAndNoTraverse (1.96s) === RUN TestCopyEmptyDirectories run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:56:09 DEBUG : sub dir2: Making directory 2021/12/13 05:56:09 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:56:09 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:56:09 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/12/13 05:56:09 INFO : sub dir/hello world: Copied (new) 2021/12/13 05:56:09 DEBUG : sub dir2: Making directory 2021/12/13 05:56:09 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: copied 1 directories fstest.go:251: Filtering empty directory "sub dir2" --- PASS: TestCopyEmptyDirectories (1.38s) === RUN TestMoveEmptyDirectories run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:56:10 DEBUG : sub dir2: Making directory 2021/12/13 05:56:10 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:56:10 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:56:11 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/12/13 05:56:11 INFO : sub dir/hello world: Copied (new) 2021/12/13 05:56:11 INFO : sub dir/hello world: Deleted 2021/12/13 05:56:11 DEBUG : sub dir: Making directory 2021/12/13 05:56:11 DEBUG : sub dir2: Making directory 2021/12/13 05:56:11 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: copied 2 directories fstest.go:251: Filtering empty directory "sub dir2" --- PASS: TestMoveEmptyDirectories (1.32s) === RUN TestSyncEmptyDirectories run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:56:11 DEBUG : sub dir2: Making directory 2021/12/13 05:56:12 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:56:12 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:56:12 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/12/13 05:56:12 INFO : sub dir/hello world: Copied (new) 2021/12/13 05:56:12 DEBUG : sub dir2: Making directory 2021/12/13 05:56:12 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: copied 1 directories 2021/12/13 05:56:12 DEBUG : Waiting for deletions to finish fstest.go:251: Filtering empty directory "sub dir2" --- PASS: TestSyncEmptyDirectories (1.51s) === RUN TestServerSideCopy run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:56:14 DEBUG : Creating backend with remote "TestB2:rclone-test-waqixob8pewupac8pizezep5" sync_test.go:275: Server side copy (if possible) B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 -> B2 bucket rclone-test-waqixob8pewupac8pizezep5 2021/12/13 05:56:15 DEBUG : B2 bucket rclone-test-waqixob8pewupac8pizezep5: Waiting for checks to finish 2021/12/13 05:56:15 DEBUG : B2 bucket rclone-test-waqixob8pewupac8pizezep5: Waiting for transfers to finish 2021/12/13 05:56:15 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/12/13 05:56:15 INFO : sub dir/hello world: Copied (server-side copy) 2021/12/13 05:56:16 DEBUG : B2 bucket rclone-test-waqixob8pewupac8pizezep5: Purge remote 2021/12/13 05:56:16 DEBUG : sub dir/hello world: Deleting (id "4_zbfd2fd0350cdbb2b7fd80e1b_f118a359fb7e8c3c9_d20211213_m055615_c001_v0001097_t0002") --- PASS: TestServerSideCopy (4.34s) === RUN TestCopyAfterDelete run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:56:18 ERROR : : error listing: directory not found 2021/12/13 05:56:18 DEBUG : Local file system at /tmp/rclone940314831: Making directory 2021/12/13 05:56:18 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:56:18 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish --- PASS: TestCopyAfterDelete (1.75s) === RUN TestCopyRedownload run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:56:20 DEBUG : Local file system at /tmp/rclone940314831: Waiting for checks to finish 2021/12/13 05:56:20 DEBUG : Local file system at /tmp/rclone940314831: Waiting for transfers to finish 2021/12/13 05:56:20 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/12/13 05:56:20 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyRedownload (2.86s) === RUN TestSyncBasedOnCheckSum run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:56:22 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:56:22 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:56:22 DEBUG : check sum: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2021/12/13 05:56:22 INFO : check sum: Copied (new) 2021/12/13 05:56:22 DEBUG : Waiting for deletions to finish 2021/12/13 05:56:23 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:56:23 DEBUG : check sum: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2021/12/13 05:56:23 DEBUG : check sum: Size and sha1 of src and dst objects identical 2021/12/13 05:56:23 DEBUG : check sum: Unchanged skipping 2021/12/13 05:56:23 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:56:23 DEBUG : Waiting for deletions to finish 2021/12/13 05:56:23 INFO : There was nothing to transfer --- PASS: TestSyncBasedOnCheckSum (2.62s) === RUN TestSyncSizeOnly run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:56:25 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:56:25 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:56:25 DEBUG : sizeonly: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2021/12/13 05:56:25 INFO : sizeonly: Copied (new) 2021/12/13 05:56:25 DEBUG : Waiting for deletions to finish 2021/12/13 05:56:25 DEBUG : sizeonly: Sizes identical 2021/12/13 05:56:25 DEBUG : sizeonly: Unchanged skipping 2021/12/13 05:56:25 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:56:25 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:56:25 DEBUG : Waiting for deletions to finish 2021/12/13 05:56:25 INFO : There was nothing to transfer --- PASS: TestSyncSizeOnly (1.91s) === RUN TestSyncIgnoreSize run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:56:27 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:56:27 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:56:27 DEBUG : ignore-size: sha1 = 4a756ca07e9487f482465a99e8286abc86ba4dc7 OK 2021/12/13 05:56:27 INFO : ignore-size: Copied (new) 2021/12/13 05:56:27 DEBUG : Waiting for deletions to finish 2021/12/13 05:56:27 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:56:27 DEBUG : ignore-size: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 05:56:27 DEBUG : ignore-size: Unchanged skipping 2021/12/13 05:56:27 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:56:27 DEBUG : Waiting for deletions to finish 2021/12/13 05:56:27 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreSize (1.94s) === RUN TestSyncIgnoreTimes run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:56:29 DEBUG : existing: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 05:56:29 DEBUG : existing: Unchanged skipping 2021/12/13 05:56:29 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:56:29 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:56:29 DEBUG : Waiting for deletions to finish 2021/12/13 05:56:29 INFO : There was nothing to transfer 2021/12/13 05:56:29 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:56:29 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2021/12/13 05:56:29 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:56:30 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2021/12/13 05:56:30 INFO : existing: Copied (replaced existing) 2021/12/13 05:56:30 DEBUG : Waiting for deletions to finish --- PASS: TestSyncIgnoreTimes (2.28s) === RUN TestSyncIgnoreExisting run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:56:31 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:56:31 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:56:31 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2021/12/13 05:56:31 INFO : existing: Copied (new) 2021/12/13 05:56:31 DEBUG : Waiting for deletions to finish 2021/12/13 05:56:32 DEBUG : existing: Destination exists, skipping 2021/12/13 05:56:32 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:56:32 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:56:32 DEBUG : Waiting for deletions to finish 2021/12/13 05:56:32 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreExisting (1.97s) === RUN TestSyncIgnoreErrors run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:56:33 DEBUG : d: Making directory fstest.go:251: Filtering empty directory "d" 2021/12/13 05:56:34 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:56:34 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/13 05:56:34 DEBUG : c/non empty space: Unchanged skipping 2021/12/13 05:56:34 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:56:34 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/12/13 05:56:34 INFO : a/potato2: Copied (new) 2021/12/13 05:56:34 DEBUG : Waiting for deletions to finish 2021/12/13 05:56:35 INFO : b/potato: Deleted --- PASS: TestSyncIgnoreErrors (6.58s) === RUN TestSyncAfterChangingModtimeOnly run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:56:40 DEBUG : empty space: Modification times differ by -95456h54m52.624456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499 +0000 UTC 2021/12/13 05:56:40 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:56:40 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2021/12/13 05:56:40 NOTICE: empty space: Skipped update modification time as --dry-run is set (size 1) 2021/12/13 05:56:40 DEBUG : empty space: Unchanged skipping 2021/12/13 05:56:40 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:56:40 DEBUG : Waiting for deletions to finish 2021/12/13 05:56:40 INFO : There was nothing to transfer 2021/12/13 05:56:41 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:56:41 DEBUG : empty space: Modification times differ by -95456h54m52.624456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499 +0000 UTC 2021/12/13 05:56:41 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2021/12/13 05:56:42 INFO : empty space: Updated modification time in destination 2021/12/13 05:56:42 DEBUG : empty space: Unchanged skipping 2021/12/13 05:56:42 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:56:42 DEBUG : Waiting for deletions to finish 2021/12/13 05:56:42 INFO : There was nothing to transfer --- PASS: TestSyncAfterChangingModtimeOnly (3.91s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:56:44 DEBUG : empty space: Modification times differ by -95456h54m52.624456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499 +0000 UTC 2021/12/13 05:56:44 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:56:44 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2021/12/13 05:56:44 DEBUG : empty space: Unchanged skipping 2021/12/13 05:56:44 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:56:44 DEBUG : Waiting for deletions to finish 2021/12/13 05:56:44 INFO : There was nothing to transfer --- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (1.45s) === RUN TestSyncDoesntUpdateModtime run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:56:45 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:56:45 DEBUG : foo: Modification times differ by -95456h54m52.624456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499 +0000 UTC 2021/12/13 05:56:45 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 (Local file system at /tmp/rclone940314831) 2021/12/13 05:56:45 DEBUG : foo: sha1 = 62cdb7020ff920e5aa642c3d4066950dd1f01f4d (B2 bucket rclone-test-yopedoj9vafihuc7rokesod7) 2021/12/13 05:56:45 DEBUG : foo: sha1 differ 2021/12/13 05:56:45 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:56:46 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 OK 2021/12/13 05:56:46 INFO : foo: Copied (replaced existing) 2021/12/13 05:56:46 DEBUG : Waiting for deletions to finish --- PASS: TestSyncDoesntUpdateModtime (2.04s) === RUN TestSyncAfterAddingAFile run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:56:47 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:56:47 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/13 05:56:47 DEBUG : empty space: Unchanged skipping 2021/12/13 05:56:47 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:56:48 DEBUG : potato: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/12/13 05:56:48 INFO : potato: Copied (new) 2021/12/13 05:56:48 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterAddingAFile (2.08s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:56:50 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2021/12/13 05:56:50 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:56:50 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:56:50 DEBUG : potato: sha1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f OK 2021/12/13 05:56:50 INFO : potato: Copied (replaced existing) 2021/12/13 05:56:50 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingFilesSizeOnly (2.05s) === RUN TestSyncAfterChangingContentsOnly run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:56:51 DEBUG : potato: Modification times differ by 119h59m59.876543211s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2011-12-30 12:59:59 +0000 UTC 2021/12/13 05:56:51 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:56:52 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f (Local file system at /tmp/rclone940314831) 2021/12/13 05:56:52 DEBUG : potato: sha1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f (B2 bucket rclone-test-yopedoj9vafihuc7rokesod7) 2021/12/13 05:56:52 DEBUG : potato: sha1 differ 2021/12/13 05:56:52 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:56:52 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f OK 2021/12/13 05:56:52 INFO : potato: Copied (replaced existing) 2021/12/13 05:56:52 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingContentsOnly (2.28s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:56:54 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2021/12/13 05:56:54 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/13 05:56:54 DEBUG : empty space: Unchanged skipping 2021/12/13 05:56:54 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:56:54 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:56:54 DEBUG : Waiting for deletions to finish 2021/12/13 05:56:54 NOTICE: potato: Skipped delete as --dry-run is set (size 21) --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (3.03s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:56:57 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/13 05:56:57 DEBUG : empty space: Unchanged skipping 2021/12/13 05:56:57 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:56:57 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:56:57 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/12/13 05:56:57 INFO : potato2: Copied (new) 2021/12/13 05:56:57 DEBUG : Waiting for deletions to finish 2021/12/13 05:56:58 INFO : potato: Deleted --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (3.63s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:57:01 DEBUG : d: Making directory 2021/12/13 05:57:01 DEBUG : d/e: Making directory fstest.go:251: Filtering empty directory "d" fstest.go:251: Filtering empty directory "d/e" 2021/12/13 05:57:01 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:57:01 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/13 05:57:01 DEBUG : c/non empty space: Unchanged skipping 2021/12/13 05:57:01 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:57:01 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/12/13 05:57:01 INFO : a/potato2: Copied (new) 2021/12/13 05:57:01 DEBUG : Waiting for deletions to finish 2021/12/13 05:57:02 INFO : b/potato: Deleted --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (4.84s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:57:05 DEBUG : d: Making directory fstest.go:251: Filtering empty directory "d" 2021/12/13 05:57:06 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:57:06 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/13 05:57:06 DEBUG : c/non empty space: Unchanged skipping 2021/12/13 05:57:06 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:57:07 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/12/13 05:57:07 INFO : a/potato2: Copied (new) 2021/12/13 05:57:07 ERROR : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: not deleting files as there were IO errors 2021/12/13 05:57:07 ERROR : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: not deleting directories as there were IO errors fstest.go:251: Filtering empty directory "d" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (13.17s) === RUN TestSyncDeleteAfter --- PASS: TestSyncDeleteAfter (0.00s) === RUN TestSyncDeleteDuring run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:57:19 DEBUG : Waiting for deletions to finish 2021/12/13 05:57:20 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/13 05:57:20 DEBUG : empty space: Unchanged skipping 2021/12/13 05:57:20 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:57:20 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:57:20 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/12/13 05:57:20 INFO : potato2: Copied (new) 2021/12/13 05:57:22 INFO : potato: Deleted --- PASS: TestSyncDeleteDuring (5.88s) === RUN TestSyncDeleteBefore run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:57:24 DEBUG : Waiting for deletions to finish 2021/12/13 05:57:24 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:57:24 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:57:25 INFO : potato: Deleted 2021/12/13 05:57:25 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:57:25 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/13 05:57:25 DEBUG : empty space: Unchanged skipping 2021/12/13 05:57:25 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:57:25 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/12/13 05:57:25 INFO : potato2: Copied (new) --- PASS: TestSyncDeleteBefore (3.90s) === RUN TestCopyDeleteBefore run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:57:28 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:57:28 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:57:29 DEBUG : potato2: sha1 = 810274f0df19dab60a894a562b7a8ff04c072623 OK 2021/12/13 05:57:29 INFO : potato2: Copied (new) --- PASS: TestCopyDeleteBefore (4.13s) === RUN TestSyncWithExclude run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:57:33 DEBUG : enormous: Excluded 2021/12/13 05:57:33 DEBUG : potato2: Excluded 2021/12/13 05:57:33 DEBUG : potato2: Excluded from sync (and deletion) 2021/12/13 05:57:33 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/13 05:57:33 DEBUG : empty space: Unchanged skipping 2021/12/13 05:57:33 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:57:33 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:57:33 DEBUG : Waiting for deletions to finish 2021/12/13 05:57:33 INFO : There was nothing to transfer 2021/12/13 05:57:33 DEBUG : enormous: Excluded 2021/12/13 05:57:33 DEBUG : potato2: Excluded 2021/12/13 05:57:33 DEBUG : potato2: Excluded from sync (and deletion) 2021/12/13 05:57:33 DEBUG : empty space: Size and modification time the same (differ by 456.789µs, within tolerance 1ms) 2021/12/13 05:57:33 DEBUG : empty space: Unchanged skipping 2021/12/13 05:57:33 DEBUG : Local file system at /tmp/rclone940314831: Waiting for checks to finish 2021/12/13 05:57:33 DEBUG : Local file system at /tmp/rclone940314831: Waiting for transfers to finish 2021/12/13 05:57:33 DEBUG : Waiting for deletions to finish 2021/12/13 05:57:33 INFO : There was nothing to transfer --- PASS: TestSyncWithExclude (3.89s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:57:37 DEBUG : enormous: Excluded 2021/12/13 05:57:37 DEBUG : potato2: Excluded 2021/12/13 05:57:37 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:57:37 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/13 05:57:37 DEBUG : empty space: Unchanged skipping 2021/12/13 05:57:37 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:57:37 DEBUG : Waiting for deletions to finish 2021/12/13 05:57:38 INFO : enormous: Deleted 2021/12/13 05:57:38 INFO : potato2: Deleted 2021/12/13 05:57:38 INFO : There was nothing to transfer 2021/12/13 05:57:38 DEBUG : empty space: Size and modification time the same (differ by 456.789µs, within tolerance 1ms) 2021/12/13 05:57:38 DEBUG : empty space: Unchanged skipping 2021/12/13 05:57:38 DEBUG : Local file system at /tmp/rclone940314831: Waiting for checks to finish 2021/12/13 05:57:38 DEBUG : Local file system at /tmp/rclone940314831: Waiting for transfers to finish 2021/12/13 05:57:38 DEBUG : Waiting for deletions to finish 2021/12/13 05:57:38 INFO : enormous: Deleted 2021/12/13 05:57:38 INFO : potato2: Deleted 2021/12/13 05:57:38 INFO : There was nothing to transfer --- PASS: TestSyncWithExcludeAndDeleteExcluded (3.51s) === RUN TestSyncWithUpdateOlder run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:57:41 DEBUG : four: Sizes differ (src 4 vs dst 8) 2021/12/13 05:57:41 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2021/12/13 05:57:41 DEBUG : three: Sizes identical 2021/12/13 05:57:41 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2021/12/13 05:57:41 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:57:41 DEBUG : one: Destination is newer than source, skipping 2021/12/13 05:57:41 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b (Local file system at /tmp/rclone940314831) 2021/12/13 05:57:41 DEBUG : two: sha1 = b10e0da85e90399abfec36c7376b20aa4596461b (B2 bucket rclone-test-yopedoj9vafihuc7rokesod7) 2021/12/13 05:57:41 DEBUG : two: sha1 differ 2021/12/13 05:57:41 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:57:41 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2021/12/13 05:57:41 INFO : four: Copied (replaced existing) 2021/12/13 05:57:42 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2021/12/13 05:57:42 INFO : five: Copied (new) 2021/12/13 05:57:42 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2021/12/13 05:57:42 INFO : two: Copied (replaced existing) 2021/12/13 05:57:42 DEBUG : Waiting for deletions to finish 2021/12/13 05:57:42 DEBUG : one: Destination is newer than source, skipping 2021/12/13 05:57:42 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:57:42 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2021/12/13 05:57:42 DEBUG : four: Size and sha1 of src and dst objects identical 2021/12/13 05:57:42 DEBUG : four: Destination mod time is within 1s of source and files identical, skipping 2021/12/13 05:57:42 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2021/12/13 05:57:42 DEBUG : two: Size and sha1 of src and dst objects identical 2021/12/13 05:57:42 DEBUG : two: Destination mod time is within 1s of source and files identical, skipping 2021/12/13 05:57:42 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2021/12/13 05:57:42 DEBUG : five: Size and sha1 of src and dst objects identical 2021/12/13 05:57:42 DEBUG : five: Destination mod time is within 1s of source and files identical, skipping 2021/12/13 05:57:42 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb (Local file system at /tmp/rclone940314831) 2021/12/13 05:57:42 DEBUG : three: sha1 = 03731cad13f4cf7b59703c77529381cdec1632e5 (B2 bucket rclone-test-yopedoj9vafihuc7rokesod7) 2021/12/13 05:57:42 DEBUG : three: sha1 differ 2021/12/13 05:57:42 DEBUG : three: Destination mod time is within 1s of source but files differ, transferring 2021/12/13 05:57:42 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:57:44 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2021/12/13 05:57:44 INFO : three: Copied (replaced existing) 2021/12/13 05:57:44 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithUpdateOlder (9.81s) === 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-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" sync_test.go:1058: Can track renames: true 2021/12/13 05:57:49 INFO : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Making map for --track-renames 2021/12/13 05:57:49 INFO : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Finished making map for --track-renames 2021/12/13 05:57:49 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:57:49 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for renames to finish 2021/12/13 05:57:49 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:57:50 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2021/12/13 05:57:50 INFO : potato: Copied (new) 2021/12/13 05:57:50 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2021/12/13 05:57:50 INFO : yam: Copied (new) 2021/12/13 05:57:50 DEBUG : Waiting for deletions to finish 2021/12/13 05:57:51 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 05:57:51 DEBUG : potato: Unchanged skipping 2021/12/13 05:57:51 INFO : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Making map for --track-renames 2021/12/13 05:57:51 INFO : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Finished making map for --track-renames 2021/12/13 05:57:51 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:57:51 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for renames to finish 2021/12/13 05:57:51 DEBUG : Couldn't decode error response: EOF 2021/12/13 05:57:53 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2021/12/13 05:57:53 INFO : yam: Copied (server-side copy) to: yaml 2021/12/13 05:57:53 INFO : yam: Deleted 2021/12/13 05:57:53 INFO : yaml: Renamed from "yam" 2021/12/13 05:57:53 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:57:53 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenames (8.04s) === RUN TestParseRenamesStrategyModtime --- PASS: TestParseRenamesStrategyModtime (0.00s) === RUN TestRenamesStrategyModtime --- PASS: TestRenamesStrategyModtime (0.00s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" sync_test.go:1127: Can track renames: true 2021/12/13 05:57:57 INFO : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Making map for --track-renames 2021/12/13 05:57:57 INFO : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Finished making map for --track-renames 2021/12/13 05:57:57 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:57:57 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for renames to finish 2021/12/13 05:57:57 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:57:58 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2021/12/13 05:57:58 INFO : yam: Copied (new) 2021/12/13 05:57:58 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2021/12/13 05:57:58 INFO : potato: Copied (new) 2021/12/13 05:57:58 DEBUG : Waiting for deletions to finish 2021/12/13 05:57:58 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 05:57:58 INFO : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Making map for --track-renames 2021/12/13 05:57:58 DEBUG : potato: Unchanged skipping 2021/12/13 05:57:58 INFO : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Finished making map for --track-renames 2021/12/13 05:57:58 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:57:58 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for renames to finish 2021/12/13 05:57:59 DEBUG : Couldn't decode error response: EOF 2021/12/13 05:58:00 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2021/12/13 05:58:00 INFO : yam: Copied (server-side copy) to: yaml 2021/12/13 05:58:01 INFO : yam: Deleted 2021/12/13 05:58:01 INFO : yaml: Renamed from "yam" 2021/12/13 05:58:01 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:58:01 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenamesStrategyModtime (12.24s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" sync_test.go:1163: Can track renames: true 2021/12/13 05:58:09 INFO : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Making map for --track-renames 2021/12/13 05:58:09 INFO : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Finished making map for --track-renames 2021/12/13 05:58:09 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:58:09 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for renames to finish 2021/12/13 05:58:09 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:58:10 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2021/12/13 05:58:10 INFO : sub/yam: Copied (new) 2021/12/13 05:58:10 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2021/12/13 05:58:10 INFO : potato: Copied (new) 2021/12/13 05:58:10 DEBUG : Waiting for deletions to finish 2021/12/13 05:58:11 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 05:58:11 DEBUG : potato: Unchanged skipping 2021/12/13 05:58:11 INFO : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Making map for --track-renames 2021/12/13 05:58:11 INFO : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Finished making map for --track-renames 2021/12/13 05:58:11 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:58:11 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for renames to finish 2021/12/13 05:58:11 DEBUG : Couldn't decode error response: EOF 2021/12/13 05:58:12 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2021/12/13 05:58:12 INFO : sub/yam: Copied (server-side copy) to: yam 2021/12/13 05:58:12 INFO : sub/yam: Deleted 2021/12/13 05:58:12 INFO : yam: Renamed from "sub/yam" 2021/12/13 05:58:12 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:58:12 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenamesStrategyLeaf (5.27s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:58:15 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:58:15 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:58:15 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2021/12/13 05:58:15 INFO : nested/sub dir/file: Copied (new) 2021/12/13 05:58:15 INFO : nested/sub dir/file: Deleted 2021/12/13 05:58:15 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/12/13 05:58:15 INFO : sub dir/hello world: Copied (new) 2021/12/13 05:58:15 INFO : sub dir/hello world: Deleted 2021/12/13 05:58:15 INFO : sub dir: Removing directory 2021/12/13 05:58:15 INFO : nested/sub dir: Removing directory 2021/12/13 05:58:15 INFO : nested: Removing directory 2021/12/13 05:58:15 DEBUG : Local file system at /tmp/rclone940314831: deleted 3 directories --- PASS: TestMoveWithDeleteEmptySrcDirs (2.58s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:58:17 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:58:17 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:58:18 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2021/12/13 05:58:18 INFO : nested/sub dir/file: Copied (new) 2021/12/13 05:58:18 INFO : nested/sub dir/file: Deleted 2021/12/13 05:58:19 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/12/13 05:58:19 INFO : sub dir/hello world: Copied (new) 2021/12/13 05:58:19 INFO : sub dir/hello world: Deleted --- PASS: TestMoveWithoutDeleteEmptySrcDirs (4.20s) === RUN TestMoveWithIgnoreExisting run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:58:21 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:58:21 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:58:22 DEBUG : existing-b: sha1 = 321f6b7e8bf7f29aab89c5e41a555b1b0baa41a9 OK 2021/12/13 05:58:22 INFO : existing-b: Copied (new) 2021/12/13 05:58:22 INFO : existing-b: Deleted 2021/12/13 05:58:22 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2021/12/13 05:58:22 INFO : existing: Copied (new) 2021/12/13 05:58:22 INFO : existing: Deleted 2021/12/13 05:58:23 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 05:58:23 DEBUG : existing: Destination exists, skipping 2021/12/13 05:58:23 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2021/12/13 05:58:23 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 05:58:23 INFO : There was nothing to transfer --- PASS: TestMoveWithIgnoreExisting (2.45s) === RUN TestServerSideMove run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:58:24 DEBUG : Creating backend with remote "TestB2:rclone-test-sacelof9tokusuv4yuwofem2" 2021/12/13 05:58:27 DEBUG : empty space: Clearing upload URL because of error: Post "https://pod-000-1165-13.backblaze.com/b2api/v1/b2_upload_file/1ff29d8350cdbb2b7fd80e1b/c001_v0001165_t0048": EOF 2021/12/13 05:58:27 DEBUG : pacer: low level retry 1/1 (error Post "https://pod-000-1165-13.backblaze.com/b2api/v1/b2_upload_file/1ff29d8350cdbb2b7fd80e1b/c001_v0001165_t0048": EOF) 2021/12/13 05:58:27 DEBUG : pacer: Rate limited, increasing sleep to 20ms run.go:283: Retry Put of "empty space" to B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: 1/10 (Post "https://pod-000-1165-13.backblaze.com/b2api/v1/b2_upload_file/1ff29d8350cdbb2b7fd80e1b/c001_v0001165_t0048": EOF) 2021/12/13 05:58:29 DEBUG : pacer: Reducing sleep to 10ms sync_test.go:1215: Server side move (if possible) B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 -> B2 bucket rclone-test-sacelof9tokusuv4yuwofem2 2021/12/13 05:58:35 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ms) 2021/12/13 05:58:35 DEBUG : empty space: Unchanged skipping 2021/12/13 05:58:35 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2021/12/13 05:58:35 DEBUG : B2 bucket rclone-test-sacelof9tokusuv4yuwofem2: Waiting for checks to finish 2021/12/13 05:58:36 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/12/13 05:58:36 INFO : potato2: Copied (server-side copy) 2021/12/13 05:58:36 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2021/12/13 05:58:36 INFO : potato3: Copied (server-side copy) 2021/12/13 05:58:36 INFO : potato3: Deleted 2021/12/13 05:58:36 INFO : potato2: Deleted 2021/12/13 05:58:38 INFO : empty space: Deleted 2021/12/13 05:58:38 DEBUG : B2 bucket rclone-test-sacelof9tokusuv4yuwofem2: Waiting for transfers to finish 2021/12/13 05:58:38 DEBUG : Creating backend with remote "TestB2:rclone-test-puqofof3lupedih3fumozah4" 2021/12/13 05:58:39 DEBUG : B2 bucket rclone-test-puqofof3lupedih3fumozah4: Waiting for checks to finish 2021/12/13 05:58:39 DEBUG : B2 bucket rclone-test-puqofof3lupedih3fumozah4: Waiting for transfers to finish 2021/12/13 05:58:40 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/12/13 05:58:40 INFO : potato2: Copied (server-side copy) 2021/12/13 05:58:40 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2021/12/13 05:58:40 INFO : potato3: Copied (server-side copy) 2021/12/13 05:58:40 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2021/12/13 05:58:40 INFO : empty space: Copied (server-side copy) 2021/12/13 05:58:40 INFO : empty space: Deleted 2021/12/13 05:58:40 INFO : potato3: Deleted 2021/12/13 05:58:40 INFO : potato2: Deleted 2021/12/13 05:58:41 DEBUG : B2 bucket rclone-test-puqofof3lupedih3fumozah4: Purge remote 2021/12/13 05:58:41 DEBUG : empty space: Deleting (id "4_z0fe22d4350fdbb2b7fd80e1b_f1049f40724711ad6_d20211213_m055839_c001_v0001030_t0000") 2021/12/13 05:58:41 DEBUG : potato2: Deleting (id "4_z0fe22d4350fdbb2b7fd80e1b_f1123f2189ae4fc7f_d20211213_m055839_c001_v0001137_t0011") 2021/12/13 05:58:41 DEBUG : potato3: Deleting (id "4_z0fe22d4350fdbb2b7fd80e1b_f1059276d9b6b6b5d_d20211213_m055839_c001_v0001000_t0015") 2021/12/13 05:58:41 DEBUG : B2 bucket rclone-test-sacelof9tokusuv4yuwofem2: Purge remote 2021/12/13 05:58:42 DEBUG : empty space: Deleting (id "4_zff320d4350fdbb2b7fd80e1b_f115ce568866da7dd_d20211213_m055840_c001_v0001165_t0050") 2021/12/13 05:58:42 DEBUG : empty space: Deleting (id "4_zff320d4350fdbb2b7fd80e1b_f1019bc656fefe353_d20211213_m055832_c001_v0001044_t0022") 2021/12/13 05:58:42 DEBUG : potato2: Deleting (id "4_zff320d4350fdbb2b7fd80e1b_f1127b99bb4311d59_d20211213_m055840_c001_v0001120_t0042") 2021/12/13 05:58:42 DEBUG : potato2: Deleting (id "4_zff320d4350fdbb2b7fd80e1b_f1064766d71a4fafe_d20211213_m055835_c001_v0001113_t0047") 2021/12/13 05:58:42 DEBUG : potato3: Deleting (id "4_zff320d4350fdbb2b7fd80e1b_f11637c63c41b5242_d20211213_m055840_c001_v0001097_t0039") 2021/12/13 05:58:42 DEBUG : potato3: Deleting (id "4_zff320d4350fdbb2b7fd80e1b_f1165239eee5ff7bf_d20211213_m055835_c001_v0001090_t0045") 2021/12/13 05:58:42 DEBUG : potato3: Deleting (id "4_zff320d4350fdbb2b7fd80e1b_f1019bc656fefe355_d20211213_m055833_c001_v0001044_t0040") --- PASS: TestServerSideMove (19.20s) === RUN TestServerSideMoveWithFilter run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:58:43 DEBUG : Creating backend with remote "TestB2:rclone-test-gedivef4pulezup2xaxitim7" sync_test.go:1215: Server side move (if possible) B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 -> B2 bucket rclone-test-gedivef4pulezup2xaxitim7 2021/12/13 05:58:51 DEBUG : empty space: Excluded from sync (and deletion) 2021/12/13 05:58:51 DEBUG : empty space: Excluded from sync (and deletion) 2021/12/13 05:58:51 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2021/12/13 05:58:51 DEBUG : B2 bucket rclone-test-gedivef4pulezup2xaxitim7: Waiting for checks to finish 2021/12/13 05:58:51 DEBUG : B2 bucket rclone-test-gedivef4pulezup2xaxitim7: Waiting for transfers to finish 2021/12/13 05:58:51 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2021/12/13 05:58:51 INFO : potato3: Copied (server-side copy) 2021/12/13 05:58:52 INFO : potato3: Deleted 2021/12/13 05:58:53 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/12/13 05:58:53 INFO : potato2: Copied (server-side copy) 2021/12/13 05:58:54 INFO : potato2: Deleted 2021/12/13 05:58:54 DEBUG : Creating backend with remote "TestB2:rclone-test-redilap3xafuqov7zeyijit6" 2021/12/13 05:58:55 DEBUG : empty space: Excluded from sync (and deletion) 2021/12/13 05:58:55 DEBUG : B2 bucket rclone-test-redilap3xafuqov7zeyijit6: Waiting for checks to finish 2021/12/13 05:58:55 DEBUG : B2 bucket rclone-test-redilap3xafuqov7zeyijit6: Waiting for transfers to finish 2021/12/13 05:58:56 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2021/12/13 05:58:56 INFO : potato3: Copied (server-side copy) 2021/12/13 05:58:57 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/12/13 05:58:57 INFO : potato2: Copied (server-side copy) 2021/12/13 05:58:57 INFO : potato3: Deleted 2021/12/13 05:58:57 INFO : potato2: Deleted 2021/12/13 05:58:58 DEBUG : B2 bucket rclone-test-redilap3xafuqov7zeyijit6: Purge remote 2021/12/13 05:58:58 DEBUG : potato2: Deleting (id "4_zcf426d4350fdbb2b7fd80e1b_f101201c183286ad5_d20211213_m055856_c001_v0001097_t0029") 2021/12/13 05:58:58 DEBUG : potato3: Deleting (id "4_zcf426d4350fdbb2b7fd80e1b_f107f3eba985596a1_d20211213_m055856_c001_v0001026_t0037") 2021/12/13 05:58:58 DEBUG : B2 bucket rclone-test-gedivef4pulezup2xaxitim7: Purge remote 2021/12/13 05:58:59 DEBUG : empty space: Deleting (id "4_z0fe24d1350fdbb2b7fd80e1b_f1021bee3b6f73247_d20211213_m055847_c001_v0001025_t0036") 2021/12/13 05:58:59 DEBUG : potato2: Deleting (id "4_z0fe24d1350fdbb2b7fd80e1b_f100785f21270537d_d20211213_m055857_c001_v0001120_t0013") 2021/12/13 05:58:59 DEBUG : potato2: Deleting (id "4_z0fe24d1350fdbb2b7fd80e1b_f1050452f3ae540f4_d20211213_m055851_c001_v0001097_t0000") 2021/12/13 05:58:59 DEBUG : potato3: Deleting (id "4_z0fe24d1350fdbb2b7fd80e1b_f100e1ff1d82444c4_d20211213_m055856_c001_v0001117_t0040") 2021/12/13 05:58:59 DEBUG : potato3: Deleting (id "4_z0fe24d1350fdbb2b7fd80e1b_f1083079faaff9d0b_d20211213_m055851_c001_v0001091_t0007") 2021/12/13 05:58:59 DEBUG : potato3: Deleting (id "4_z0fe24d1350fdbb2b7fd80e1b_f1021bee3b6f7324a_d20211213_m055850_c001_v0001025_t0024") --- PASS: TestServerSideMoveWithFilter (17.84s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:59:01 DEBUG : Creating backend with remote "TestB2:rclone-test-zupijig8xowamon8biyawum1" 2021/12/13 05:59:05 DEBUG : tomatoDir: Making directory sync_test.go:1215: Server side move (if possible) B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 -> B2 bucket rclone-test-zupijig8xowamon8biyawum1 2021/12/13 05:59:08 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ms) 2021/12/13 05:59:08 DEBUG : empty space: Unchanged skipping 2021/12/13 05:59:08 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2021/12/13 05:59:08 DEBUG : B2 bucket rclone-test-zupijig8xowamon8biyawum1: Waiting for checks to finish 2021/12/13 05:59:09 INFO : empty space: Deleted 2021/12/13 05:59:09 DEBUG : B2 bucket rclone-test-zupijig8xowamon8biyawum1: Waiting for transfers to finish 2021/12/13 05:59:09 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/12/13 05:59:09 INFO : potato2: Copied (server-side copy) 2021/12/13 05:59:09 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2021/12/13 05:59:09 INFO : potato3: Copied (server-side copy) 2021/12/13 05:59:10 INFO : potato3: Deleted 2021/12/13 05:59:11 INFO : potato2: Deleted 2021/12/13 05:59:11 DEBUG : Creating backend with remote "TestB2:rclone-test-cakegon0lewesoj3rifivic3" 2021/12/13 05:59:12 DEBUG : tomatoDir: Making directory 2021/12/13 05:59:12 DEBUG : B2 bucket rclone-test-cakegon0lewesoj3rifivic3: Waiting for checks to finish 2021/12/13 05:59:12 DEBUG : B2 bucket rclone-test-cakegon0lewesoj3rifivic3: Waiting for transfers to finish 2021/12/13 05:59:13 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2021/12/13 05:59:13 INFO : empty space: Copied (server-side copy) 2021/12/13 05:59:13 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/12/13 05:59:13 INFO : potato2: Copied (server-side copy) 2021/12/13 05:59:14 INFO : empty space: Deleted 2021/12/13 05:59:14 INFO : potato2: Deleted 2021/12/13 05:59:14 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2021/12/13 05:59:14 INFO : potato3: Copied (server-side copy) 2021/12/13 05:59:15 INFO : potato3: Deleted 2021/12/13 05:59:15 DEBUG : B2 bucket rclone-test-cakegon0lewesoj3rifivic3: Purge remote 2021/12/13 05:59:15 DEBUG : empty space: Deleting (id "4_zefa2ad5350fdbb2b7fd80e1b_f1157c4ab0286b046_d20211213_m055913_c001_v0001097_t0012") 2021/12/13 05:59:15 DEBUG : potato2: Deleting (id "4_zefa2ad5350fdbb2b7fd80e1b_f110ec3252c8945d5_d20211213_m055913_c001_v0001041_t0009") 2021/12/13 05:59:15 DEBUG : potato3: Deleting (id "4_zefa2ad5350fdbb2b7fd80e1b_f11419e70f9ab15a6_d20211213_m055913_c001_v0001040_t0046") 2021/12/13 05:59:16 DEBUG : B2 bucket rclone-test-zupijig8xowamon8biyawum1: Purge remote 2021/12/13 05:59:16 DEBUG : empty space: Deleting (id "4_z8f628dc350fdbb2b7fd80e1b_f11760e935c35f326_d20211213_m055913_c001_v0001092_t0058") 2021/12/13 05:59:16 DEBUG : empty space: Deleting (id "4_z8f628dc350fdbb2b7fd80e1b_f1157c4ab0286b00f_d20211213_m055907_c001_v0001097_t0016") 2021/12/13 05:59:16 DEBUG : potato2: Deleting (id "4_z8f628dc350fdbb2b7fd80e1b_f106a1bf2f66c8cd6_d20211213_m055913_c001_v0001041_t0035") 2021/12/13 05:59:16 DEBUG : potato2: Deleting (id "4_z8f628dc350fdbb2b7fd80e1b_f116b02b72ec4e25b_d20211213_m055909_c001_v0001134_t0029") 2021/12/13 05:59:16 DEBUG : potato3: Deleting (id "4_z8f628dc350fdbb2b7fd80e1b_f112eab9e63d18909_d20211213_m055914_c001_v0001090_t0002") 2021/12/13 05:59:16 DEBUG : potato3: Deleting (id "4_z8f628dc350fdbb2b7fd80e1b_f1046036143e31c60_d20211213_m055909_c001_v0001025_t0003") 2021/12/13 05:59:16 DEBUG : potato3: Deleting (id "4_z8f628dc350fdbb2b7fd80e1b_f1157c4ab0286b018_d20211213_m055908_c001_v0001097_t0039") --- PASS: TestServerSideMoveDeleteEmptySourceDirs (16.82s) === RUN TestServerSideMoveOverlap run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:59:17 DEBUG : Creating backend with remote "TestB2:rclone-test-yopedoj9vafihuc7rokesod7/rclone-move-test" 2021/12/13 05:59:19 DEBUG : Couldn't decode error response: EOF --- PASS: TestServerSideMoveOverlap (4.35s) === RUN TestSyncOverlap run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:59:22 DEBUG : Creating backend with remote "TestB2:rclone-test-yopedoj9vafihuc7rokesod7/rclone-sync-test" 2021/12/13 05:59:22 DEBUG : Couldn't decode error response: EOF --- PASS: TestSyncOverlap (0.73s) === RUN TestSyncCompareDest run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:59:23 DEBUG : Creating backend with remote "TestB2:rclone-test-yopedoj9vafihuc7rokesod7/dst" 2021/12/13 05:59:23 DEBUG : Couldn't decode error response: EOF 2021/12/13 05:59:23 DEBUG : Creating backend with remote "TestB2:rclone-test-yopedoj9vafihuc7rokesod7/CompareDest" 2021/12/13 05:59:23 DEBUG : Couldn't decode error response: EOF 2021/12/13 05:59:24 DEBUG : Couldn't decode error response: EOF 2021/12/13 05:59:24 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for checks to finish 2021/12/13 05:59:24 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for transfers to finish 2021/12/13 05:59:25 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/12/13 05:59:25 INFO : one: Copied (new) 2021/12/13 05:59:25 DEBUG : Waiting for deletions to finish 2021/12/13 05:59:25 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for checks to finish 2021/12/13 05:59:26 DEBUG : Couldn't decode error response: EOF 2021/12/13 05:59:26 DEBUG : one: Sizes differ (src 5 vs dst 3) 2021/12/13 05:59:26 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for transfers to finish 2021/12/13 05:59:26 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2021/12/13 05:59:26 INFO : one: Copied (replaced existing) 2021/12/13 05:59:26 DEBUG : Waiting for deletions to finish 2021/12/13 05:59:28 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for checks to finish 2021/12/13 05:59:29 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/13 05:59:29 DEBUG : one: Destination found in --compare-dest, skipping 2021/12/13 05:59:29 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for transfers to finish 2021/12/13 05:59:29 DEBUG : Waiting for deletions to finish 2021/12/13 05:59:29 INFO : There was nothing to transfer 2021/12/13 05:59:30 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/13 05:59:30 DEBUG : two: Destination found in --compare-dest, skipping 2021/12/13 05:59:30 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for checks to finish 2021/12/13 05:59:30 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/13 05:59:30 DEBUG : one: Destination found in --compare-dest, skipping 2021/12/13 05:59:30 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for transfers to finish 2021/12/13 05:59:30 DEBUG : Waiting for deletions to finish 2021/12/13 05:59:30 INFO : There was nothing to transfer 2021/12/13 05:59:31 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/13 05:59:31 DEBUG : two: Destination found in --compare-dest, skipping 2021/12/13 05:59:31 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for checks to finish 2021/12/13 05:59:31 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/13 05:59:31 DEBUG : one: Destination found in --compare-dest, skipping 2021/12/13 05:59:31 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for transfers to finish 2021/12/13 05:59:31 DEBUG : Waiting for deletions to finish 2021/12/13 05:59:31 INFO : There was nothing to transfer 2021/12/13 05:59:32 DEBUG : two: Modification times differ by -119h59m59.877s: 2011-12-30 12:59:59 +0000 UTC, 2011-12-25 12:59:59.123 +0000 UTC 2021/12/13 05:59:32 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2021/12/13 05:59:32 DEBUG : two: Destination found in --compare-dest, skipping 2021/12/13 05:59:32 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for checks to finish 2021/12/13 05:59:32 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/13 05:59:32 DEBUG : one: Destination found in --compare-dest, skipping 2021/12/13 05:59:32 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for transfers to finish 2021/12/13 05:59:32 DEBUG : Waiting for deletions to finish 2021/12/13 05:59:32 INFO : There was nothing to transfer 2021/12/13 05:59:32 DEBUG : two: Sizes differ (src 5 vs dst 3) 2021/12/13 05:59:32 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for checks to finish 2021/12/13 05:59:33 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/13 05:59:33 DEBUG : one: Destination found in --compare-dest, skipping 2021/12/13 05:59:33 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for transfers to finish 2021/12/13 05:59:33 DEBUG : two: sha1 = a4be8877ad88f3109a6411985a1f359e10e2d930 OK 2021/12/13 05:59:33 INFO : two: Copied (new) 2021/12/13 05:59:33 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (16.42s) === RUN TestSyncMultipleCompareDest run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:59:41 DEBUG : Creating backend with remote "TestB2:rclone-test-yopedoj9vafihuc7rokesod7/dest" 2021/12/13 05:59:43 DEBUG : Couldn't decode error response: EOF 2021/12/13 05:59:43 DEBUG : Creating backend with remote "TestB2:rclone-test-yopedoj9vafihuc7rokesod7/pre-dest1" 2021/12/13 05:59:43 DEBUG : Couldn't decode error response: EOF 2021/12/13 05:59:43 DEBUG : Creating backend with remote "TestB2:rclone-test-yopedoj9vafihuc7rokesod7/pre-dest2" 2021/12/13 05:59:44 DEBUG : Couldn't decode error response: EOF 2021/12/13 05:59:44 DEBUG : 1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 05:59:44 DEBUG : 1: Destination found in --compare-dest, skipping 2021/12/13 05:59:44 DEBUG : Couldn't decode error response: EOF 2021/12/13 05:59:44 DEBUG : 2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 05:59:44 DEBUG : 2: Destination found in --compare-dest, skipping 2021/12/13 05:59:45 DEBUG : Couldn't decode error response: EOF 2021/12/13 05:59:45 DEBUG : Couldn't decode error response: EOF 2021/12/13 05:59:45 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dest: Waiting for checks to finish 2021/12/13 05:59:45 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dest: Waiting for transfers to finish 2021/12/13 05:59:47 DEBUG : 3: sha1 = 77de68daecd823babbb58edb1c8e14d7106e83bb OK 2021/12/13 05:59:47 INFO : 3: Copied (new) 2021/12/13 05:59:47 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (9.81s) === RUN TestSyncCopyDest run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 05:59:49 DEBUG : Creating backend with remote "TestB2:rclone-test-yopedoj9vafihuc7rokesod7/dst" 2021/12/13 05:59:50 DEBUG : Couldn't decode error response: EOF 2021/12/13 05:59:50 DEBUG : Creating backend with remote "TestB2:rclone-test-yopedoj9vafihuc7rokesod7/CopyDest" 2021/12/13 05:59:50 DEBUG : Couldn't decode error response: EOF 2021/12/13 05:59:51 DEBUG : Couldn't decode error response: EOF 2021/12/13 05:59:51 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for checks to finish 2021/12/13 05:59:51 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for transfers to finish 2021/12/13 05:59:52 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/12/13 05:59:52 INFO : one: Copied (new) 2021/12/13 05:59:52 DEBUG : Waiting for deletions to finish 2021/12/13 05:59:52 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for checks to finish 2021/12/13 05:59:52 DEBUG : Couldn't decode error response: EOF 2021/12/13 05:59:52 DEBUG : one: Sizes differ (src 5 vs dst 3) 2021/12/13 05:59:52 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for transfers to finish 2021/12/13 05:59:53 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2021/12/13 05:59:53 INFO : one: Copied (replaced existing) 2021/12/13 05:59:53 DEBUG : Waiting for deletions to finish 2021/12/13 05:59:55 DEBUG : Creating backend with remote "TestB2:rclone-test-yopedoj9vafihuc7rokesod7/BackupDir" 2021/12/13 05:59:56 DEBUG : Couldn't decode error response: EOF 2021/12/13 05:59:56 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for checks to finish 2021/12/13 05:59:56 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/13 05:59:56 DEBUG : one: Sizes differ (src 5 vs dst 3) 2021/12/13 05:59:57 DEBUG : Couldn't decode error response: EOF 2021/12/13 06:00:00 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/12/13 06:00:00 INFO : one: Copied (server-side copy) 2021/12/13 06:00:01 INFO : one: Deleted 2021/12/13 06:00:02 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2021/12/13 06:00:02 INFO : one: Copied (server-side copy) 2021/12/13 06:00:02 DEBUG : one: Destination found in --copy-dest, using server-side copy 2021/12/13 06:00:02 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for transfers to finish 2021/12/13 06:00:02 DEBUG : Waiting for deletions to finish 2021/12/13 06:00:04 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/13 06:00:05 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2021/12/13 06:00:05 INFO : two: Copied (server-side copy) 2021/12/13 06:00:05 DEBUG : two: Destination found in --copy-dest, using server-side copy 2021/12/13 06:00:05 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for checks to finish 2021/12/13 06:00:05 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/13 06:00:05 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/13 06:00:05 DEBUG : one: Unchanged skipping 2021/12/13 06:00:05 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for transfers to finish 2021/12/13 06:00:05 DEBUG : Waiting for deletions to finish 2021/12/13 06:00:05 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for checks to finish 2021/12/13 06:00:05 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/13 06:00:05 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/13 06:00:05 DEBUG : one: Unchanged skipping 2021/12/13 06:00:05 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/13 06:00:05 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/13 06:00:05 DEBUG : two: Unchanged skipping 2021/12/13 06:00:05 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for transfers to finish 2021/12/13 06:00:05 DEBUG : Waiting for deletions to finish 2021/12/13 06:00:05 INFO : There was nothing to transfer 2021/12/13 06:00:08 DEBUG : three: Sizes differ (src 7 vs dst 5) 2021/12/13 06:00:08 DEBUG : three: Destination not found in --copy-dest 2021/12/13 06:00:08 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for checks to finish 2021/12/13 06:00:08 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/13 06:00:08 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/13 06:00:08 DEBUG : one: Unchanged skipping 2021/12/13 06:00:08 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/13 06:00:08 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/12/13 06:00:08 DEBUG : two: Unchanged skipping 2021/12/13 06:00:08 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for transfers to finish 2021/12/13 06:00:09 DEBUG : three: sha1 = 370e613335f3cf2f19b2a2d35a86402f55c659f8 OK 2021/12/13 06:00:09 INFO : three: Copied (new) 2021/12/13 06:00:09 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCopyDest (25.34s) === RUN TestSyncBackupDir run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 06:00:16 DEBUG : Creating backend with remote "TestB2:rclone-test-yopedoj9vafihuc7rokesod7/dst" 2021/12/13 06:00:17 DEBUG : Couldn't decode error response: EOF 2021/12/13 06:00:17 DEBUG : Creating backend with remote "TestB2:rclone-test-yopedoj9vafihuc7rokesod7/backup" 2021/12/13 06:00:18 DEBUG : Couldn't decode error response: EOF 2021/12/13 06:00:18 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/12/13 06:00:18 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:00:18 DEBUG : two: Unchanged skipping 2021/12/13 06:00:18 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for checks to finish 2021/12/13 06:00:18 DEBUG : Couldn't decode error response: EOF 2021/12/13 06:00:21 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/12/13 06:00:21 INFO : one: Copied (server-side copy) 2021/12/13 06:00:21 INFO : one: Deleted 2021/12/13 06:00:21 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for transfers to finish 2021/12/13 06:00:23 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/12/13 06:00:23 INFO : one: Copied (new) 2021/12/13 06:00:23 DEBUG : Waiting for deletions to finish 2021/12/13 06:00:23 DEBUG : Couldn't decode error response: EOF 2021/12/13 06:00:24 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2021/12/13 06:00:24 INFO : three.txt: Copied (server-side copy) 2021/12/13 06:00:25 INFO : three.txt: Deleted 2021/12/13 06:00:25 INFO : three.txt: Moved into backup dir 2021/12/13 06:00:26 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/12/13 06:00:26 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:00:26 DEBUG : two: Unchanged skipping 2021/12/13 06:00:26 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for checks to finish 2021/12/13 06:00:28 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/12/13 06:00:28 INFO : one: Copied (server-side copy) 2021/12/13 06:00:28 INFO : one: Deleted 2021/12/13 06:00:28 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for transfers to finish 2021/12/13 06:00:29 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2021/12/13 06:00:29 INFO : one: Copied (new) 2021/12/13 06:00:29 DEBUG : Waiting for deletions to finish 2021/12/13 06:00:31 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2021/12/13 06:00:31 INFO : three.txt: Copied (server-side copy) 2021/12/13 06:00:31 INFO : three.txt: Deleted 2021/12/13 06:00:31 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (48.99s) === RUN TestSyncBackupDirWithSuffix run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 06:01:08 DEBUG : Creating backend with remote "TestB2:rclone-test-yopedoj9vafihuc7rokesod7/dst" 2021/12/13 06:01:08 DEBUG : Config file has changed externaly - reloading 2021/12/13 06:01:09 DEBUG : Couldn't decode error response: EOF 2021/12/13 06:01:09 DEBUG : Creating backend with remote "TestB2:rclone-test-yopedoj9vafihuc7rokesod7/backup" 2021/12/13 06:01:10 DEBUG : Couldn't decode error response: EOF 2021/12/13 06:01:10 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for checks to finish 2021/12/13 06:01:10 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/12/13 06:01:10 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:01:10 DEBUG : two: Unchanged skipping 2021/12/13 06:01:10 DEBUG : Couldn't decode error response: EOF 2021/12/13 06:01:12 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/12/13 06:01:12 INFO : one: Copied (server-side copy) to: one.bak 2021/12/13 06:01:13 INFO : one: Deleted 2021/12/13 06:01:13 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for transfers to finish 2021/12/13 06:01:14 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/12/13 06:01:14 INFO : one: Copied (new) 2021/12/13 06:01:14 DEBUG : Waiting for deletions to finish 2021/12/13 06:01:14 DEBUG : Couldn't decode error response: EOF 2021/12/13 06:01:15 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2021/12/13 06:01:15 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2021/12/13 06:01:16 INFO : three.txt: Deleted 2021/12/13 06:01:16 INFO : three.txt: Moved into backup dir 2021/12/13 06:01:19 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/12/13 06:01:19 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:01:19 DEBUG : two: Unchanged skipping 2021/12/13 06:01:19 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for checks to finish 2021/12/13 06:01:22 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/12/13 06:01:22 INFO : one: Copied (server-side copy) to: one.bak 2021/12/13 06:01:22 INFO : one: Deleted 2021/12/13 06:01:22 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for transfers to finish 2021/12/13 06:01:23 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2021/12/13 06:01:23 INFO : one: Copied (new) 2021/12/13 06:01:23 DEBUG : Waiting for deletions to finish 2021/12/13 06:01:24 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2021/12/13 06:01:24 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2021/12/13 06:01:24 INFO : three.txt: Deleted 2021/12/13 06:01:24 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (23.97s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 06:01:30 DEBUG : Creating backend with remote "TestB2:rclone-test-yopedoj9vafihuc7rokesod7/dst" 2021/12/13 06:01:32 DEBUG : Couldn't decode error response: EOF 2021/12/13 06:01:32 DEBUG : Creating backend with remote "TestB2:rclone-test-yopedoj9vafihuc7rokesod7/backup" 2021/12/13 06:01:32 DEBUG : Couldn't decode error response: EOF 2021/12/13 06:01:32 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/12/13 06:01:32 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:01:32 DEBUG : two: Unchanged skipping 2021/12/13 06:01:32 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for checks to finish 2021/12/13 06:01:33 DEBUG : Couldn't decode error response: EOF 2021/12/13 06:01:34 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/12/13 06:01:34 INFO : one: Copied (server-side copy) to: one-2019-01-01 2021/12/13 06:01:35 INFO : one: Deleted 2021/12/13 06:01:35 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for transfers to finish 2021/12/13 06:01:36 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/12/13 06:01:36 INFO : one: Copied (new) 2021/12/13 06:01:36 DEBUG : Waiting for deletions to finish 2021/12/13 06:01:36 DEBUG : Couldn't decode error response: EOF 2021/12/13 06:01:37 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2021/12/13 06:01:37 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2021/12/13 06:01:37 INFO : three.txt: Deleted 2021/12/13 06:01:37 INFO : three.txt: Moved into backup dir 2021/12/13 06:01:39 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/12/13 06:01:39 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:01:39 DEBUG : two: Unchanged skipping 2021/12/13 06:01:39 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for checks to finish 2021/12/13 06:01:40 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/12/13 06:01:40 INFO : one: Copied (server-side copy) to: one-2019-01-01 2021/12/13 06:01:41 INFO : one: Deleted 2021/12/13 06:01:41 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for transfers to finish 2021/12/13 06:01:42 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2021/12/13 06:01:42 INFO : one: Copied (new) 2021/12/13 06:01:42 DEBUG : Waiting for deletions to finish 2021/12/13 06:01:42 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2021/12/13 06:01:42 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2021/12/13 06:01:43 INFO : three.txt: Deleted 2021/12/13 06:01:43 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (36.86s) === RUN TestSyncBackupDirSuffixOnly run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 06:02:07 DEBUG : Creating backend with remote "TestB2:rclone-test-yopedoj9vafihuc7rokesod7/dst" 2021/12/13 06:02:09 DEBUG : Couldn't decode error response: EOF 2021/12/13 06:02:09 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/12/13 06:02:09 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for checks to finish 2021/12/13 06:02:09 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:02:09 DEBUG : two: Unchanged skipping 2021/12/13 06:02:09 DEBUG : Couldn't decode error response: EOF 2021/12/13 06:02:10 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/12/13 06:02:10 INFO : one: Copied (server-side copy) to: one.bak 2021/12/13 06:02:11 INFO : one: Deleted 2021/12/13 06:02:11 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for transfers to finish 2021/12/13 06:02:12 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/12/13 06:02:12 INFO : one: Copied (new) 2021/12/13 06:02:12 DEBUG : Waiting for deletions to finish 2021/12/13 06:02:12 DEBUG : Couldn't decode error response: EOF 2021/12/13 06:02:19 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2021/12/13 06:02:19 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2021/12/13 06:02:20 INFO : three.txt: Deleted 2021/12/13 06:02:20 INFO : three.txt: Moved into backup dir 2021/12/13 06:02:21 DEBUG : one.bak: Excluded from sync (and deletion) 2021/12/13 06:02:21 DEBUG : three.txt.bak: Excluded from sync (and deletion) 2021/12/13 06:02:21 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/12/13 06:02:21 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for checks to finish 2021/12/13 06:02:21 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:02:21 DEBUG : two: Unchanged skipping 2021/12/13 06:02:22 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/12/13 06:02:22 INFO : one: Copied (server-side copy) to: one.bak 2021/12/13 06:02:27 INFO : one: Deleted 2021/12/13 06:02:27 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7 path dst: Waiting for transfers to finish 2021/12/13 06:02:28 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2021/12/13 06:02:28 INFO : one: Copied (new) 2021/12/13 06:02:28 DEBUG : Waiting for deletions to finish 2021/12/13 06:02:29 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2021/12/13 06:02:29 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2021/12/13 06:02:30 INFO : three.txt: Deleted 2021/12/13 06:02:30 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (30.71s) === RUN TestSyncSuffix run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 06:02:38 DEBUG : Creating backend with remote "TestB2:rclone-test-yopedoj9vafihuc7rokesod7/dst" 2021/12/13 06:02:39 DEBUG : Couldn't decode error response: EOF 2021/12/13 06:02:40 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/12/13 06:02:40 DEBUG : Couldn't decode error response: EOF 2021/12/13 06:02:42 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/12/13 06:02:42 INFO : one: Copied (server-side copy) to: one.bak 2021/12/13 06:02:42 INFO : one: Deleted 2021/12/13 06:02:43 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/12/13 06:02:43 INFO : one: Copied (new) 2021/12/13 06:02:44 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:02:44 DEBUG : two: Unchanged skipping 2021/12/13 06:02:44 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2021/12/13 06:02:44 DEBUG : Couldn't decode error response: EOF 2021/12/13 06:02:45 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2021/12/13 06:02:45 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2021/12/13 06:02:45 INFO : three.txt: Deleted 2021/12/13 06:02:46 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2021/12/13 06:02:46 INFO : three.txt: Copied (new) 2021/12/13 06:02:46 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/12/13 06:02:48 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/12/13 06:02:48 INFO : one: Copied (server-side copy) to: one.bak 2021/12/13 06:02:48 INFO : one: Deleted 2021/12/13 06:02:49 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2021/12/13 06:02:49 INFO : one: Copied (new) 2021/12/13 06:02:49 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:02:49 DEBUG : two: Unchanged skipping 2021/12/13 06:02:49 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2021/12/13 06:02:50 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2021/12/13 06:02:50 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2021/12/13 06:02:50 INFO : three.txt: Deleted 2021/12/13 06:02:51 DEBUG : three.txt: sha1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK 2021/12/13 06:02:51 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (22.52s) === RUN TestSyncSuffixKeepExtension run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 06:03:04 DEBUG : Creating backend with remote "TestB2:rclone-test-yopedoj9vafihuc7rokesod7/dst" 2021/12/13 06:03:05 DEBUG : Couldn't decode error response: EOF 2021/12/13 06:03:05 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/12/13 06:03:05 DEBUG : Couldn't decode error response: EOF 2021/12/13 06:03:12 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/12/13 06:03:12 INFO : one: Copied (server-side copy) to: one-2019-01-01 2021/12/13 06:03:12 INFO : one: Deleted 2021/12/13 06:03:13 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/12/13 06:03:13 INFO : one: Copied (new) 2021/12/13 06:03:14 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:03:14 DEBUG : two: Unchanged skipping 2021/12/13 06:03:14 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2021/12/13 06:03:14 DEBUG : Couldn't decode error response: EOF 2021/12/13 06:03:16 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2021/12/13 06:03:16 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2021/12/13 06:03:16 INFO : three.txt: Deleted 2021/12/13 06:03:16 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2021/12/13 06:03:16 INFO : three.txt: Copied (new) 2021/12/13 06:03:17 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/12/13 06:03:18 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/12/13 06:03:18 INFO : one: Copied (server-side copy) to: one-2019-01-01 2021/12/13 06:03:21 INFO : one: Deleted 2021/12/13 06:03:21 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2021/12/13 06:03:21 INFO : one: Copied (new) 2021/12/13 06:03:21 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:03:21 DEBUG : two: Unchanged skipping 2021/12/13 06:03:21 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2021/12/13 06:03:22 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2021/12/13 06:03:22 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2021/12/13 06:03:23 INFO : three.txt: Deleted 2021/12/13 06:03:23 DEBUG : three.txt: sha1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK 2021/12/13 06:03:23 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (29.27s) === RUN TestSyncUTFNorm run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 06:03:28 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 06:03:28 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2021/12/13 06:03:28 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 06:03:29 DEBUG : Testêé: sha1 = a54d88e06612d820bc3be72877c74f257b561b19 OK 2021/12/13 06:03:29 INFO : Testêé: Copied (replaced existing) to: Testêé 2021/12/13 06:03:29 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (3.16s) === RUN TestSyncImmutable run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 06:03:30 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 06:03:30 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 06:03:30 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2021/12/13 06:03:30 INFO : existing: Copied (new) 2021/12/13 06:03:30 DEBUG : Waiting for deletions to finish 2021/12/13 06:03:31 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2021/12/13 06:03:31 ERROR : existing: Source and destination exist but do not match: immutable file modified 2021/12/13 06:03:31 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 06:03:31 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 06:03:31 ERROR : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: not deleting files as there were IO errors 2021/12/13 06:03:31 ERROR : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: not deleting directories as there were IO errors --- PASS: TestSyncImmutable (2.10s) === RUN TestSyncIgnoreCase run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 06:03:33 DEBUG : existing: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:03:33 DEBUG : existing: Unchanged skipping 2021/12/13 06:03:33 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 06:03:33 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 06:03:33 DEBUG : Waiting for deletions to finish 2021/12/13 06:03:33 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (2.43s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" sync_test.go:1989: This test only runs on local === RUN TestMaxTransfer/Soft run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" sync_test.go:1989: This test only runs on local === RUN TestMaxTransfer/Cautious run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", 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-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 06:03:35 DEBUG : both0: Clearing upload URL because of error: Post "https://pod-000-1146-09.backblaze.com/b2api/v1/b2_upload_file/1ff29d8350cdbb2b7fd80e1b/c001_v0001146_t0033": EOF 2021/12/13 06:03:35 DEBUG : pacer: low level retry 1/1 (error Post "https://pod-000-1146-09.backblaze.com/b2api/v1/b2_upload_file/1ff29d8350cdbb2b7fd80e1b/c001_v0001146_t0033": EOF) 2021/12/13 06:03:35 DEBUG : pacer: Rate limited, increasing sleep to 20ms run.go:283: Retry Put of "both0" to B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: 1/10 (Post "https://pod-000-1146-09.backblaze.com/b2api/v1/b2_upload_file/1ff29d8350cdbb2b7fd80e1b/c001_v0001146_t0033": EOF) 2021/12/13 06:03:38 DEBUG : pacer: Reducing sleep to 10ms 2021/12/13 06:04:19 DEBUG : both0: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:04:19 DEBUG : both0: Unchanged skipping 2021/12/13 06:04:19 DEBUG : both1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:04:19 DEBUG : both1: Unchanged skipping 2021/12/13 06:04:19 DEBUG : both10: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:04:19 DEBUG : both10: Unchanged skipping 2021/12/13 06:04:19 DEBUG : both11: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:04:19 DEBUG : both11: Unchanged skipping 2021/12/13 06:04:19 DEBUG : both12: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:04:19 DEBUG : both12: Unchanged skipping 2021/12/13 06:04:19 DEBUG : both13: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:04:19 DEBUG : both13: Unchanged skipping 2021/12/13 06:04:19 DEBUG : both14: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:04:19 DEBUG : both14: Unchanged skipping 2021/12/13 06:04:19 DEBUG : both15: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:04:19 DEBUG : both15: Unchanged skipping 2021/12/13 06:04:19 DEBUG : both16: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:04:19 DEBUG : both16: Unchanged skipping 2021/12/13 06:04:19 DEBUG : both17: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:04:19 DEBUG : both17: Unchanged skipping 2021/12/13 06:04:19 DEBUG : both18: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:04:19 DEBUG : both18: Unchanged skipping 2021/12/13 06:04:19 DEBUG : both19: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:04:19 DEBUG : both19: Unchanged skipping 2021/12/13 06:04:19 DEBUG : both2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:04:19 DEBUG : both2: Unchanged skipping 2021/12/13 06:04:19 DEBUG : both3: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:04:19 DEBUG : both3: Unchanged skipping 2021/12/13 06:04:19 DEBUG : both4: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:04:19 DEBUG : both4: Unchanged skipping 2021/12/13 06:04:19 DEBUG : both5: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:04:19 DEBUG : both5: Unchanged skipping 2021/12/13 06:04:19 DEBUG : both6: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:04:19 DEBUG : both6: Unchanged skipping 2021/12/13 06:04:19 DEBUG : both7: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:04:19 DEBUG : both7: Unchanged skipping 2021/12/13 06:04:19 DEBUG : both8: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:04:19 DEBUG : both8: Unchanged skipping 2021/12/13 06:04:19 DEBUG : both9: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:04:19 DEBUG : both9: Unchanged skipping 2021/12/13 06:04:19 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 06:04:19 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 06:04:19 DEBUG : Waiting for deletions to finish 2021/12/13 06:04:19 INFO : only11: Deleted 2021/12/13 06:04:19 INFO : only13: Deleted 2021/12/13 06:04:20 INFO : only6: Deleted 2021/12/13 06:04:20 INFO : only3: Deleted 2021/12/13 06:04:20 INFO : only0: Deleted 2021/12/13 06:04:20 INFO : only17: Deleted 2021/12/13 06:04:20 INFO : only19: Deleted 2021/12/13 06:04:20 INFO : only8: Deleted 2021/12/13 06:04:21 INFO : only18: Deleted 2021/12/13 06:04:21 INFO : only4: Deleted 2021/12/13 06:04:21 INFO : only1: Deleted 2021/12/13 06:04:22 INFO : only5: Deleted 2021/12/13 06:04:22 INFO : only7: Deleted 2021/12/13 06:04:22 INFO : only14: Deleted 2021/12/13 06:04:22 INFO : only15: Deleted 2021/12/13 06:04:22 INFO : only12: Deleted 2021/12/13 06:04:23 INFO : only16: Deleted 2021/12/13 06:04:23 INFO : only9: Deleted 2021/12/13 06:04:24 INFO : only10: Deleted 2021/12/13 06:04:27 INFO : only2: Deleted 2021/12/13 06:04:27 INFO : There was nothing to transfer --- PASS: TestSyncConcurrentDelete (85.83s) === RUN TestSyncConcurrentTruncate run.go:181: Remote "B2 bucket rclone-test-yopedoj9vafihuc7rokesod7", Local "Local file system at /tmp/rclone940314831", Modify Window "1ms" 2021/12/13 06:05:38 DEBUG : both1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:05:38 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for checks to finish 2021/12/13 06:05:38 DEBUG : both11: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:05:38 DEBUG : both11: Unchanged skipping 2021/12/13 06:05:38 DEBUG : both12: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:05:38 DEBUG : both12: Unchanged skipping 2021/12/13 06:05:38 DEBUG : both13: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:05:38 DEBUG : both13: Unchanged skipping 2021/12/13 06:05:38 DEBUG : both14: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:05:38 DEBUG : both14: Unchanged skipping 2021/12/13 06:05:38 DEBUG : both15: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:05:38 DEBUG : both15: Unchanged skipping 2021/12/13 06:05:38 DEBUG : both16: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:05:38 DEBUG : both16: Unchanged skipping 2021/12/13 06:05:38 DEBUG : both17: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:05:38 DEBUG : both17: Unchanged skipping 2021/12/13 06:05:38 DEBUG : both18: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:05:38 DEBUG : both18: Unchanged skipping 2021/12/13 06:05:38 DEBUG : both19: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:05:38 DEBUG : both19: Unchanged skipping 2021/12/13 06:05:38 DEBUG : both2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:05:38 DEBUG : both2: Unchanged skipping 2021/12/13 06:05:38 DEBUG : both0: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:05:38 DEBUG : both3: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:05:38 DEBUG : both3: Unchanged skipping 2021/12/13 06:05:38 DEBUG : both4: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:05:38 DEBUG : both4: Unchanged skipping 2021/12/13 06:05:38 DEBUG : both5: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:05:38 DEBUG : both5: Unchanged skipping 2021/12/13 06:05:38 DEBUG : both6: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:05:38 DEBUG : both6: Unchanged skipping 2021/12/13 06:05:38 DEBUG : both7: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:05:38 DEBUG : both7: Unchanged skipping 2021/12/13 06:05:38 DEBUG : both8: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:05:38 DEBUG : both8: Unchanged skipping 2021/12/13 06:05:38 DEBUG : both9: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:05:38 DEBUG : both9: Unchanged skipping 2021/12/13 06:05:38 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2021/12/13 06:05:38 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2021/12/13 06:05:38 DEBUG : both0: Unchanged skipping 2021/12/13 06:05:38 DEBUG : both1: Unchanged skipping 2021/12/13 06:05:38 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2021/12/13 06:05:38 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2021/12/13 06:05:38 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2021/12/13 06:05:38 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2021/12/13 06:05:38 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2021/12/13 06:05:38 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2021/12/13 06:05:38 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2021/12/13 06:05:38 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2021/12/13 06:05:38 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2021/12/13 06:05:38 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2021/12/13 06:05:38 DEBUG : both10: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/12/13 06:05:38 DEBUG : both10: Unchanged skipping 2021/12/13 06:05:38 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2021/12/13 06:05:38 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2021/12/13 06:05:38 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2021/12/13 06:05:38 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2021/12/13 06:05:38 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2021/12/13 06:05:38 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2021/12/13 06:05:38 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2021/12/13 06:05:38 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2021/12/13 06:05:38 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Waiting for transfers to finish 2021/12/13 06:05:39 DEBUG : only0: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/13 06:05:39 INFO : only0: Copied (replaced existing) 2021/12/13 06:05:40 DEBUG : only1: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/13 06:05:40 INFO : only1: Copied (replaced existing) 2021/12/13 06:05:40 DEBUG : only13: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/13 06:05:40 INFO : only13: Copied (replaced existing) 2021/12/13 06:05:40 DEBUG : only12: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/13 06:05:40 INFO : only12: Copied (replaced existing) 2021/12/13 06:05:41 DEBUG : only15: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/13 06:05:41 INFO : only15: Copied (replaced existing) 2021/12/13 06:05:41 DEBUG : only16: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/13 06:05:41 INFO : only16: Copied (replaced existing) 2021/12/13 06:05:41 DEBUG : only14: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/13 06:05:41 INFO : only14: Copied (replaced existing) 2021/12/13 06:05:41 DEBUG : only17: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/13 06:05:41 INFO : only17: Copied (replaced existing) 2021/12/13 06:05:42 DEBUG : only19: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/13 06:05:42 INFO : only19: Copied (replaced existing) 2021/12/13 06:05:42 DEBUG : only11: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/13 06:05:42 INFO : only11: Copied (replaced existing) 2021/12/13 06:05:42 DEBUG : only2: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/13 06:05:42 INFO : only2: Copied (replaced existing) 2021/12/13 06:05:42 DEBUG : only3: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/13 06:05:42 INFO : only3: Copied (replaced existing) 2021/12/13 06:05:43 DEBUG : only10: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/13 06:05:43 INFO : only10: Copied (replaced existing) 2021/12/13 06:05:43 DEBUG : only5: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/13 06:05:43 INFO : only5: Copied (replaced existing) 2021/12/13 06:05:43 DEBUG : only7: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/13 06:05:43 INFO : only7: Copied (replaced existing) 2021/12/13 06:05:43 DEBUG : only4: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/13 06:05:43 INFO : only4: Copied (replaced existing) 2021/12/13 06:05:44 DEBUG : only18: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/13 06:05:44 INFO : only18: Copied (replaced existing) 2021/12/13 06:05:44 DEBUG : only8: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/13 06:05:44 INFO : only8: Copied (replaced existing) 2021/12/13 06:05:44 DEBUG : only9: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/13 06:05:44 INFO : only9: Copied (replaced existing) 2021/12/13 06:05:44 DEBUG : only6: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/12/13 06:05:44 INFO : only6: Copied (replaced existing) 2021/12/13 06:05:44 DEBUG : Waiting for deletions to finish --- PASS: TestSyncConcurrentTruncate (82.02s) PASS 2021/12/13 06:06:23 DEBUG : B2 bucket rclone-test-yopedoj9vafihuc7rokesod7: Purge remote 2021/12/13 06:06:24 DEBUG : BackupDir/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f114bb24fa18fe4e8_d20211213_m060009_c001_v0001097_t0016") 2021/12/13 06:06:24 DEBUG : BackupDir/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1031ee3ab099747d_d20211213_m055958_c001_v0001033_t0042") 2021/12/13 06:06:24 DEBUG : CompareDest/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1160c7f075d1ed52_d20211213_m055934_c001_v0001038_t0057") 2021/12/13 06:06:24 DEBUG : CompareDest/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd2568c_d20211213_m055928_c001_v0001146_t0043") 2021/12/13 06:06:24 DEBUG : CompareDest/two: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1009b9e9c9317ddd_d20211213_m055935_c001_v0001042_t0004") 2021/12/13 06:06:24 DEBUG : CompareDest/two: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d207e_d20211213_m055929_c001_v0001097_t0011") 2021/12/13 06:06:24 DEBUG : CopyDest/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f106018fa4cfd5db7_d20211213_m060010_c001_v0001145_t0043") 2021/12/13 06:06:24 DEBUG : CopyDest/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d212b_d20211213_m055954_c001_v0001097_t0004") 2021/12/13 06:06:24 DEBUG : CopyDest/three: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1065308ecddd5ca3_d20211213_m060011_c001_v0001161_t0026") 2021/12/13 06:06:24 DEBUG : CopyDest/three: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2180_d20211213_m060006_c001_v0001097_t0029") 2021/12/13 06:06:24 DEBUG : CopyDest/two: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f110b48d9887131ad_d20211213_m060011_c001_v0001038_t0011") 2021/12/13 06:06:24 DEBUG : CopyDest/two: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd256b4_d20211213_m060002_c001_v0001146_t0042") 2021/12/13 06:06:24 DEBUG : EXISTING: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f102035789fd3d3f6_d20211213_m060334_c001_v0001150_t0023") 2021/12/13 06:06:24 DEBUG : EXISTING: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2aa3_d20211213_m060332_c001_v0001097_t0035") 2021/12/13 06:06:24 DEBUG : Testêé: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1089c7a3d4fce06b_d20211213_m060329_c001_v0001157_t0013") 2021/12/13 06:06:24 DEBUG : Testêé: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2a85_d20211213_m060328_c001_v0001097_t0018") 2021/12/13 06:06:25 DEBUG : Testêé: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd258d5_d20211213_m060327_c001_v0001146_t0024") 2021/12/13 06:06:25 DEBUG : a/potato2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1157c4ab0286ab4b_d20211213_m055708_c001_v0001097_t0058") 2021/12/13 06:06:25 DEBUG : a/potato2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd2555b_d20211213_m055707_c001_v0001146_t0042") 2021/12/13 06:06:25 DEBUG : a/potato2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f105a60f53f9aab94_d20211213_m055703_c001_v0001005_t0027") 2021/12/13 06:06:25 DEBUG : a/potato2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25544_d20211213_m055701_c001_v0001146_t0003") 2021/12/13 06:06:25 DEBUG : a/potato2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f114bb24fa18fdc41_d20211213_m055635_c001_v0001097_t0039") 2021/12/13 06:06:25 DEBUG : a/potato2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd254da_d20211213_m055634_c001_v0001146_t0014") 2021/12/13 06:06:25 DEBUG : b/potato: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f111c94f5b96d375c_d20211213_m055715_c001_v0001097_t0008") 2021/12/13 06:06:25 DEBUG : b/potato: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25553_d20211213_m055705_c001_v0001146_t0055") 2021/12/13 06:06:25 DEBUG : b/potato: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1198f2cfaae6588d_d20211213_m055701_c001_v0001145_t0039") 2021/12/13 06:06:25 DEBUG : b/potato: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd2553d_d20211213_m055700_c001_v0001146_t0000") 2021/12/13 06:06:25 DEBUG : b/potato: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1185e9f37854f76b_d20211213_m055634_c001_v0001117_t0003") 2021/12/13 06:06:25 DEBUG : b/potato: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd254d2_d20211213_m055633_c001_v0001146_t0006") 2021/12/13 06:06:25 DEBUG : backup/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1091d22398523a3d_d20211213_m060032_c001_v0001130_t0045") 2021/12/13 06:06:25 DEBUG : backup/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f114e005284d26706_d20211213_m060026_c001_v0001144_t0028") 2021/12/13 06:06:25 DEBUG : backup/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1052d3a2d00f792f_d20211213_m060021_c001_v0001154_t0011") 2021/12/13 06:06:25 DEBUG : backup/one-2019-01-01: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f103f47d6c3503431_d20211213_m060144_c001_v0001097_t0017") 2021/12/13 06:06:25 DEBUG : backup/one-2019-01-01: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f106658780f9b046e_d20211213_m060139_c001_v0001042_t0034") 2021/12/13 06:06:25 DEBUG : backup/one-2019-01-01: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1185e9f378550231_d20211213_m060134_c001_v0001117_t0003") 2021/12/13 06:06:25 DEBUG : backup/one.bak: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f103e6024dc377500_d20211213_m060125_c001_v0001134_t0024") 2021/12/13 06:06:25 DEBUG : backup/one.bak: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f111edf9c687cf192_d20211213_m060119_c001_v0001026_t0018") 2021/12/13 06:06:25 DEBUG : backup/one.bak: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10943515789e3e22_d20211213_m060111_c001_v0001011_t0012") 2021/12/13 06:06:25 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f112142dae29e4846_d20211213_m060144_c001_v0001033_t0049") 2021/12/13 06:06:26 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1026d22be3b74c29_d20211213_m060142_c001_v0001144_t0010") 2021/12/13 06:06:26 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1108c6ea87dfd72b_d20211213_m060136_c001_v0001018_t0018") 2021/12/13 06:06:26 DEBUG : backup/three.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1130c4e9e7bae227_d20211213_m060102_c001_v0001093_t0024") 2021/12/13 06:06:26 DEBUG : backup/three.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1008eed7eab9f0af_d20211213_m060029_c001_v0001039_t0031") 2021/12/13 06:06:26 DEBUG : backup/three.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1111a37102a216e8_d20211213_m060023_c001_v0001033_t0052") 2021/12/13 06:06:26 DEBUG : backup/three.txt.bak: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f105e3e7dc410923f_d20211213_m060125_c001_v0001032_t0045") 2021/12/13 06:06:26 DEBUG : backup/three.txt.bak: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1061d74d2332b877_d20211213_m060123_c001_v0001120_t0053") 2021/12/13 06:06:26 DEBUG : backup/three.txt.bak: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1026d22be3b74b79_d20211213_m060114_c001_v0001144_t0026") 2021/12/13 06:06:26 DEBUG : both0: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1158d1c1f88a6a66_d20211213_m060545_c001_v0001144_t0006") 2021/12/13 06:06:26 DEBUG : both0: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2e74_d20211213_m060502_c001_v0001097_t0000") 2021/12/13 06:06:26 DEBUG : both0: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f101407f1e976b1c0_d20211213_m060428_c001_v0001131_t0032") 2021/12/13 06:06:26 DEBUG : both0: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2ad9_d20211213_m060337_c001_v0001097_t0031") 2021/12/13 06:06:26 DEBUG : both1: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d310f_d20211213_m060546_c001_v0001097_t0049") 2021/12/13 06:06:26 DEBUG : both1: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2e8f_d20211213_m060505_c001_v0001097_t0019") 2021/12/13 06:06:26 DEBUG : both1: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1158d1c1f88a687a_d20211213_m060428_c001_v0001144_t0037") 2021/12/13 06:06:26 DEBUG : both1: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2af4_d20211213_m060339_c001_v0001097_t0046") 2021/12/13 06:06:26 DEBUG : both10: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f11691140b11fc8e9_d20211213_m060547_c001_v0001036_t0049") 2021/12/13 06:06:27 DEBUG : both10: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2f7f_d20211213_m060520_c001_v0001097_t0042") 2021/12/13 06:06:27 DEBUG : both10: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f113ede6e422837b5_d20211213_m060429_c001_v0001097_t0028") 2021/12/13 06:06:27 DEBUG : both10: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2bc4_d20211213_m060357_c001_v0001097_t0021") 2021/12/13 06:06:27 DEBUG : both11: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1118ffb30e2392e9_d20211213_m060547_c001_v0001032_t0018") 2021/12/13 06:06:27 DEBUG : both11: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2fa0_d20211213_m060522_c001_v0001097_t0027") 2021/12/13 06:06:27 DEBUG : both11: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f113461e53aace2f5_d20211213_m060430_c001_v0001131_t0017") 2021/12/13 06:06:27 DEBUG : both11: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2bd4_d20211213_m060400_c001_v0001097_t0013") 2021/12/13 06:06:27 DEBUG : both12: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f104de105fe0c2bca_d20211213_m060549_c001_v0001033_t0005") 2021/12/13 06:06:27 DEBUG : both12: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2fae_d20211213_m060523_c001_v0001097_t0018") 2021/12/13 06:06:27 DEBUG : both12: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f118e218fffdb326c_d20211213_m060431_c001_v0001145_t0002") 2021/12/13 06:06:27 DEBUG : both12: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2be9_d20211213_m060402_c001_v0001097_t0008") 2021/12/13 06:06:27 DEBUG : both13: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f119a9c408c80e495_d20211213_m060550_c001_v0001033_t0004") 2021/12/13 06:06:27 DEBUG : both13: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2fcf_d20211213_m060525_c001_v0001097_t0051") 2021/12/13 06:06:27 DEBUG : both13: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f113ede6e422837c4_d20211213_m060431_c001_v0001097_t0023") 2021/12/13 06:06:27 DEBUG : both13: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2bf7_d20211213_m060404_c001_v0001097_t0052") 2021/12/13 06:06:27 DEBUG : both14: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f111a93f60920c85d_d20211213_m060553_c001_v0001017_t0005") 2021/12/13 06:06:27 DEBUG : both14: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2fe9_d20211213_m060526_c001_v0001097_t0007") 2021/12/13 06:06:27 DEBUG : both14: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1020dc2ae26ff411_d20211213_m060432_c001_v0001026_t0027") 2021/12/13 06:06:27 DEBUG : both14: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2c2a_d20211213_m060408_c001_v0001097_t0053") 2021/12/13 06:06:27 DEBUG : both15: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f107dca03cee1ec3e_d20211213_m060555_c001_v0001021_t0044") 2021/12/13 06:06:27 DEBUG : both15: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d3004_d20211213_m060528_c001_v0001097_t0015") 2021/12/13 06:06:27 DEBUG : both15: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f102be8ad4b47fe1c_d20211213_m060432_c001_v0001038_t0012") 2021/12/13 06:06:27 DEBUG : both15: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2c46_d20211213_m060411_c001_v0001097_t0014") 2021/12/13 06:06:27 DEBUG : both16: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d3195_d20211213_m060556_c001_v0001097_t0008") 2021/12/13 06:06:28 DEBUG : both16: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d3022_d20211213_m060530_c001_v0001097_t0003") 2021/12/13 06:06:28 DEBUG : both16: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f118dc6f124aac2b3_d20211213_m060434_c001_v0001003_t0016") 2021/12/13 06:06:28 DEBUG : both16: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2c4d_d20211213_m060412_c001_v0001097_t0043") 2021/12/13 06:06:28 DEBUG : both17: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f114bd582664fd0ad_d20211213_m060556_c001_v0001090_t0022") 2021/12/13 06:06:28 DEBUG : both17: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d3053_d20211213_m060533_c001_v0001097_t0043") 2021/12/13 06:06:28 DEBUG : both17: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f11069217b5b9c2c7_d20211213_m060434_c001_v0001000_t0025") 2021/12/13 06:06:28 DEBUG : both17: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2c6c_d20211213_m060413_c001_v0001097_t0045") 2021/12/13 06:06:28 DEBUG : both18: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d319d_d20211213_m060556_c001_v0001097_t0039") 2021/12/13 06:06:28 DEBUG : both18: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d306a_d20211213_m060534_c001_v0001097_t0028") 2021/12/13 06:06:28 DEBUG : both18: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f104823ad38ebb8f7_d20211213_m060435_c001_v0001137_t0008") 2021/12/13 06:06:28 DEBUG : both18: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2c74_d20211213_m060414_c001_v0001097_t0006") 2021/12/13 06:06:28 DEBUG : both19: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1127b99bb431271d_d20211213_m060557_c001_v0001120_t0040") 2021/12/13 06:06:28 DEBUG : both19: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d3089_d20211213_m060536_c001_v0001097_t0031") 2021/12/13 06:06:28 DEBUG : both19: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1025f1bfaec6bd17_d20211213_m060436_c001_v0001097_t0007") 2021/12/13 06:06:28 DEBUG : both19: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2c93_d20211213_m060417_c001_v0001097_t0045") 2021/12/13 06:06:28 DEBUG : both2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1112093d58540326_d20211213_m060558_c001_v0001011_t0037") 2021/12/13 06:06:28 DEBUG : both2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2eb1_d20211213_m060506_c001_v0001097_t0028") 2021/12/13 06:06:28 DEBUG : both2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1053e0eace85c9e2_d20211213_m060436_c001_v0001134_t0001") 2021/12/13 06:06:28 DEBUG : both2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2b1c_d20211213_m060342_c001_v0001097_t0026") 2021/12/13 06:06:29 DEBUG : both3: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f107b17cefe77c216_d20211213_m060558_c001_v0001040_t0040") 2021/12/13 06:06:29 DEBUG : both3: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2ed2_d20211213_m060509_c001_v0001097_t0017") 2021/12/13 06:06:29 DEBUG : both3: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f118ab3a97453e2e8_d20211213_m060437_c001_v0001038_t0056") 2021/12/13 06:06:29 DEBUG : both3: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2b26_d20211213_m060343_c001_v0001097_t0033") 2021/12/13 06:06:29 DEBUG : both4: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f11952a588da48e2b_d20211213_m060559_c001_v0001093_t0036") 2021/12/13 06:06:29 DEBUG : both4: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2eec_d20211213_m060510_c001_v0001097_t0004") 2021/12/13 06:06:29 DEBUG : both4: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f102cd5318be6602d_d20211213_m060438_c001_v0001117_t0028") 2021/12/13 06:06:29 DEBUG : both4: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2b30_d20211213_m060344_c001_v0001097_t0018") 2021/12/13 06:06:29 DEBUG : both5: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f102f78b21778e823_d20211213_m060559_c001_v0001043_t0043") 2021/12/13 06:06:29 DEBUG : both5: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2f11_d20211213_m060513_c001_v0001097_t0011") 2021/12/13 06:06:29 DEBUG : both5: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f119415bee4316d7e_d20211213_m060439_c001_v0001018_t0022") 2021/12/13 06:06:29 DEBUG : both5: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2b64_d20211213_m060347_c001_v0001097_t0040") 2021/12/13 06:06:29 DEBUG : both6: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f110b48d98871343a_d20211213_m060600_c001_v0001038_t0046") 2021/12/13 06:06:29 DEBUG : both6: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2f28_d20211213_m060515_c001_v0001097_t0024") 2021/12/13 06:06:29 DEBUG : both6: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f100d7ba0819a8460_d20211213_m060439_c001_v0001033_t0027") 2021/12/13 06:06:29 DEBUG : both6: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2b74_d20211213_m060349_c001_v0001097_t0005") 2021/12/13 06:06:29 DEBUG : both7: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f117744c7ac573955_d20211213_m060603_c001_v0001117_t0014") 2021/12/13 06:06:29 DEBUG : both7: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2f32_d20211213_m060516_c001_v0001097_t0027") 2021/12/13 06:06:29 DEBUG : both7: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1039062a08daefb9_d20211213_m060459_c001_v0001145_t0028") 2021/12/13 06:06:29 DEBUG : both7: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2b8a_d20211213_m060351_c001_v0001097_t0031") 2021/12/13 06:06:30 DEBUG : both8: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10171925db04c531_d20211213_m060605_c001_v0001136_t0025") 2021/12/13 06:06:30 DEBUG : both8: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2f3e_d20211213_m060517_c001_v0001097_t0036") 2021/12/13 06:06:30 DEBUG : both8: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f107ba46b906a2bd0_d20211213_m060459_c001_v0001036_t0010") 2021/12/13 06:06:30 DEBUG : both8: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2ba7_d20211213_m060354_c001_v0001097_t0046") 2021/12/13 06:06:30 DEBUG : both9: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f11409ebd4d7c4971_d20211213_m060606_c001_v0001117_t0038") 2021/12/13 06:06:30 DEBUG : both9: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2f5e_d20211213_m060518_c001_v0001097_t0029") 2021/12/13 06:06:30 DEBUG : both9: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10226575b2a8d090_d20211213_m060500_c001_v0001145_t0020") 2021/12/13 06:06:30 DEBUG : both9: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2bb0_d20211213_m060355_c001_v0001097_t0014") 2021/12/13 06:06:30 DEBUG : c/non empty space: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f109723f23e93e3ce_d20211213_m055717_c001_v0001000_t0021") 2021/12/13 06:06:30 DEBUG : c/non empty space: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25555_d20211213_m055705_c001_v0001146_t0015") 2021/12/13 06:06:30 DEBUG : c/non empty space: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1103242f9545ee7d_d20211213_m055703_c001_v0001097_t0022") 2021/12/13 06:06:30 DEBUG : c/non empty space: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25540_d20211213_m055700_c001_v0001146_t0046") 2021/12/13 06:06:30 DEBUG : c/non empty space: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f106fbc39333c2d89_d20211213_m055636_c001_v0001037_t0019") 2021/12/13 06:06:30 DEBUG : c/non empty space: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd254d4_d20211213_m055633_c001_v0001146_t0056") 2021/12/13 06:06:30 DEBUG : check sum: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1081be1f682cc3bb_d20211213_m055623_c001_v0001097_t0034") 2021/12/13 06:06:30 DEBUG : check sum: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd254aa_d20211213_m055622_c001_v0001146_t0004") 2021/12/13 06:06:30 DEBUG : dest/3: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1191ec8d74739c01_d20211213_m055947_c001_v0001146_t0017") 2021/12/13 06:06:30 DEBUG : dest/3: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f102cd5318be65426_d20211213_m055946_c001_v0001117_t0022") 2021/12/13 06:06:30 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f106018fa4cfd5f91_d20211213_m060324_c001_v0001145_t0028") 2021/12/13 06:06:30 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f110dd839e3594b21_d20211213_m060321_c001_v0001165_t0035") 2021/12/13 06:06:30 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1086584c2902dc00_d20211213_m060318_c001_v0001113_t0018") 2021/12/13 06:06:30 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f110dd839e3594b08_d20211213_m060313_c001_v0001165_t0031") 2021/12/13 06:06:31 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1074c7af93a67680_d20211213_m060312_c001_v0001117_t0046") 2021/12/13 06:06:31 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2922_d20211213_m060258_c001_v0001097_t0040") 2021/12/13 06:06:31 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f111f5098022a54c8_d20211213_m060254_c001_v0001120_t0007") 2021/12/13 06:06:31 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f109e44dd07eca7bd_d20211213_m060249_c001_v0001036_t0035") 2021/12/13 06:06:31 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f117446c51fc5a0f0_d20211213_m060248_c001_v0001144_t0000") 2021/12/13 06:06:31 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f109e44dd07eca7ac_d20211213_m060243_c001_v0001036_t0051") 2021/12/13 06:06:31 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f103e6024dc37756b_d20211213_m060242_c001_v0001134_t0018") 2021/12/13 06:06:31 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd2585d_d20211213_m060235_c001_v0001146_t0055") 2021/12/13 06:06:31 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f103f47d6c3503634_d20211213_m060230_c001_v0001097_t0044") 2021/12/13 06:06:31 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f117560b935062c0c_d20211213_m060228_c001_v0001120_t0034") 2021/12/13 06:06:31 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1007ff49a55571ca_d20211213_m060223_c001_v0001144_t0040") 2021/12/13 06:06:31 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f117560b935062bd6_d20211213_m060212_c001_v0001120_t0044") 2021/12/13 06:06:31 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f100cf0f5376b3b47_d20211213_m060210_c001_v0001097_t0032") 2021/12/13 06:06:31 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd257da_d20211213_m060205_c001_v0001146_t0037") 2021/12/13 06:06:31 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f119415bee4316d2e_d20211213_m060202_c001_v0001018_t0038") 2021/12/13 06:06:31 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f102e4385536bc45f_d20211213_m060141_c001_v0001039_t0013") 2021/12/13 06:06:31 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f105af04f132682f0_d20211213_m060140_c001_v0001144_t0056") 2021/12/13 06:06:31 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f102e4385536bc441_d20211213_m060136_c001_v0001039_t0034") 2021/12/13 06:06:31 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10514e72d88de977_d20211213_m060134_c001_v0001120_t0054") 2021/12/13 06:06:31 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd2573e_d20211213_m060128_c001_v0001146_t0001") 2021/12/13 06:06:31 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f113b7fc136660c4a_d20211213_m060125_c001_v0001032_t0030") 2021/12/13 06:06:31 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f108859f5509ca420_d20211213_m060123_c001_v0001150_t0045") 2021/12/13 06:06:32 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1095fddf8704595c_d20211213_m060122_c001_v0001041_t0016") 2021/12/13 06:06:32 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f108859f5509ca3de_d20211213_m060114_c001_v0001150_t0054") 2021/12/13 06:06:32 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f106bd56c379f9922_d20211213_m060112_c001_v0001117_t0056") 2021/12/13 06:06:32 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25715_d20211213_m060104_c001_v0001146_t0011") 2021/12/13 06:06:32 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f11489da21bfae9d1_d20211213_m060102_c001_v0001091_t0056") 2021/12/13 06:06:32 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f116af01020daee8a_d20211213_m060029_c001_v0001113_t0020") 2021/12/13 06:06:32 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f114bb24fa18fe5d7_d20211213_m060028_c001_v0001097_t0039") 2021/12/13 06:06:32 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f116af01020daee82_d20211213_m060022_c001_v0001113_t0055") 2021/12/13 06:06:32 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1185e9f37854ff46_d20211213_m060021_c001_v0001117_t0023") 2021/12/13 06:06:32 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd256d0_d20211213_m060015_c001_v0001146_t0045") 2021/12/13 06:06:32 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f112e2c12ee826523_d20211213_m060013_c001_v0001092_t0033") 2021/12/13 06:06:32 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f11558c1747543e12_d20211213_m060002_c001_v0001161_t0056") 2021/12/13 06:06:32 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10422b1cd6a9c2c1_d20211213_m060000_c001_v0001117_t0039") 2021/12/13 06:06:32 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd256ac_d20211213_m055954_c001_v0001146_t0031") 2021/12/13 06:06:32 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f107786f0d387ab82_d20211213_m055952_c001_v0001136_t0048") 2021/12/13 06:06:32 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f107786f0d387ab80_d20211213_m055951_c001_v0001136_t0013") 2021/12/13 06:06:32 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10358b3d99396a08_d20211213_m055936_c001_v0001113_t0024") 2021/12/13 06:06:32 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d206a_d20211213_m055927_c001_v0001097_t0059") 2021/12/13 06:06:32 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f106977938d43a84d_d20211213_m055926_c001_v0001150_t0001") 2021/12/13 06:06:32 DEBUG : dst/one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f106977938d43a84b_d20211213_m055925_c001_v0001150_t0013") 2021/12/13 06:06:32 DEBUG : dst/one-2019-01-01: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1119947a434a4eaa_d20211213_m060324_c001_v0001161_t0000") 2021/12/13 06:06:33 DEBUG : dst/one-2019-01-01: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1068a76792780bd3_d20211213_m060317_c001_v0001039_t0059") 2021/12/13 06:06:33 DEBUG : dst/one-2019-01-01: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f101b14291162636a_d20211213_m060307_c001_v0001037_t0048") 2021/12/13 06:06:33 DEBUG : dst/one.bak: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f115a1cdf7e047a6c_d20211213_m060256_c001_v0001146_t0059") 2021/12/13 06:06:33 DEBUG : dst/one.bak: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f105da58a1f3ed1ab_d20211213_m060247_c001_v0001117_t0032") 2021/12/13 06:06:33 DEBUG : dst/one.bak: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2848_d20211213_m060241_c001_v0001097_t0036") 2021/12/13 06:06:33 DEBUG : dst/one.bak: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f111bbfa2affd7e20_d20211213_m060232_c001_v0001092_t0049") 2021/12/13 06:06:33 DEBUG : dst/one.bak: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1058bbd1314aae3a_d20211213_m060222_c001_v0001025_t0005") 2021/12/13 06:06:33 DEBUG : dst/one.bak: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f118a359fb7e8d3a7_d20211213_m060209_c001_v0001097_t0045") 2021/12/13 06:06:33 DEBUG : dst/three: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1025f1bfaec6b221_d20211213_m060013_c001_v0001097_t0025") 2021/12/13 06:06:33 DEBUG : dst/three: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f107786f0d387ab9b_d20211213_m060008_c001_v0001136_t0051") 2021/12/13 06:06:33 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f110b15366ec4604d_d20211213_m060325_c001_v0001120_t0011") 2021/12/13 06:06:33 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f100c2875af1a0cc7_d20211213_m060322_c001_v0001041_t0005") 2021/12/13 06:06:33 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f108df365a8ff1120_d20211213_m060315_c001_v0001117_t0028") 2021/12/13 06:06:33 DEBUG : dst/three.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f11419e70f9ab177e_d20211213_m060325_c001_v0001040_t0019") 2021/12/13 06:06:33 DEBUG : dst/three.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f110dd839e3594b25_d20211213_m060323_c001_v0001165_t0037") 2021/12/13 06:06:33 DEBUG : dst/three.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1157c4ab0286bb17_d20211213_m060322_c001_v0001097_t0056") 2021/12/13 06:06:33 DEBUG : dst/three.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f110dd839e3594b11_d20211213_m060317_c001_v0001165_t0009") 2021/12/13 06:06:33 DEBUG : dst/three.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10659e5d6fec0154_d20211213_m060316_c001_v0001153_t0004") 2021/12/13 06:06:33 DEBUG : dst/three.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2951_d20211213_m060302_c001_v0001097_t0017") 2021/12/13 06:06:33 DEBUG : dst/three.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1071da06ee387a83_d20211213_m060256_c001_v0001090_t0004") 2021/12/13 06:06:33 DEBUG : dst/three.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f109e44dd07eca7c0_d20211213_m060251_c001_v0001036_t0035") 2021/12/13 06:06:34 DEBUG : dst/three.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f108c132277fef30e_d20211213_m060250_c001_v0001017_t0026") 2021/12/13 06:06:34 DEBUG : dst/three.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f109e44dd07eca7b4_d20211213_m060246_c001_v0001036_t0001") 2021/12/13 06:06:34 DEBUG : dst/three.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10289b91d57cc743_d20211213_m060245_c001_v0001157_t0014") 2021/12/13 06:06:34 DEBUG : dst/three.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25861_d20211213_m060237_c001_v0001146_t0048") 2021/12/13 06:06:34 DEBUG : dst/three.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1050452f3ae54a75_d20211213_m060230_c001_v0001097_t0005") 2021/12/13 06:06:34 DEBUG : dst/three.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2748_d20211213_m060220_c001_v0001097_t0032") 2021/12/13 06:06:34 DEBUG : dst/three.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f111c94f5b96d4711_d20211213_m060219_c001_v0001097_t0049") 2021/12/13 06:06:34 DEBUG : dst/three.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd257ee_d20211213_m060207_c001_v0001146_t0047") 2021/12/13 06:06:34 DEBUG : dst/three.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10931af4834b5105_d20211213_m060143_c001_v0001145_t0056") 2021/12/13 06:06:34 DEBUG : dst/three.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d259c_d20211213_m060138_c001_v0001097_t0025") 2021/12/13 06:06:34 DEBUG : dst/three.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f114a96ac9313bb2c_d20211213_m060137_c001_v0001043_t0015") 2021/12/13 06:06:34 DEBUG : dst/three.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25744_d20211213_m060130_c001_v0001146_t0010") 2021/12/13 06:06:34 DEBUG : dst/three.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f11435e61f1a338fa_d20211213_m060124_c001_v0001022_t0040") 2021/12/13 06:06:34 DEBUG : dst/three.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d24c1_d20211213_m060117_c001_v0001097_t0049") 2021/12/13 06:06:34 DEBUG : dst/three.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1102acf37b0420f3_d20211213_m060115_c001_v0001117_t0024") 2021/12/13 06:06:34 DEBUG : dst/three.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd2571d_d20211213_m060107_c001_v0001146_t0010") 2021/12/13 06:06:34 DEBUG : dst/three.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f108d5ca4e6f830d3_d20211213_m060031_c001_v0001145_t0011") 2021/12/13 06:06:34 DEBUG : dst/three.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d224f_d20211213_m060025_c001_v0001097_t0021") 2021/12/13 06:06:34 DEBUG : dst/three.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f111c94f5b96d40ad_d20211213_m060024_c001_v0001097_t0058") 2021/12/13 06:06:34 DEBUG : dst/three.txt: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd256d2_d20211213_m060016_c001_v0001146_t0015") 2021/12/13 06:06:35 DEBUG : dst/three.txt.bak: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f108e1990b7d582fc_d20211213_m060256_c001_v0001019_t0039") 2021/12/13 06:06:35 DEBUG : dst/three.txt.bak: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1188f6a9b976c92c_d20211213_m060249_c001_v0001025_t0004") 2021/12/13 06:06:35 DEBUG : dst/three.txt.bak: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f111c94f5b96d48b9_d20211213_m060244_c001_v0001097_t0016") 2021/12/13 06:06:35 DEBUG : dst/three.txt.bak: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f111bbfa2affd7e23_d20211213_m060233_c001_v0001092_t0029") 2021/12/13 06:06:35 DEBUG : dst/three.txt.bak: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f113c457935c76b79_d20211213_m060229_c001_v0001022_t0007") 2021/12/13 06:06:35 DEBUG : dst/three.txt.bak: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f107155cc09a76f31_d20211213_m060213_c001_v0001033_t0034") 2021/12/13 06:06:35 DEBUG : dst/two: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1094088b1c2b65ce_d20211213_m060326_c001_v0001144_t0043") 2021/12/13 06:06:35 DEBUG : dst/two: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd2588f_d20211213_m060302_c001_v0001146_t0053") 2021/12/13 06:06:35 DEBUG : dst/two: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f118ab3a97453e194_d20211213_m060257_c001_v0001038_t0043") 2021/12/13 06:06:35 DEBUG : dst/two: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2814_d20211213_m060236_c001_v0001097_t0048") 2021/12/13 06:06:35 DEBUG : dst/two: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1103242f9545fbbb_d20211213_m060233_c001_v0001097_t0028") 2021/12/13 06:06:35 DEBUG : dst/two: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d269c_d20211213_m060205_c001_v0001097_t0010") 2021/12/13 06:06:35 DEBUG : dst/two: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1030ac33d121b36c_d20211213_m060203_c001_v0001117_t0058") 2021/12/13 06:06:35 DEBUG : dst/two: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2526_d20211213_m060128_c001_v0001097_t0043") 2021/12/13 06:06:35 DEBUG : dst/two: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1015740bb46283d8_d20211213_m060126_c001_v0001042_t0006") 2021/12/13 06:06:35 DEBUG : dst/two: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2456_d20211213_m060105_c001_v0001097_t0047") 2021/12/13 06:06:35 DEBUG : dst/two: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f112e7793d8c0b75e_d20211213_m060103_c001_v0001153_t0021") 2021/12/13 06:06:35 DEBUG : dst/two: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d21ea_d20211213_m060016_c001_v0001097_t0017") 2021/12/13 06:06:35 DEBUG : dst/two: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1074c7af93a66f80_d20211213_m060013_c001_v0001117_t0001") 2021/12/13 06:06:35 DEBUG : dst/two: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1081be1f682cce49_d20211213_m060004_c001_v0001097_t0004") 2021/12/13 06:06:35 DEBUG : dst/two: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f102d73482ce7ec4f_d20211213_m055938_c001_v0001003_t0016") 2021/12/13 06:06:36 DEBUG : dst/two: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f106977938d43a85d_d20211213_m055933_c001_v0001150_t0036") 2021/12/13 06:06:36 DEBUG : empty space: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1059a76155c89214_d20211213_m055909_c001_v0001153_t0013") 2021/12/13 06:06:36 DEBUG : empty space: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25671_d20211213_m055904_c001_v0001146_t0006") 2021/12/13 06:06:36 DEBUG : empty space: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f108d47d88be0a171_d20211213_m055900_c001_v0001038_t0002") 2021/12/13 06:06:36 DEBUG : empty space: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d1ebf_d20211213_m055845_c001_v0001097_t0003") 2021/12/13 06:06:36 DEBUG : empty space: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f116fd9b3aaaf4569_d20211213_m055835_c001_v0001039_t0034") 2021/12/13 06:06:36 DEBUG : empty space: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25636_d20211213_m055829_c001_v0001146_t0043") 2021/12/13 06:06:36 DEBUG : empty space: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1059a76155c890b6_d20211213_m055739_c001_v0001153_t0000") 2021/12/13 06:06:36 DEBUG : empty space: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd255c6_d20211213_m055736_c001_v0001146_t0053") 2021/12/13 06:06:36 DEBUG : empty space: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f119b126cc23f9cf8_d20211213_m055733_c001_v0001113_t0039") 2021/12/13 06:06:36 DEBUG : empty space: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd255af_d20211213_m055732_c001_v0001146_t0054") 2021/12/13 06:06:36 DEBUG : empty space: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1074c7af93a66a98_d20211213_m055726_c001_v0001117_t0021") 2021/12/13 06:06:36 DEBUG : empty space: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd2559c_d20211213_m055724_c001_v0001146_t0002") 2021/12/13 06:06:36 DEBUG : empty space: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f118af69500dfbfc9_d20211213_m055723_c001_v0001130_t0033") 2021/12/13 06:06:36 DEBUG : empty space: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25584_d20211213_m055719_c001_v0001146_t0034") 2021/12/13 06:06:36 DEBUG : empty space: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f115d95d591f9ecaf_d20211213_m055658_c001_v0001042_t0015") 2021/12/13 06:06:36 DEBUG : empty space: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd2552d_d20211213_m055656_c001_v0001146_t0016") 2021/12/13 06:06:36 DEBUG : empty space: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f105da58a1f3ec5d2_d20211213_m055654_c001_v0001117_t0056") 2021/12/13 06:06:36 DEBUG : empty space: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25526_d20211213_m055653_c001_v0001146_t0030") 2021/12/13 06:06:36 DEBUG : empty space: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f114fefeb5750ea47_d20211213_m055648_c001_v0001041_t0046") 2021/12/13 06:06:36 DEBUG : empty space: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25507_d20211213_m055647_c001_v0001146_t0013") 2021/12/13 06:06:36 DEBUG : empty space: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1137a33dabab864c_d20211213_m055645_c001_v0001161_t0038") 2021/12/13 06:06:37 DEBUG : empty space: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd254fb_d20211213_m055644_c001_v0001146_t0006") 2021/12/13 06:06:37 DEBUG : empty space: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f100277a8bbb387a4_d20211213_m055643_c001_v0001150_t0012") 2021/12/13 06:06:37 DEBUG : empty space: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f11829b4141e4d9df_d20211213_m055642_c001_v0001026_t0015") 2021/12/13 06:06:37 DEBUG : empty space: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd254ee_d20211213_m055640_c001_v0001146_t0056") 2021/12/13 06:06:37 DEBUG : enormous: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1072a1088066620d_d20211213_m055737_c001_v0001043_t0057") 2021/12/13 06:06:37 DEBUG : enormous: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd255c8_d20211213_m055736_c001_v0001146_t0038") 2021/12/13 06:06:37 DEBUG : existing: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1132d7ef4c4917c2_d20211213_m060331_c001_v0001134_t0003") 2021/12/13 06:06:37 DEBUG : existing: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd258d7_d20211213_m060330_c001_v0001146_t0053") 2021/12/13 06:06:37 DEBUG : existing: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1005a91c38868eba_d20211213_m055823_c001_v0001044_t0039") 2021/12/13 06:06:37 DEBUG : existing: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25626_d20211213_m055822_c001_v0001146_t0040") 2021/12/13 06:06:37 DEBUG : existing: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f107df5ba89572acc_d20211213_m055633_c001_v0001097_t0010") 2021/12/13 06:06:37 DEBUG : existing: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd254c9_d20211213_m055632_c001_v0001146_t0030") 2021/12/13 06:06:37 DEBUG : existing: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f109b44db954729f7_d20211213_m055631_c001_v0001038_t0047") 2021/12/13 06:06:37 DEBUG : existing: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd254c3_d20211213_m055630_c001_v0001146_t0054") 2021/12/13 06:06:37 DEBUG : existing: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd254bf_d20211213_m055629_c001_v0001146_t0003") 2021/12/13 06:06:37 DEBUG : existing-b: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f106fac985e15daf2_d20211213_m055823_c001_v0001154_t0019") 2021/12/13 06:06:37 DEBUG : existing-b: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1139d58ca71619e0_d20211213_m055821_c001_v0001165_t0020") 2021/12/13 06:06:37 DEBUG : five: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1069cd89a01d327d_d20211213_m055745_c001_v0001136_t0042") 2021/12/13 06:06:37 DEBUG : five: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1139d58ca7161981_d20211213_m055741_c001_v0001165_t0007") 2021/12/13 06:06:37 DEBUG : foo: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f113ede6e42282295_d20211213_m055647_c001_v0001097_t0015") 2021/12/13 06:06:37 DEBUG : foo: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25505_d20211213_m055646_c001_v0001146_t0035") 2021/12/13 06:06:38 DEBUG : foo: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25501_d20211213_m055645_c001_v0001146_t0024") 2021/12/13 06:06:38 DEBUG : four: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1067a58f7a496f99_d20211213_m055745_c001_v0001097_t0029") 2021/12/13 06:06:38 DEBUG : four: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd255de_d20211213_m055741_c001_v0001146_t0013") 2021/12/13 06:06:38 DEBUG : four: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd255dc_d20211213_m055740_c001_v0001146_t0016") 2021/12/13 06:06:38 DEBUG : hello world2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1006f4ee8eafc862_d20211213_m055605_c001_v0001131_t0010") 2021/12/13 06:06:38 DEBUG : hello world2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25479_d20211213_m055604_c001_v0001146_t0030") 2021/12/13 06:06:38 DEBUG : ignore-size: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f101201c1832862e1_d20211213_m055628_c001_v0001097_t0052") 2021/12/13 06:06:38 DEBUG : ignore-size: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd254ba_d20211213_m055627_c001_v0001146_t0013") 2021/12/13 06:06:38 DEBUG : nested/sub dir/file: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10553dcc92d351b3_d20211213_m055819_c001_v0001038_t0007") 2021/12/13 06:06:38 DEBUG : nested/sub dir/file: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1139d58ca71619d8_d20211213_m055817_c001_v0001165_t0036") 2021/12/13 06:06:38 DEBUG : nested/sub dir/file: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10743dfad03fce02_d20211213_m055816_c001_v0001008_t0034") 2021/12/13 06:06:38 DEBUG : nested/sub dir/file: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1139d58ca71619cf_d20211213_m055815_c001_v0001165_t0041") 2021/12/13 06:06:38 DEBUG : one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f112361f673b1aec8_d20211213_m055746_c001_v0001040_t0037") 2021/12/13 06:06:38 DEBUG : one: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd255d2_d20211213_m055739_c001_v0001146_t0037") 2021/12/13 06:06:38 DEBUG : only0: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1154aacf75028142_d20211213_m060607_c001_v0001136_t0044") 2021/12/13 06:06:38 DEBUG : only0: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d30a1_d20211213_m060538_c001_v0001097_t0018") 2021/12/13 06:06:38 DEBUG : only0: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2e82_d20211213_m060503_c001_v0001097_t0025") 2021/12/13 06:06:38 DEBUG : only0: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10626c90220bfdd6_d20211213_m060420_c001_v0001144_t0049") 2021/12/13 06:06:38 DEBUG : only0: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2ae1_d20211213_m060338_c001_v0001097_t0001") 2021/12/13 06:06:38 DEBUG : only1: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1022e3a89f737706_d20211213_m060607_c001_v0001009_t0005") 2021/12/13 06:06:39 DEBUG : only1: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f11637c63c41b67fc_d20211213_m060539_c001_v0001097_t0047") 2021/12/13 06:06:39 DEBUG : only1: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2ea1_d20211213_m060506_c001_v0001097_t0024") 2021/12/13 06:06:39 DEBUG : only1: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1057b2a96731e862_d20211213_m060421_c001_v0001165_t0044") 2021/12/13 06:06:39 DEBUG : only1: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2b12_d20211213_m060341_c001_v0001097_t0041") 2021/12/13 06:06:39 DEBUG : only10: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f110cba7bf5134b8b_d20211213_m060608_c001_v0001042_t0020") 2021/12/13 06:06:39 DEBUG : only10: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1103242f954602b8_d20211213_m060542_c001_v0001097_t0003") 2021/12/13 06:06:39 DEBUG : only10: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2f96_d20211213_m060521_c001_v0001097_t0035") 2021/12/13 06:06:39 DEBUG : only10: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f11409ebd4d7c44ef_d20211213_m060422_c001_v0001117_t0048") 2021/12/13 06:06:39 DEBUG : only10: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2bce_d20211213_m060358_c001_v0001097_t0012") 2021/12/13 06:06:39 DEBUG : only11: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f118ab3a97453e412_d20211213_m060610_c001_v0001038_t0017") 2021/12/13 06:06:39 DEBUG : only11: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f11637c63c41b6814_d20211213_m060541_c001_v0001097_t0031") 2021/12/13 06:06:39 DEBUG : only11: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2fa6_d20211213_m060522_c001_v0001097_t0057") 2021/12/13 06:06:39 DEBUG : only11: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f104e78c06b46dcde_d20211213_m060419_c001_v0001004_t0017") 2021/12/13 06:06:39 DEBUG : only11: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2be1_d20211213_m060401_c001_v0001097_t0052") 2021/12/13 06:06:39 DEBUG : only12: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f11459f117f159320_d20211213_m060611_c001_v0001145_t0018") 2021/12/13 06:06:39 DEBUG : only12: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f115fde9e3c81a021_d20211213_m060539_c001_v0001117_t0015") 2021/12/13 06:06:39 DEBUG : only12: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2fbf_d20211213_m060523_c001_v0001097_t0004") 2021/12/13 06:06:39 DEBUG : only12: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f112ec0cec5624a6b_d20211213_m060421_c001_v0001097_t0042") 2021/12/13 06:06:39 DEBUG : only12: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2bef_d20211213_m060403_c001_v0001097_t0015") 2021/12/13 06:06:39 DEBUG : only13: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f114cc020f04f0db4_d20211213_m060611_c001_v0001134_t0017") 2021/12/13 06:06:39 DEBUG : only13: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1103242f9546028d_d20211213_m060539_c001_v0001097_t0011") 2021/12/13 06:06:39 DEBUG : only13: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2fd3_d20211213_m060525_c001_v0001097_t0013") 2021/12/13 06:06:39 DEBUG : only13: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f101169cb4b38cbb3_d20211213_m060419_c001_v0001018_t0044") 2021/12/13 06:06:40 DEBUG : only13: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2c1a_d20211213_m060406_c001_v0001097_t0049") 2021/12/13 06:06:40 DEBUG : only14: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f101201c18328830c_d20211213_m060612_c001_v0001097_t0023") 2021/12/13 06:06:40 DEBUG : only14: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d30ad_d20211213_m060539_c001_v0001097_t0049") 2021/12/13 06:06:40 DEBUG : only14: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2ff3_d20211213_m060527_c001_v0001097_t0046") 2021/12/13 06:06:40 DEBUG : only14: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1192d8399ce9cadc_d20211213_m060421_c001_v0001144_t0019") 2021/12/13 06:06:40 DEBUG : only14: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2c40_d20211213_m060410_c001_v0001097_t0020") 2021/12/13 06:06:40 DEBUG : only15: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f108d47d88be0ac81_d20211213_m060613_c001_v0001038_t0021") 2021/12/13 06:06:40 DEBUG : only15: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f11637c63c41b6801_d20211213_m060540_c001_v0001097_t0056") 2021/12/13 06:06:40 DEBUG : only15: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d300f_d20211213_m060529_c001_v0001097_t0026") 2021/12/13 06:06:40 DEBUG : only15: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f108d5ca4e6f8334c_d20211213_m060422_c001_v0001145_t0030") 2021/12/13 06:06:40 DEBUG : only15: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2c4b_d20211213_m060411_c001_v0001097_t0001") 2021/12/13 06:06:40 DEBUG : only16: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1187913d3a413297_d20211213_m060613_c001_v0001039_t0031") 2021/12/13 06:06:40 DEBUG : only16: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1103242f954602a2_d20211213_m060540_c001_v0001097_t0024") 2021/12/13 06:06:40 DEBUG : only16: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d3039_d20211213_m060532_c001_v0001097_t0054") 2021/12/13 06:06:40 DEBUG : only16: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1122c633fd02d8de_d20211213_m060422_c001_v0001117_t0039") 2021/12/13 06:06:40 DEBUG : only16: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2c5e_d20211213_m060413_c001_v0001097_t0001") 2021/12/13 06:06:41 DEBUG : only17: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f110dd839e3594ce8_d20211213_m060613_c001_v0001165_t0051") 2021/12/13 06:06:41 DEBUG : only17: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f115fde9e3c81a032_d20211213_m060540_c001_v0001117_t0058") 2021/12/13 06:06:41 DEBUG : only17: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d305e_d20211213_m060534_c001_v0001097_t0018") 2021/12/13 06:06:41 DEBUG : only17: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f107ffba4a8f0ba6b_d20211213_m060419_c001_v0001145_t0023") 2021/12/13 06:06:41 DEBUG : only17: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2c6e_d20211213_m060414_c001_v0001097_t0009") 2021/12/13 06:06:41 DEBUG : only18: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f115079bb2efff7ff_d20211213_m060614_c001_v0001137_t0058") 2021/12/13 06:06:41 DEBUG : only18: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d30e9_d20211213_m060543_c001_v0001097_t0015") 2021/12/13 06:06:41 DEBUG : only18: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d307d_d20211213_m060535_c001_v0001097_t0034") 2021/12/13 06:06:41 DEBUG : only18: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f11910e3ee89f7c58_d20211213_m060420_c001_v0001097_t0019") 2021/12/13 06:06:41 DEBUG : only18: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2c87_d20211213_m060416_c001_v0001097_t0040") 2021/12/13 06:06:41 DEBUG : only19: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f117446c51fc5a74a_d20211213_m060614_c001_v0001144_t0056") 2021/12/13 06:06:41 DEBUG : only19: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1103242f954602b2_d20211213_m060541_c001_v0001097_t0046") 2021/12/13 06:06:41 DEBUG : only19: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d3093_d20211213_m060537_c001_v0001097_t0041") 2021/12/13 06:06:41 DEBUG : only19: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1114425bd6ee3749_d20211213_m060420_c001_v0001043_t0057") 2021/12/13 06:06:41 DEBUG : only19: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2c9b_d20211213_m060417_c001_v0001097_t0043") 2021/12/13 06:06:42 DEBUG : only2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f106bd56c379fa799_d20211213_m060615_c001_v0001117_t0000") 2021/12/13 06:06:42 DEBUG : only2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d30c8_d20211213_m060541_c001_v0001097_t0051") 2021/12/13 06:06:42 DEBUG : only2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2ec5_d20211213_m060508_c001_v0001097_t0028") 2021/12/13 06:06:42 DEBUG : only2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1114c2cde7f0ba8b_d20211213_m060422_c001_v0001042_t0030") 2021/12/13 06:06:42 DEBUG : only2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2b22_d20211213_m060342_c001_v0001097_t0047") 2021/12/13 06:06:42 DEBUG : only3: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f105ad2b7588e5c75_d20211213_m060616_c001_v0001019_t0028") 2021/12/13 06:06:42 DEBUG : only3: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f115fde9e3c81a040_d20211213_m060541_c001_v0001117_t0022") 2021/12/13 06:06:42 DEBUG : only3: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2ed7_d20211213_m060509_c001_v0001097_t0004") 2021/12/13 06:06:42 DEBUG : only3: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f11900cc221097a47_d20211213_m060419_c001_v0001001_t0013") 2021/12/13 06:06:42 DEBUG : only3: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2b2a_d20211213_m060343_c001_v0001097_t0031") 2021/12/13 06:06:42 DEBUG : only4: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f113e9f26cc1bab77_d20211213_m060617_c001_v0001154_t0012") 2021/12/13 06:06:42 DEBUG : only4: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d30d8_d20211213_m060542_c001_v0001097_t0015") 2021/12/13 06:06:42 DEBUG : only4: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2f03_d20211213_m060512_c001_v0001097_t0011") 2021/12/13 06:06:42 DEBUG : only4: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f113e26a33a61fb77_d20211213_m060420_c001_v0001117_t0038") 2021/12/13 06:06:42 DEBUG : only4: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2b4b_d20211213_m060345_c001_v0001097_t0050") 2021/12/13 06:06:42 DEBUG : only5: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f119c6d64e7baff87_d20211213_m060617_c001_v0001117_t0045") 2021/12/13 06:06:42 DEBUG : only5: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f11637c63c41b682a_d20211213_m060542_c001_v0001097_t0008") 2021/12/13 06:06:42 DEBUG : only5: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2f1e_d20211213_m060514_c001_v0001097_t0017") 2021/12/13 06:06:42 DEBUG : only5: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1071da06ee387c32_d20211213_m060420_c001_v0001090_t0005") 2021/12/13 06:06:42 DEBUG : only5: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2b66_d20211213_m060348_c001_v0001097_t0048") 2021/12/13 06:06:42 DEBUG : only6: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1074c7af93a67e71_d20211213_m060619_c001_v0001117_t0030") 2021/12/13 06:06:42 DEBUG : only6: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f115fde9e3c81a06e_d20211213_m060543_c001_v0001117_t0026") 2021/12/13 06:06:43 DEBUG : only6: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2f2e_d20211213_m060515_c001_v0001097_t0017") 2021/12/13 06:06:43 DEBUG : only6: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f115cdab3bd45d6d2_d20211213_m060419_c001_v0001021_t0042") 2021/12/13 06:06:43 DEBUG : only6: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2b7e_d20211213_m060350_c001_v0001097_t0027") 2021/12/13 06:06:43 DEBUG : only7: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d3282_d20211213_m060620_c001_v0001097_t0058") 2021/12/13 06:06:43 DEBUG : only7: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f115fde9e3c81a061_d20211213_m060542_c001_v0001117_t0048") 2021/12/13 06:06:43 DEBUG : only7: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2f38_d20211213_m060516_c001_v0001097_t0012") 2021/12/13 06:06:43 DEBUG : only7: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f105da58a1f3ed508_d20211213_m060420_c001_v0001117_t0003") 2021/12/13 06:06:43 DEBUG : only7: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2b97_d20211213_m060352_c001_v0001097_t0058") 2021/12/13 06:06:43 DEBUG : only8: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f108a8aa771bd12d8_d20211213_m060621_c001_v0001015_t0019") 2021/12/13 06:06:43 DEBUG : only8: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1103242f954602d0_d20211213_m060543_c001_v0001097_t0039") 2021/12/13 06:06:43 DEBUG : only8: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2f4d_d20211213_m060517_c001_v0001097_t0025") 2021/12/13 06:06:43 DEBUG : only8: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f108c04f6720adad8_d20211213_m060420_c001_v0001026_t0040") 2021/12/13 06:06:43 DEBUG : only8: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2bac_d20211213_m060355_c001_v0001097_t0048") 2021/12/13 06:06:43 DEBUG : only9: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1025f1bfaec6c1dd_d20211213_m060622_c001_v0001097_t0044") 2021/12/13 06:06:43 DEBUG : only9: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f11637c63c41b683e_d20211213_m060543_c001_v0001097_t0053") 2021/12/13 06:06:43 DEBUG : only9: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2f73_d20211213_m060519_c001_v0001097_t0033") 2021/12/13 06:06:43 DEBUG : only9: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1032b4c637d37cab_d20211213_m060422_c001_v0001004_t0036") 2021/12/13 06:06:43 DEBUG : only9: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d2bbe_d20211213_m060357_c001_v0001097_t0016") 2021/12/13 06:06:43 DEBUG : potato: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1067a58f7a497125_d20211213_m055813_c001_v0001097_t0040") 2021/12/13 06:06:43 DEBUG : potato: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d1d21_d20211213_m055810_c001_v0001097_t0030") 2021/12/13 06:06:43 DEBUG : potato: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f111697b908d148bd_d20211213_m055801_c001_v0001000_t0041") 2021/12/13 06:06:44 DEBUG : potato: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25600_d20211213_m055758_c001_v0001146_t0019") 2021/12/13 06:06:44 DEBUG : potato: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f11858fc6ce9fcbfe_d20211213_m055755_c001_v0001022_t0028") 2021/12/13 06:06:44 DEBUG : potato: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1139d58ca7161993_d20211213_m055750_c001_v0001165_t0038") 2021/12/13 06:06:44 DEBUG : potato: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1102acf37b041980_d20211213_m055729_c001_v0001117_t0052") 2021/12/13 06:06:44 DEBUG : potato: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd255a5_d20211213_m055728_c001_v0001146_t0007") 2021/12/13 06:06:44 DEBUG : potato: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1018a0d996c2a9d7_d20211213_m055725_c001_v0001165_t0009") 2021/12/13 06:06:44 DEBUG : potato: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd2559a_d20211213_m055724_c001_v0001146_t0021") 2021/12/13 06:06:44 DEBUG : potato: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f110202c925818d70_d20211213_m055720_c001_v0001039_t0034") 2021/12/13 06:06:44 DEBUG : potato: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25582_d20211213_m055718_c001_v0001146_t0045") 2021/12/13 06:06:44 DEBUG : potato: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10856dd1d532b620_d20211213_m055658_c001_v0001137_t0021") 2021/12/13 06:06:44 DEBUG : potato: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd2552b_d20211213_m055657_c001_v0001146_t0002") 2021/12/13 06:06:44 DEBUG : potato: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1127d2d8d55336d2_d20211213_m055656_c001_v0001032_t0052") 2021/12/13 06:06:44 DEBUG : potato: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25522_d20211213_m055655_c001_v0001146_t0049") 2021/12/13 06:06:44 DEBUG : potato: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f116fd9b3aaaf44e3_d20211213_m055654_c001_v0001039_t0027") 2021/12/13 06:06:44 DEBUG : potato: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25519_d20211213_m055653_c001_v0001146_t0004") 2021/12/13 06:06:44 DEBUG : potato: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25516_d20211213_m055652_c001_v0001146_t0010") 2021/12/13 06:06:44 DEBUG : potato: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f11386d2f4ce4d946_d20211213_m055651_c001_v0001018_t0002") 2021/12/13 06:06:44 DEBUG : potato: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25512_d20211213_m055650_c001_v0001146_t0052") 2021/12/13 06:06:44 DEBUG : potato: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd2550e_d20211213_m055649_c001_v0001146_t0048") 2021/12/13 06:06:44 DEBUG : potato: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10293402dabd7c88_d20211213_m055648_c001_v0001131_t0005") 2021/12/13 06:06:44 DEBUG : potato: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25509_d20211213_m055647_c001_v0001146_t0053") 2021/12/13 06:06:44 DEBUG : potato2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f11691140b11fc4ca_d20211213_m055920_c001_v0001036_t0043") 2021/12/13 06:06:45 DEBUG : potato2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25687_d20211213_m055919_c001_v0001146_t0030") 2021/12/13 06:06:45 DEBUG : potato2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f113ede6e4228290e_d20211213_m055909_c001_v0001097_t0049") 2021/12/13 06:06:45 DEBUG : potato2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d1f66_d20211213_m055902_c001_v0001097_t0041") 2021/12/13 06:06:45 DEBUG : potato2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f119b126cc23f9d7f_d20211213_m055854_c001_v0001113_t0053") 2021/12/13 06:06:45 DEBUG : potato2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd2564b_d20211213_m055844_c001_v0001146_t0041") 2021/12/13 06:06:45 DEBUG : potato2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f112ec0cec5623b0b_d20211213_m055836_c001_v0001097_t0035") 2021/12/13 06:06:45 DEBUG : potato2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d1de2_d20211213_m055825_c001_v0001097_t0011") 2021/12/13 06:06:45 DEBUG : potato2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f108ec408527877f3_d20211213_m055738_c001_v0001042_t0042") 2021/12/13 06:06:45 DEBUG : potato2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd255c3_d20211213_m055736_c001_v0001146_t0025") 2021/12/13 06:06:45 DEBUG : potato2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1102acf37b0419ae_d20211213_m055735_c001_v0001117_t0059") 2021/12/13 06:06:45 DEBUG : potato2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd255ad_d20211213_m055732_c001_v0001146_t0045") 2021/12/13 06:06:45 DEBUG : potato2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f117be749c23ff97b_d20211213_m055730_c001_v0001037_t0000") 2021/12/13 06:06:45 DEBUG : potato2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd255ab_d20211213_m055728_c001_v0001146_t0053") 2021/12/13 06:06:45 DEBUG : potato2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f105e5278ef1c0b22_d20211213_m055727_c001_v0001090_t0055") 2021/12/13 06:06:45 DEBUG : potato2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd2559e_d20211213_m055725_c001_v0001146_t0009") 2021/12/13 06:06:45 DEBUG : potato2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f101765a4844dc75e_d20211213_m055723_c001_v0001134_t0048") 2021/12/13 06:06:45 DEBUG : potato2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25588_d20211213_m055720_c001_v0001146_t0054") 2021/12/13 06:06:45 DEBUG : potato2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1094088b1c2b5f7c_d20211213_m055659_c001_v0001144_t0036") 2021/12/13 06:06:45 DEBUG : potato2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd2552f_d20211213_m055657_c001_v0001146_t0006") 2021/12/13 06:06:45 DEBUG : potato2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1059772104f3ce59_d20211213_m055609_c001_v0001092_t0013") 2021/12/13 06:06:46 DEBUG : potato2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25485_d20211213_m055608_c001_v0001146_t0012") 2021/12/13 06:06:46 DEBUG : potato2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f108e1a781327be7b_d20211213_m055606_c001_v0001025_t0005") 2021/12/13 06:06:46 DEBUG : potato2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25482_d20211213_m055605_c001_v0001146_t0009") 2021/12/13 06:06:46 DEBUG : potato3: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1127d2d8d553373a_d20211213_m055909_c001_v0001032_t0013") 2021/12/13 06:06:46 DEBUG : potato3: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d1f7d_d20211213_m055904_c001_v0001097_t0018") 2021/12/13 06:06:46 DEBUG : potato3: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1192d8399ce9c6af_d20211213_m055851_c001_v0001144_t0018") 2021/12/13 06:06:46 DEBUG : potato3: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25651_d20211213_m055846_c001_v0001146_t0005") 2021/12/13 06:06:46 DEBUG : potato3: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1199250b8ba3a44e_d20211213_m055836_c001_v0001161_t0011") 2021/12/13 06:06:46 DEBUG : potato3: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d1e1f_d20211213_m055829_c001_v0001097_t0020") 2021/12/13 06:06:46 DEBUG : pre-dest1/1: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1022a85741184bdf_d20211213_m055948_c001_v0001093_t0027") 2021/12/13 06:06:46 DEBUG : pre-dest1/1: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd256a0_d20211213_m055940_c001_v0001146_t0001") 2021/12/13 06:06:46 DEBUG : pre-dest2/2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10887cca61d17679_d20211213_m055948_c001_v0001144_t0055") 2021/12/13 06:06:46 DEBUG : pre-dest2/2: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d20d4_d20211213_m055940_c001_v0001097_t0004") 2021/12/13 06:06:46 DEBUG : sizeonly: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1082fe4c696b4136_d20211213_m055626_c001_v0001032_t0054") 2021/12/13 06:06:46 DEBUG : sizeonly: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd254b3_d20211213_m055625_c001_v0001146_t0043") 2021/12/13 06:06:46 DEBUG : sub dir/hello world: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f11810dbaf87fcf1a_d20211213_m055821_c001_v0001037_t0025") 2021/12/13 06:06:46 DEBUG : sub dir/hello world: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d1d80_d20211213_m055818_c001_v0001097_t0003") 2021/12/13 06:06:46 DEBUG : sub dir/hello world: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1199250b8ba3a411_d20211213_m055817_c001_v0001161_t0013") 2021/12/13 06:06:46 DEBUG : sub dir/hello world: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25619_d20211213_m055815_c001_v0001146_t0050") 2021/12/13 06:06:46 DEBUG : sub dir/hello world: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f118a359fb7e8c3ff_d20211213_m055621_c001_v0001097_t0049") 2021/12/13 06:06:47 DEBUG : sub dir/hello world: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd254a3_d20211213_m055620_c001_v0001146_t0006") 2021/12/13 06:06:47 DEBUG : sub dir/hello world: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10125130be77425e_d20211213_m055619_c001_v0001117_t0048") 2021/12/13 06:06:47 DEBUG : sub dir/hello world: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd254a0_d20211213_m055618_c001_v0001146_t0040") 2021/12/13 06:06:47 DEBUG : sub dir/hello world: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f105af04f13267dbb_d20211213_m055617_c001_v0001144_t0041") 2021/12/13 06:06:47 DEBUG : sub dir/hello world: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25496_d20211213_m055615_c001_v0001146_t0050") 2021/12/13 06:06:47 DEBUG : sub dir/hello world: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f107df5ba895729d8_d20211213_m055614_c001_v0001097_t0053") 2021/12/13 06:06:47 DEBUG : sub dir/hello world: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25494_d20211213_m055613_c001_v0001146_t0002") 2021/12/13 06:06:47 DEBUG : sub dir/hello world: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f107cd1bb883b4af1_d20211213_m055612_c001_v0001130_t0058") 2021/12/13 06:06:47 DEBUG : sub dir/hello world: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25492_d20211213_m055611_c001_v0001146_t0013") 2021/12/13 06:06:47 DEBUG : sub dir/hello world: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1045118fffdf2a25_d20211213_m055610_c001_v0001128_t0009") 2021/12/13 06:06:47 DEBUG : sub dir/hello world: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd2548e_d20211213_m055609_c001_v0001146_t0003") 2021/12/13 06:06:47 DEBUG : sub dir/hello world: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1160c7f075d1eb3e_d20211213_m055603_c001_v0001038_t0047") 2021/12/13 06:06:47 DEBUG : sub dir/hello world: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25472_d20211213_m055602_c001_v0001146_t0053") 2021/12/13 06:06:47 DEBUG : sub dir/hello world: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1049ed7493b6d3a4_d20211213_m055601_c001_v0001165_t0011") 2021/12/13 06:06:47 DEBUG : sub dir/hello world: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd2546f_d20211213_m055600_c001_v0001146_t0023") 2021/12/13 06:06:47 DEBUG : sub dir/hello world: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10989b57d85b53c9_d20211213_m055558_c001_v0001005_t0035") 2021/12/13 06:06:47 DEBUG : sub dir/hello world: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd2545f_d20211213_m055557_c001_v0001146_t0035") 2021/12/13 06:06:47 DEBUG : sub dir/hello world: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f105da58a1f3ec3a3_d20211213_m055555_c001_v0001117_t0045") 2021/12/13 06:06:47 DEBUG : sub dir/hello world: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd25459_d20211213_m055554_c001_v0001146_t0021") 2021/12/13 06:06:47 DEBUG : sub/yam: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f106e70bbe907ba3e_d20211213_m055812_c001_v0001131_t0015") 2021/12/13 06:06:47 DEBUG : sub/yam: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1139d58ca71619c7_d20211213_m055810_c001_v0001165_t0016") 2021/12/13 06:06:47 DEBUG : three: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f103f47d6c35029d7_d20211213_m055747_c001_v0001097_t0031") 2021/12/13 06:06:48 DEBUG : three: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd255e2_d20211213_m055744_c001_v0001146_t0006") 2021/12/13 06:06:48 DEBUG : three: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd255d8_d20211213_m055740_c001_v0001146_t0005") 2021/12/13 06:06:48 DEBUG : two: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f11409ebd4d7c343e_d20211213_m055748_c001_v0001117_t0000") 2021/12/13 06:06:48 DEBUG : two: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d1bf2_d20211213_m055742_c001_v0001097_t0039") 2021/12/13 06:06:48 DEBUG : two: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10975b6c7cd255d6_d20211213_m055739_c001_v0001146_t0038") 2021/12/13 06:06:48 DEBUG : yam: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f105dfa33f8aa88d0_d20211213_m055814_c001_v0001037_t0034") 2021/12/13 06:06:48 DEBUG : yam: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f102cd5318be650ac_d20211213_m055811_c001_v0001117_t0023") 2021/12/13 06:06:48 DEBUG : yam: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1178b522c157d52d_d20211213_m055800_c001_v0001145_t0009") 2021/12/13 06:06:48 DEBUG : yam: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1139d58ca71619ac_d20211213_m055758_c001_v0001165_t0051") 2021/12/13 06:06:48 DEBUG : yam: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f116d350fcf3b143c_d20211213_m055753_c001_v0001033_t0024") 2021/12/13 06:06:48 DEBUG : yam: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10438fcc1e1d1c55_d20211213_m055750_c001_v0001097_t0024") 2021/12/13 06:06:48 DEBUG : yaml: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f105e0544f7761d4a_d20211213_m055802_c001_v0001136_t0008") 2021/12/13 06:06:48 DEBUG : yaml: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1128e5bb8aeff849_d20211213_m055759_c001_v0001144_t0013") 2021/12/13 06:06:48 DEBUG : yaml: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f1137d3e4ef477b19_d20211213_m055756_c001_v0001146_t0050") 2021/12/13 06:06:48 DEBUG : yaml: Deleting (id "4_z1ff29d8350cdbb2b7fd80e1b_f10125130be7745c0_d20211213_m055752_c001_v0001117_t0003") "./sync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -fast-list" - Finished OK in 10m58.709152745s (try 1/5)