"./sync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Starting (try 1/5) 2021/11/13 06:40:01 DEBUG : Creating backend with remote "TestB2:rclone-test-quzexim3motamul9cupenas5" 2021/11/13 06:40:01 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2021/11/13 06:40:02 DEBUG : Creating backend with remote "/tmp/rclone3419184883" === RUN TestPipe --- PASS: TestPipe (0.00s) === RUN TestPipeConcurrent --- PASS: TestPipeConcurrent (0.02s) === RUN TestPipeOrderBy === RUN TestPipeOrderBy/#00 === RUN TestPipeOrderBy/size === RUN TestPipeOrderBy/name === RUN TestPipeOrderBy/modtime === RUN TestPipeOrderBy/size,ascending === RUN TestPipeOrderBy/name,asc === RUN TestPipeOrderBy/modtime,ascending === RUN TestPipeOrderBy/size,descending === RUN TestPipeOrderBy/name,desc === RUN TestPipeOrderBy/modtime,descending === RUN TestPipeOrderBy/size,mixed,50 === RUN TestPipeOrderBy/size,mixed,51 --- PASS: TestPipeOrderBy (0.00s) --- PASS: TestPipeOrderBy/#00 (0.00s) --- PASS: TestPipeOrderBy/size (0.00s) --- PASS: TestPipeOrderBy/name (0.00s) --- PASS: TestPipeOrderBy/modtime (0.00s) --- PASS: TestPipeOrderBy/size,ascending (0.00s) --- PASS: TestPipeOrderBy/name,asc (0.00s) --- PASS: TestPipeOrderBy/modtime,ascending (0.00s) --- PASS: TestPipeOrderBy/size,descending (0.00s) --- PASS: TestPipeOrderBy/name,desc (0.00s) --- PASS: TestPipeOrderBy/modtime,descending (0.00s) --- PASS: TestPipeOrderBy/size,mixed,50 (0.00s) --- PASS: TestPipeOrderBy/size,mixed,51 (0.00s) === RUN TestNewLess === RUN TestNewLess/blankOK === RUN TestNewLess/tooManyParts === RUN TestNewLess/tooManyParts2 === RUN TestNewLess/badMixed === RUN TestNewLess/unknownComparison === RUN TestNewLess/unknownSortDirection === RUN TestNewLess/size === RUN TestNewLess/name === RUN TestNewLess/modtime === RUN TestNewLess/size,ascending === RUN TestNewLess/name,asc === RUN TestNewLess/modtime,ascending === RUN TestNewLess/size,descending === RUN TestNewLess/name,desc === RUN TestNewLess/modtime,descending === RUN TestNewLess/modtime,mixed === RUN TestNewLess/modtime,mixed,30 --- PASS: TestNewLess (0.00s) --- PASS: TestNewLess/blankOK (0.00s) --- PASS: TestNewLess/tooManyParts (0.00s) --- PASS: TestNewLess/tooManyParts2 (0.00s) --- PASS: TestNewLess/badMixed (0.00s) --- PASS: TestNewLess/unknownComparison (0.00s) --- PASS: TestNewLess/unknownSortDirection (0.00s) --- PASS: TestNewLess/size (0.00s) --- PASS: TestNewLess/name (0.00s) --- PASS: TestNewLess/modtime (0.00s) --- PASS: TestNewLess/size,ascending (0.00s) --- PASS: TestNewLess/name,asc (0.00s) --- PASS: TestNewLess/modtime,ascending (0.00s) --- PASS: TestNewLess/size,descending (0.00s) --- PASS: TestNewLess/name,desc (0.00s) --- PASS: TestNewLess/modtime,descending (0.00s) --- PASS: TestNewLess/modtime,mixed (0.00s) --- PASS: TestNewLess/modtime,mixed,30 (0.00s) === RUN TestRcCopy rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcCopy (0.00s) === RUN TestRcMove rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcMove (0.00s) === RUN TestRcSync rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcSync (0.00s) === RUN TestCopyWithDryRun run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:40:03 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:40:03 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:40:03 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) --- PASS: TestCopyWithDryRun (1.72s) === RUN TestCopy run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:40:04 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:40:04 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:40:05 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/11/13 06:40:05 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopy (2.67s) === RUN TestCopyMissingDirectory run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:40:06 DEBUG : Creating backend with remote "/non-existing" 2021/11/13 06:40:06 ERROR : Local file system at /non-existing: error reading source root directory: directory not found 2021/11/13 06:40:06 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:40:06 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish --- PASS: TestCopyMissingDirectory (0.53s) === RUN TestCopyNoTraverse run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:40:07 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:40:07 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:40:07 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:40:08 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/11/13 06:40:08 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoTraverse (2.69s) === RUN TestCopyCheckFirst run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:40:09 INFO : B2 bucket rclone-test-quzexim3motamul9cupenas5: Running all checks before starting transfers 2021/11/13 06:40:09 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:40:09 INFO : B2 bucket rclone-test-quzexim3motamul9cupenas5: Checks finished, now starting transfers 2021/11/13 06:40:09 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:40:10 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/11/13 06:40:10 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyCheckFirst (2.18s) === RUN TestSyncNoTraverse run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:40:11 ERROR : Ignoring --no-traverse with sync 2021/11/13 06:40:12 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:40:12 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:40:12 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/11/13 06:40:12 INFO : sub dir/hello world: Copied (new) 2021/11/13 06:40:12 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoTraverse (2.05s) === RUN TestCopyWithDepth run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:40:14 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:40:14 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:40:14 DEBUG : hello world2: sha1 = c0bf117f9c93d02c894fe8ffd6e5cecf3545c209 OK 2021/11/13 06:40:14 INFO : hello world2: Copied (new) --- PASS: TestCopyWithDepth (5.62s) === RUN TestCopyWithFilesFrom run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:40:19 DEBUG : hello world2: Excluded 2021/11/13 06:40:19 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:40:19 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:40:19 DEBUG : potato2: Clearing upload URL because of error: Post "https://pod-000-1032-13.backblaze.com/b2api/v1/b2_upload_file/df424d03006d1b8b7fd80e1b/c001_v0001032_t0024": EOF 2021/11/13 06:40:19 DEBUG : pacer: low level retry 1/1 (error Post "https://pod-000-1032-13.backblaze.com/b2api/v1/b2_upload_file/df424d03006d1b8b7fd80e1b/c001_v0001032_t0024": EOF) 2021/11/13 06:40:19 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2021/11/13 06:40:19 DEBUG : potato2: Received error: Post "https://pod-000-1032-13.backblaze.com/b2api/v1/b2_upload_file/df424d03006d1b8b7fd80e1b/c001_v0001032_t0024": EOF - low level retry 1/10 2021/11/13 06:40:20 DEBUG : pacer: Reducing sleep to 10ms 2021/11/13 06:40:20 DEBUG : potato2: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/11/13 06:40:20 INFO : potato2: Copied (new) --- PASS: TestCopyWithFilesFrom (2.06s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:40:22 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:40:22 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:40:22 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:40:22 DEBUG : potato2: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/11/13 06:40:22 INFO : potato2: Copied (new) --- PASS: TestCopyWithFilesFromAndNoTraverse (2.44s) === RUN TestCopyEmptyDirectories run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:40:24 DEBUG : sub dir2: Making directory 2021/11/13 06:40:24 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:40:24 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:40:24 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/11/13 06:40:24 INFO : sub dir/hello world: Copied (new) 2021/11/13 06:40:24 DEBUG : sub dir2: Making directory 2021/11/13 06:40:24 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: copied 1 directories fstest.go:251: Filtering empty directory "sub dir2" --- PASS: TestCopyEmptyDirectories (1.99s) === RUN TestMoveEmptyDirectories run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:40:26 DEBUG : sub dir2: Making directory 2021/11/13 06:40:26 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:40:26 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:40:26 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/11/13 06:40:26 INFO : sub dir/hello world: Copied (new) 2021/11/13 06:40:26 INFO : sub dir/hello world: Deleted 2021/11/13 06:40:26 DEBUG : sub dir: Making directory 2021/11/13 06:40:26 DEBUG : sub dir2: Making directory 2021/11/13 06:40:26 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: copied 2 directories fstest.go:251: Filtering empty directory "sub dir2" --- PASS: TestMoveEmptyDirectories (1.24s) === RUN TestSyncEmptyDirectories run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:40:27 DEBUG : sub dir2: Making directory 2021/11/13 06:40:27 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:40:27 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:40:27 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/11/13 06:40:27 INFO : sub dir/hello world: Copied (new) 2021/11/13 06:40:27 DEBUG : sub dir2: Making directory 2021/11/13 06:40:27 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: copied 1 directories 2021/11/13 06:40:27 DEBUG : Waiting for deletions to finish fstest.go:251: Filtering empty directory "sub dir2" --- PASS: TestSyncEmptyDirectories (1.37s) === RUN TestServerSideCopy run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:40:29 DEBUG : Creating backend with remote "TestB2:rclone-test-waxenol6woxuyuk0gubijom2" sync_test.go:275: Server side copy (if possible) B2 bucket rclone-test-quzexim3motamul9cupenas5 -> B2 bucket rclone-test-waxenol6woxuyuk0gubijom2 2021/11/13 06:40:30 DEBUG : B2 bucket rclone-test-waxenol6woxuyuk0gubijom2: Waiting for checks to finish 2021/11/13 06:40:30 DEBUG : B2 bucket rclone-test-waxenol6woxuyuk0gubijom2: Waiting for transfers to finish 2021/11/13 06:40:31 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/11/13 06:40:31 INFO : sub dir/hello world: Copied (server-side copy) 2021/11/13 06:40:31 DEBUG : B2 bucket rclone-test-waxenol6woxuyuk0gubijom2: Purge remote 2021/11/13 06:40:31 DEBUG : sub dir/hello world: Deleting (id "4_z7fb2add3006d1b8b7fd80e1b_f11528762a6884241_d20211113_m064031_c001_v0001161_t0003") --- PASS: TestServerSideCopy (5.00s) === RUN TestCopyAfterDelete run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:40:33 ERROR : : error listing: directory not found 2021/11/13 06:40:34 DEBUG : Local file system at /tmp/rclone3419184883: Making directory 2021/11/13 06:40:34 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:40:34 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish --- PASS: TestCopyAfterDelete (1.63s) === RUN TestCopyRedownload run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:40:36 DEBUG : Local file system at /tmp/rclone3419184883: Waiting for checks to finish 2021/11/13 06:40:36 DEBUG : Local file system at /tmp/rclone3419184883: Waiting for transfers to finish 2021/11/13 06:40:36 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/11/13 06:40:36 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyRedownload (2.84s) === RUN TestSyncBasedOnCheckSum run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:40:38 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:40:38 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:40:38 DEBUG : check sum: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2021/11/13 06:40:38 INFO : check sum: Copied (new) 2021/11/13 06:40:38 DEBUG : Waiting for deletions to finish 2021/11/13 06:40:38 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:40:38 DEBUG : check sum: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2021/11/13 06:40:38 DEBUG : check sum: Size and sha1 of src and dst objects identical 2021/11/13 06:40:38 DEBUG : check sum: Unchanged skipping 2021/11/13 06:40:38 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:40:38 DEBUG : Waiting for deletions to finish 2021/11/13 06:40:38 INFO : There was nothing to transfer --- PASS: TestSyncBasedOnCheckSum (2.51s) === RUN TestSyncSizeOnly run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:40:40 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:40:40 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:40:41 DEBUG : sizeonly: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2021/11/13 06:40:41 INFO : sizeonly: Copied (new) 2021/11/13 06:40:41 DEBUG : Waiting for deletions to finish 2021/11/13 06:40:41 DEBUG : sizeonly: Sizes identical 2021/11/13 06:40:41 DEBUG : sizeonly: Unchanged skipping 2021/11/13 06:40:41 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:40:41 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:40:41 DEBUG : Waiting for deletions to finish 2021/11/13 06:40:41 INFO : There was nothing to transfer --- PASS: TestSyncSizeOnly (1.74s) === RUN TestSyncIgnoreSize run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:40:42 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:40:42 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:40:43 DEBUG : ignore-size: sha1 = 4a756ca07e9487f482465a99e8286abc86ba4dc7 OK 2021/11/13 06:40:43 INFO : ignore-size: Copied (new) 2021/11/13 06:40:43 DEBUG : Waiting for deletions to finish 2021/11/13 06:40:43 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:40:43 DEBUG : ignore-size: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:40:43 DEBUG : ignore-size: Unchanged skipping 2021/11/13 06:40:43 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:40:43 DEBUG : Waiting for deletions to finish 2021/11/13 06:40:43 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreSize (2.32s) === RUN TestSyncIgnoreTimes run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:40:45 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:40:45 DEBUG : existing: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:40:45 DEBUG : existing: Unchanged skipping 2021/11/13 06:40:45 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:40:45 DEBUG : Waiting for deletions to finish 2021/11/13 06:40:45 INFO : There was nothing to transfer 2021/11/13 06:40:45 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2021/11/13 06:40:45 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:40:45 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:40:45 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2021/11/13 06:40:45 INFO : existing: Copied (replaced existing) 2021/11/13 06:40:45 DEBUG : Waiting for deletions to finish --- PASS: TestSyncIgnoreTimes (2.34s) === RUN TestSyncIgnoreExisting run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:40:47 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:40:47 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:40:47 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2021/11/13 06:40:47 INFO : existing: Copied (new) 2021/11/13 06:40:47 DEBUG : Waiting for deletions to finish 2021/11/13 06:40:47 DEBUG : existing: Destination exists, skipping 2021/11/13 06:40:47 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:40:47 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:40:47 DEBUG : Waiting for deletions to finish 2021/11/13 06:40:47 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreExisting (1.58s) === RUN TestSyncIgnoreErrors run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:40:49 DEBUG : d: Making directory fstest.go:251: Filtering empty directory "d" 2021/11/13 06:40:49 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:40:49 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/11/13 06:40:49 DEBUG : c/non empty space: Unchanged skipping 2021/11/13 06:40:49 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:40:49 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/11/13 06:40:49 INFO : a/potato2: Copied (new) 2021/11/13 06:40:49 DEBUG : Waiting for deletions to finish 2021/11/13 06:40:50 INFO : b/potato: Deleted --- PASS: TestSyncIgnoreErrors (3.64s) === RUN TestSyncAfterChangingModtimeOnly run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:40:53 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:40:53 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/11/13 06:40:53 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2021/11/13 06:40:53 NOTICE: empty space: Skipped update modification time as --dry-run is set (size 1) 2021/11/13 06:40:53 DEBUG : empty space: Unchanged skipping 2021/11/13 06:40:53 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:40:53 DEBUG : Waiting for deletions to finish 2021/11/13 06:40:53 INFO : There was nothing to transfer 2021/11/13 06:40:53 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:40:53 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/11/13 06:40:53 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2021/11/13 06:40:54 INFO : empty space: Updated modification time in destination 2021/11/13 06:40:54 DEBUG : empty space: Unchanged skipping 2021/11/13 06:40:54 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:40:54 DEBUG : Waiting for deletions to finish 2021/11/13 06:40:54 INFO : There was nothing to transfer --- PASS: TestSyncAfterChangingModtimeOnly (3.39s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:40:56 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:40:56 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/11/13 06:40:56 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2021/11/13 06:40:56 DEBUG : empty space: Unchanged skipping 2021/11/13 06:40:56 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:40:56 DEBUG : Waiting for deletions to finish 2021/11/13 06:40:56 INFO : There was nothing to transfer --- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (3.03s) === RUN TestSyncDoesntUpdateModtime run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:40:59 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:40:59 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/11/13 06:40:59 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 (Local file system at /tmp/rclone3419184883) 2021/11/13 06:40:59 DEBUG : foo: sha1 = 62cdb7020ff920e5aa642c3d4066950dd1f01f4d (B2 bucket rclone-test-quzexim3motamul9cupenas5) 2021/11/13 06:40:59 DEBUG : foo: sha1 differ 2021/11/13 06:40:59 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:40:59 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 OK 2021/11/13 06:40:59 INFO : foo: Copied (replaced existing) 2021/11/13 06:40:59 DEBUG : Waiting for deletions to finish --- PASS: TestSyncDoesntUpdateModtime (2.41s) === RUN TestSyncAfterAddingAFile run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:41:01 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/11/13 06:41:01 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:41:01 DEBUG : empty space: Unchanged skipping 2021/11/13 06:41:01 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:41:01 DEBUG : potato: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/11/13 06:41:01 INFO : potato: Copied (new) 2021/11/13 06:41:01 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterAddingAFile (12.35s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:41:14 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2021/11/13 06:41:14 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:41:14 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:41:14 DEBUG : potato: sha1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f OK 2021/11/13 06:41:14 INFO : potato: Copied (replaced existing) 2021/11/13 06:41:14 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingFilesSizeOnly (2.39s) === RUN TestSyncAfterChangingContentsOnly run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:41:16 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/11/13 06:41:16 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:41:16 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f (Local file system at /tmp/rclone3419184883) 2021/11/13 06:41:16 DEBUG : potato: sha1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f (B2 bucket rclone-test-quzexim3motamul9cupenas5) 2021/11/13 06:41:16 DEBUG : potato: sha1 differ 2021/11/13 06:41:16 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:41:16 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f OK 2021/11/13 06:41:16 INFO : potato: Copied (replaced existing) 2021/11/13 06:41:16 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingContentsOnly (1.91s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:41:18 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2021/11/13 06:41:18 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/11/13 06:41:18 DEBUG : empty space: Unchanged skipping 2021/11/13 06:41:18 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:41:18 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:41:18 DEBUG : Waiting for deletions to finish 2021/11/13 06:41:18 NOTICE: potato: Skipped delete as --dry-run is set (size 21) --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (2.71s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:41:21 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/11/13 06:41:21 DEBUG : empty space: Unchanged skipping 2021/11/13 06:41:21 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:41:21 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:41:21 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/11/13 06:41:21 INFO : potato2: Copied (new) 2021/11/13 06:41:21 DEBUG : Waiting for deletions to finish 2021/11/13 06:41:21 INFO : potato: Deleted --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (3.44s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:41:24 DEBUG : d: Making directory 2021/11/13 06:41:24 DEBUG : d/e: Making directory fstest.go:251: Filtering empty directory "d" fstest.go:251: Filtering empty directory "d/e" 2021/11/13 06:41:24 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/11/13 06:41:24 DEBUG : c/non empty space: Unchanged skipping 2021/11/13 06:41:25 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/11/13 06:41:25 INFO : a/potato2: Copied (new) 2021/11/13 06:41:25 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:41:25 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:41:25 DEBUG : Waiting for deletions to finish 2021/11/13 06:41:26 INFO : b/potato: Deleted --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (4.61s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:41:28 DEBUG : d: Making directory fstest.go:251: Filtering empty directory "d" 2021/11/13 06:41:29 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/11/13 06:41:29 DEBUG : c/non empty space: Unchanged skipping 2021/11/13 06:41:29 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:41:29 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:41:29 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/11/13 06:41:29 INFO : a/potato2: Copied (new) 2021/11/13 06:41:29 ERROR : B2 bucket rclone-test-quzexim3motamul9cupenas5: not deleting files as there were IO errors 2021/11/13 06:41:29 ERROR : B2 bucket rclone-test-quzexim3motamul9cupenas5: not deleting directories as there were IO errors fstest.go:251: Filtering empty directory "d" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (4.61s) === RUN TestSyncDeleteAfter --- PASS: TestSyncDeleteAfter (0.00s) === RUN TestSyncDeleteDuring run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:41:33 DEBUG : Waiting for deletions to finish 2021/11/13 06:41:34 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/11/13 06:41:34 DEBUG : empty space: Unchanged skipping 2021/11/13 06:41:34 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:41:34 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:41:34 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/11/13 06:41:34 INFO : potato2: Copied (new) 2021/11/13 06:41:35 INFO : potato: Deleted --- PASS: TestSyncDeleteDuring (4.26s) === RUN TestSyncDeleteBefore run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:41:38 DEBUG : Waiting for deletions to finish 2021/11/13 06:41:38 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:41:38 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:41:38 INFO : potato: Deleted 2021/11/13 06:41:38 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/11/13 06:41:38 DEBUG : empty space: Unchanged skipping 2021/11/13 06:41:38 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:41:38 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:41:38 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/11/13 06:41:38 INFO : potato2: Copied (new) --- PASS: TestSyncDeleteBefore (3.18s) === RUN TestCopyDeleteBefore run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:41:41 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:41:41 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:41:41 DEBUG : potato2: sha1 = 810274f0df19dab60a894a562b7a8ff04c072623 OK 2021/11/13 06:41:41 INFO : potato2: Copied (new) --- PASS: TestCopyDeleteBefore (2.59s) === RUN TestSyncWithExclude run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:41:43 DEBUG : enormous: Excluded 2021/11/13 06:41:43 DEBUG : potato2: Excluded 2021/11/13 06:41:44 DEBUG : potato2: Excluded 2021/11/13 06:41:44 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/11/13 06:41:44 DEBUG : empty space: Unchanged skipping 2021/11/13 06:41:44 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:41:44 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:41:44 DEBUG : Waiting for deletions to finish 2021/11/13 06:41:44 INFO : There was nothing to transfer 2021/11/13 06:41:44 DEBUG : enormous: Excluded 2021/11/13 06:41:44 DEBUG : potato2: Excluded 2021/11/13 06:41:44 DEBUG : potato2: Excluded 2021/11/13 06:41:44 DEBUG : empty space: Size and modification time the same (differ by 456.789µs, within tolerance 1ms) 2021/11/13 06:41:44 DEBUG : empty space: Unchanged skipping 2021/11/13 06:41:44 DEBUG : Local file system at /tmp/rclone3419184883: Waiting for checks to finish 2021/11/13 06:41:44 DEBUG : Local file system at /tmp/rclone3419184883: Waiting for transfers to finish 2021/11/13 06:41:44 DEBUG : Waiting for deletions to finish 2021/11/13 06:41:44 INFO : There was nothing to transfer --- PASS: TestSyncWithExclude (3.05s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:41:47 DEBUG : enormous: Excluded 2021/11/13 06:41:47 DEBUG : potato2: Excluded 2021/11/13 06:41:47 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/11/13 06:41:47 DEBUG : empty space: Unchanged skipping 2021/11/13 06:41:47 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:41:47 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:41:47 DEBUG : Waiting for deletions to finish 2021/11/13 06:41:47 INFO : enormous: Deleted 2021/11/13 06:41:48 INFO : potato2: Deleted 2021/11/13 06:41:48 INFO : There was nothing to transfer 2021/11/13 06:41:48 DEBUG : empty space: Size and modification time the same (differ by 456.789µs, within tolerance 1ms) 2021/11/13 06:41:48 DEBUG : empty space: Unchanged skipping 2021/11/13 06:41:48 DEBUG : Local file system at /tmp/rclone3419184883: Waiting for checks to finish 2021/11/13 06:41:48 DEBUG : Local file system at /tmp/rclone3419184883: Waiting for transfers to finish 2021/11/13 06:41:48 DEBUG : Waiting for deletions to finish 2021/11/13 06:41:48 INFO : enormous: Deleted 2021/11/13 06:41:48 INFO : potato2: Deleted 2021/11/13 06:41:48 INFO : There was nothing to transfer --- PASS: TestSyncWithExcludeAndDeleteExcluded (4.20s) === RUN TestSyncWithUpdateOlder run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:41:51 DEBUG : four: Sizes differ (src 4 vs dst 8) 2021/11/13 06:41:51 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2021/11/13 06:41:51 DEBUG : one: Destination is newer than source, skipping 2021/11/13 06:41:51 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:41:51 DEBUG : three: Sizes identical 2021/11/13 06:41:51 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2021/11/13 06:41:51 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b (Local file system at /tmp/rclone3419184883) 2021/11/13 06:41:51 DEBUG : two: sha1 = b10e0da85e90399abfec36c7376b20aa4596461b (B2 bucket rclone-test-quzexim3motamul9cupenas5) 2021/11/13 06:41:51 DEBUG : two: sha1 differ 2021/11/13 06:41:51 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:41:52 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2021/11/13 06:41:52 INFO : four: Copied (replaced existing) 2021/11/13 06:41:53 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2021/11/13 06:41:53 INFO : five: Copied (new) 2021/11/13 06:41:53 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2021/11/13 06:41:53 INFO : two: Copied (replaced existing) 2021/11/13 06:41:53 DEBUG : Waiting for deletions to finish 2021/11/13 06:41:53 DEBUG : one: Destination is newer than source, skipping 2021/11/13 06:41:53 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:41:53 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2021/11/13 06:41:53 DEBUG : five: Size and sha1 of src and dst objects identical 2021/11/13 06:41:53 DEBUG : five: Destination mod time is within 1s of source and files identical, skipping 2021/11/13 06:41:53 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2021/11/13 06:41:53 DEBUG : two: Size and sha1 of src and dst objects identical 2021/11/13 06:41:53 DEBUG : two: Destination mod time is within 1s of source and files identical, skipping 2021/11/13 06:41:53 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2021/11/13 06:41:53 DEBUG : four: Size and sha1 of src and dst objects identical 2021/11/13 06:41:53 DEBUG : four: Destination mod time is within 1s of source and files identical, skipping 2021/11/13 06:41:53 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb (Local file system at /tmp/rclone3419184883) 2021/11/13 06:41:53 DEBUG : three: sha1 = 03731cad13f4cf7b59703c77529381cdec1632e5 (B2 bucket rclone-test-quzexim3motamul9cupenas5) 2021/11/13 06:41:53 DEBUG : three: sha1 differ 2021/11/13 06:41:53 DEBUG : three: Destination mod time is within 1s of source but files differ, transferring 2021/11/13 06:41:53 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:41:54 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2021/11/13 06:41:54 INFO : three: Copied (replaced existing) 2021/11/13 06:41:54 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithUpdateOlder (9.99s) === 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-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" sync_test.go:1058: Can track renames: true 2021/11/13 06:42:00 INFO : B2 bucket rclone-test-quzexim3motamul9cupenas5: Making map for --track-renames 2021/11/13 06:42:00 INFO : B2 bucket rclone-test-quzexim3motamul9cupenas5: Finished making map for --track-renames 2021/11/13 06:42:00 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:42:00 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for renames to finish 2021/11/13 06:42:00 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:42:01 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2021/11/13 06:42:01 INFO : potato: Copied (new) 2021/11/13 06:42:02 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2021/11/13 06:42:02 INFO : yam: Copied (new) 2021/11/13 06:42:02 DEBUG : Waiting for deletions to finish 2021/11/13 06:42:02 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:42:02 DEBUG : potato: Unchanged skipping 2021/11/13 06:42:02 INFO : B2 bucket rclone-test-quzexim3motamul9cupenas5: Making map for --track-renames 2021/11/13 06:42:02 INFO : B2 bucket rclone-test-quzexim3motamul9cupenas5: Finished making map for --track-renames 2021/11/13 06:42:02 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:42:02 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for renames to finish 2021/11/13 06:42:03 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:42:04 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2021/11/13 06:42:04 INFO : yam: Copied (server-side copy) to: yaml 2021/11/13 06:42:05 INFO : yam: Deleted 2021/11/13 06:42:05 INFO : yaml: Renamed from "yam" 2021/11/13 06:42:05 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:42:05 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenames (8.01s) === RUN TestParseRenamesStrategyModtime --- PASS: TestParseRenamesStrategyModtime (0.00s) === RUN TestRenamesStrategyModtime --- PASS: TestRenamesStrategyModtime (0.00s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" sync_test.go:1127: Can track renames: true 2021/11/13 06:42:08 INFO : B2 bucket rclone-test-quzexim3motamul9cupenas5: Making map for --track-renames 2021/11/13 06:42:08 INFO : B2 bucket rclone-test-quzexim3motamul9cupenas5: Finished making map for --track-renames 2021/11/13 06:42:08 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:42:08 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for renames to finish 2021/11/13 06:42:08 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:42:09 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2021/11/13 06:42:09 INFO : yam: Copied (new) 2021/11/13 06:42:09 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2021/11/13 06:42:09 INFO : potato: Copied (new) 2021/11/13 06:42:09 DEBUG : Waiting for deletions to finish 2021/11/13 06:42:10 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:42:10 DEBUG : potato: Unchanged skipping 2021/11/13 06:42:10 INFO : B2 bucket rclone-test-quzexim3motamul9cupenas5: Making map for --track-renames 2021/11/13 06:42:10 INFO : B2 bucket rclone-test-quzexim3motamul9cupenas5: Finished making map for --track-renames 2021/11/13 06:42:10 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:42:10 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for renames to finish 2021/11/13 06:42:11 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:42:11 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2021/11/13 06:42:11 INFO : yam: Copied (server-side copy) to: yaml 2021/11/13 06:42:12 INFO : yam: Deleted 2021/11/13 06:42:12 INFO : yaml: Renamed from "yam" 2021/11/13 06:42:12 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:42:12 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenamesStrategyModtime (6.27s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" sync_test.go:1163: Can track renames: true 2021/11/13 06:42:14 INFO : B2 bucket rclone-test-quzexim3motamul9cupenas5: Making map for --track-renames 2021/11/13 06:42:14 INFO : B2 bucket rclone-test-quzexim3motamul9cupenas5: Finished making map for --track-renames 2021/11/13 06:42:14 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:42:14 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for renames to finish 2021/11/13 06:42:14 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:42:15 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2021/11/13 06:42:15 INFO : sub/yam: Copied (new) 2021/11/13 06:42:16 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2021/11/13 06:42:16 INFO : potato: Copied (new) 2021/11/13 06:42:16 DEBUG : Waiting for deletions to finish 2021/11/13 06:42:16 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:42:16 DEBUG : potato: Unchanged skipping 2021/11/13 06:42:17 INFO : B2 bucket rclone-test-quzexim3motamul9cupenas5: Making map for --track-renames 2021/11/13 06:42:17 INFO : B2 bucket rclone-test-quzexim3motamul9cupenas5: Finished making map for --track-renames 2021/11/13 06:42:17 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:42:17 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for renames to finish 2021/11/13 06:42:17 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:42:18 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2021/11/13 06:42:18 INFO : sub/yam: Copied (server-side copy) to: yam 2021/11/13 06:42:24 INFO : sub/yam: Deleted 2021/11/13 06:42:24 INFO : yam: Renamed from "sub/yam" 2021/11/13 06:42:24 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:42:24 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenamesStrategyLeaf (11.49s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:42:26 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:42:26 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:42:27 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2021/11/13 06:42:27 INFO : nested/sub dir/file: Copied (new) 2021/11/13 06:42:27 INFO : nested/sub dir/file: Deleted 2021/11/13 06:42:27 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/11/13 06:42:27 INFO : sub dir/hello world: Copied (new) 2021/11/13 06:42:27 INFO : sub dir/hello world: Deleted 2021/11/13 06:42:27 INFO : sub dir: Removing directory 2021/11/13 06:42:27 INFO : nested/sub dir: Removing directory 2021/11/13 06:42:27 INFO : nested: Removing directory 2021/11/13 06:42:27 DEBUG : Local file system at /tmp/rclone3419184883: deleted 3 directories --- PASS: TestMoveWithDeleteEmptySrcDirs (4.33s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:42:30 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:42:30 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:42:30 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2021/11/13 06:42:30 INFO : nested/sub dir/file: Copied (new) 2021/11/13 06:42:30 INFO : nested/sub dir/file: Deleted 2021/11/13 06:42:32 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2021/11/13 06:42:32 INFO : sub dir/hello world: Copied (new) 2021/11/13 06:42:32 INFO : sub dir/hello world: Deleted --- PASS: TestMoveWithoutDeleteEmptySrcDirs (4.12s) === RUN TestMoveWithIgnoreExisting run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:42:34 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:42:34 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:42:35 DEBUG : existing-b: sha1 = 321f6b7e8bf7f29aab89c5e41a555b1b0baa41a9 OK 2021/11/13 06:42:35 INFO : existing-b: Copied (new) 2021/11/13 06:42:35 INFO : existing-b: Deleted 2021/11/13 06:42:35 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2021/11/13 06:42:35 INFO : existing: Copied (new) 2021/11/13 06:42:35 INFO : existing: Deleted 2021/11/13 06:42:36 DEBUG : existing: Destination exists, skipping 2021/11/13 06:42:36 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2021/11/13 06:42:36 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:42:36 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:42:36 INFO : There was nothing to transfer --- PASS: TestMoveWithIgnoreExisting (3.09s) === RUN TestServerSideMove run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:42:37 DEBUG : Creating backend with remote "TestB2:rclone-test-xoxibev1fobitor3lipamas1" sync_test.go:1215: Server side move (if possible) B2 bucket rclone-test-quzexim3motamul9cupenas5 -> B2 bucket rclone-test-xoxibev1fobitor3lipamas1 2021/11/13 06:42:43 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ms) 2021/11/13 06:42:43 DEBUG : empty space: Unchanged skipping 2021/11/13 06:42:43 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2021/11/13 06:42:43 DEBUG : B2 bucket rclone-test-xoxibev1fobitor3lipamas1: Waiting for checks to finish 2021/11/13 06:42:44 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2021/11/13 06:42:44 INFO : potato3: Copied (server-side copy) 2021/11/13 06:42:44 INFO : potato3: Deleted 2021/11/13 06:42:45 INFO : empty space: Deleted 2021/11/13 06:42:45 DEBUG : B2 bucket rclone-test-xoxibev1fobitor3lipamas1: Waiting for transfers to finish 2021/11/13 06:42:45 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/11/13 06:42:45 INFO : potato2: Copied (server-side copy) 2021/11/13 06:42:46 INFO : potato2: Deleted 2021/11/13 06:42:47 DEBUG : Creating backend with remote "TestB2:rclone-test-jonolen5biqodav1pugizaf9" 2021/11/13 06:42:48 DEBUG : B2 bucket rclone-test-jonolen5biqodav1pugizaf9: Waiting for checks to finish 2021/11/13 06:42:48 DEBUG : B2 bucket rclone-test-jonolen5biqodav1pugizaf9: Waiting for transfers to finish 2021/11/13 06:42:48 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/11/13 06:42:48 INFO : potato2: Copied (server-side copy) 2021/11/13 06:42:48 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2021/11/13 06:42:48 INFO : empty space: Copied (server-side copy) 2021/11/13 06:42:49 INFO : empty space: Deleted 2021/11/13 06:42:49 INFO : potato2: Deleted 2021/11/13 06:42:49 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2021/11/13 06:42:49 INFO : potato3: Copied (server-side copy) 2021/11/13 06:42:50 INFO : potato3: Deleted 2021/11/13 06:42:50 DEBUG : B2 bucket rclone-test-jonolen5biqodav1pugizaf9: Purge remote 2021/11/13 06:42:50 DEBUG : empty space: Deleting (id "4_z0f52cd73008d1b8b7fd80e1b_f11804d53d9fc8cab_d20211113_m064248_c001_v0001130_t0023") 2021/11/13 06:42:50 DEBUG : potato2: Deleting (id "4_z0f52cd73008d1b8b7fd80e1b_f1043f1464c640905_d20211113_m064248_c001_v0001041_t0013") 2021/11/13 06:42:50 DEBUG : potato3: Deleting (id "4_z0f52cd73008d1b8b7fd80e1b_f11125cb3af51c2e1_d20211113_m064248_c001_v0001090_t0059") 2021/11/13 06:42:51 DEBUG : B2 bucket rclone-test-xoxibev1fobitor3lipamas1: Purge remote 2021/11/13 06:42:51 DEBUG : empty space: Deleting (id "4_zcf02ad93008d1b8b7fd80e1b_f1133df744da2e7c5_d20211113_m064249_c001_v0001091_t0020") 2021/11/13 06:42:51 DEBUG : empty space: Deleting (id "4_zcf02ad93008d1b8b7fd80e1b_f11782c3578ab0ebf_d20211113_m064241_c001_v0001022_t0004") 2021/11/13 06:42:51 DEBUG : potato2: Deleting (id "4_zcf02ad93008d1b8b7fd80e1b_f108f87930ed2643a_d20211113_m064248_c001_v0001022_t0008") 2021/11/13 06:42:51 DEBUG : potato2: Deleting (id "4_zcf02ad93008d1b8b7fd80e1b_f1164361b7bc3949d_d20211113_m064245_c001_v0001150_t0026") 2021/11/13 06:42:51 DEBUG : potato3: Deleting (id "4_zcf02ad93008d1b8b7fd80e1b_f11380a197ad5ad3f_d20211113_m064249_c001_v0001030_t0017") 2021/11/13 06:42:51 DEBUG : potato3: Deleting (id "4_zcf02ad93008d1b8b7fd80e1b_f104af2623b08eb40_d20211113_m064244_c001_v0001012_t0032") 2021/11/13 06:42:51 DEBUG : potato3: Deleting (id "4_zcf02ad93008d1b8b7fd80e1b_f11782c3578ab0ec1_d20211113_m064242_c001_v0001022_t0012") --- PASS: TestServerSideMove (15.25s) === RUN TestServerSideMoveWithFilter run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:42:52 DEBUG : Creating backend with remote "TestB2:rclone-test-vesabaz0dufanes0vecojom4" sync_test.go:1215: Server side move (if possible) B2 bucket rclone-test-quzexim3motamul9cupenas5 -> B2 bucket rclone-test-vesabaz0dufanes0vecojom4 2021/11/13 06:43:01 DEBUG : empty space: Excluded 2021/11/13 06:43:01 DEBUG : empty space: Excluded 2021/11/13 06:43:01 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2021/11/13 06:43:01 DEBUG : B2 bucket rclone-test-vesabaz0dufanes0vecojom4: Waiting for checks to finish 2021/11/13 06:43:01 DEBUG : B2 bucket rclone-test-vesabaz0dufanes0vecojom4: Waiting for transfers to finish 2021/11/13 06:43:01 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/11/13 06:43:01 INFO : potato2: Copied (server-side copy) 2021/11/13 06:43:02 INFO : potato2: Deleted 2021/11/13 06:43:05 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2021/11/13 06:43:05 INFO : potato3: Copied (server-side copy) 2021/11/13 06:43:06 INFO : potato3: Deleted 2021/11/13 06:43:06 DEBUG : Creating backend with remote "TestB2:rclone-test-hixavox3niqawed3qohujin5" 2021/11/13 06:43:06 DEBUG : Config file has changed externaly - reloading 2021/11/13 06:43:07 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_list_file_names": EOF) 2021/11/13 06:43:07 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2021/11/13 06:43:07 DEBUG : pacer: Reducing sleep to 10ms 2021/11/13 06:43:07 DEBUG : empty space: Excluded 2021/11/13 06:43:07 DEBUG : B2 bucket rclone-test-hixavox3niqawed3qohujin5: Waiting for checks to finish 2021/11/13 06:43:07 DEBUG : B2 bucket rclone-test-hixavox3niqawed3qohujin5: Waiting for transfers to finish 2021/11/13 06:43:08 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/11/13 06:43:08 INFO : potato2: Copied (server-side copy) 2021/11/13 06:43:09 INFO : potato2: Deleted 2021/11/13 06:43:09 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2021/11/13 06:43:09 INFO : potato3: Copied (server-side copy) 2021/11/13 06:43:10 INFO : potato3: Deleted 2021/11/13 06:43:10 DEBUG : B2 bucket rclone-test-hixavox3niqawed3qohujin5: Purge remote 2021/11/13 06:43:10 DEBUG : potato2: Deleting (id "4_z7f721d43009d1b8b7fd80e1b_f1066554177e981f3_d20211113_m064308_c001_v0001130_t0009") 2021/11/13 06:43:10 DEBUG : potato3: Deleting (id "4_z7f721d43009d1b8b7fd80e1b_f102fc55192f96785_d20211113_m064308_c001_v0001120_t0023") 2021/11/13 06:43:11 DEBUG : B2 bucket rclone-test-vesabaz0dufanes0vecojom4: Purge remote 2021/11/13 06:43:11 DEBUG : empty space: Deleting (id "4_z4ff2eda3008d1b8b7fd80e1b_f104bda439de181e3_d20211113_m064258_c001_v0001097_t0042") 2021/11/13 06:43:11 DEBUG : potato2: Deleting (id "4_z4ff2eda3008d1b8b7fd80e1b_f1023864098a6d8ed_d20211113_m064308_c001_v0001019_t0002") 2021/11/13 06:43:11 DEBUG : potato2: Deleting (id "4_z4ff2eda3008d1b8b7fd80e1b_f1069d78f9ca039c9_d20211113_m064301_c001_v0001165_t0040") 2021/11/13 06:43:11 DEBUG : potato3: Deleting (id "4_z4ff2eda3008d1b8b7fd80e1b_f104bda439de1829c_d20211113_m064309_c001_v0001097_t0018") 2021/11/13 06:43:11 DEBUG : potato3: Deleting (id "4_z4ff2eda3008d1b8b7fd80e1b_f109981f280315af9_d20211113_m064301_c001_v0001131_t0047") 2021/11/13 06:43:11 DEBUG : potato3: Deleting (id "4_z4ff2eda3008d1b8b7fd80e1b_f104bda439de181f8_d20211113_m064259_c001_v0001097_t0037") --- PASS: TestServerSideMoveWithFilter (20.76s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:43:13 DEBUG : Creating backend with remote "TestB2:rclone-test-beceneh4saluvey2potanes7" 2021/11/13 06:43:17 DEBUG : tomatoDir: Making directory sync_test.go:1215: Server side move (if possible) B2 bucket rclone-test-quzexim3motamul9cupenas5 -> B2 bucket rclone-test-beceneh4saluvey2potanes7 2021/11/13 06:43:19 DEBUG : B2 bucket rclone-test-beceneh4saluvey2potanes7: Waiting for checks to finish 2021/11/13 06:43:19 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2021/11/13 06:43:19 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ms) 2021/11/13 06:43:19 DEBUG : empty space: Unchanged skipping 2021/11/13 06:43:19 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2021/11/13 06:43:19 INFO : potato3: Copied (server-side copy) 2021/11/13 06:43:20 INFO : potato3: Deleted 2021/11/13 06:43:20 INFO : empty space: Deleted 2021/11/13 06:43:20 DEBUG : B2 bucket rclone-test-beceneh4saluvey2potanes7: Waiting for transfers to finish 2021/11/13 06:43:20 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/11/13 06:43:20 INFO : potato2: Copied (server-side copy) 2021/11/13 06:43:21 INFO : potato2: Deleted 2021/11/13 06:43:22 DEBUG : Creating backend with remote "TestB2:rclone-test-dapotay4telihot6gucerak5" 2021/11/13 06:43:23 DEBUG : tomatoDir: Making directory 2021/11/13 06:43:23 DEBUG : B2 bucket rclone-test-dapotay4telihot6gucerak5: Waiting for checks to finish 2021/11/13 06:43:23 DEBUG : B2 bucket rclone-test-dapotay4telihot6gucerak5: Waiting for transfers to finish 2021/11/13 06:43:24 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2021/11/13 06:43:24 INFO : empty space: Copied (server-side copy) 2021/11/13 06:43:24 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2021/11/13 06:43:24 INFO : potato3: Copied (server-side copy) 2021/11/13 06:43:25 INFO : empty space: Deleted 2021/11/13 06:43:25 INFO : potato3: Deleted 2021/11/13 06:43:26 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/11/13 06:43:26 INFO : potato2: Copied (server-side copy) 2021/11/13 06:43:26 INFO : potato2: Deleted 2021/11/13 06:43:27 DEBUG : B2 bucket rclone-test-dapotay4telihot6gucerak5: Purge remote 2021/11/13 06:43:27 DEBUG : empty space: Deleting (id "4_zcf125d03009d1b8b7fd80e1b_f101a0212b27480a6_d20211113_m064323_c001_v0001091_t0057") 2021/11/13 06:43:27 DEBUG : potato2: Deleting (id "4_zcf125d03009d1b8b7fd80e1b_f1077e7fdfa1ab5d0_d20211113_m064323_c001_v0001001_t0032") 2021/11/13 06:43:27 DEBUG : potato3: Deleting (id "4_zcf125d03009d1b8b7fd80e1b_f105f668f7fba0e56_d20211113_m064323_c001_v0001043_t0048") 2021/11/13 06:43:28 DEBUG : B2 bucket rclone-test-beceneh4saluvey2potanes7: Purge remote 2021/11/13 06:43:28 DEBUG : empty space: Deleting (id "4_zef623d93009d1b8b7fd80e1b_f11125cb3af51c335_d20211113_m064324_c001_v0001090_t0016") 2021/11/13 06:43:28 DEBUG : empty space: Deleting (id "4_zef623d93009d1b8b7fd80e1b_f11033dfd6384622f_d20211113_m064318_c001_v0001146_t0002") 2021/11/13 06:43:28 DEBUG : potato2: Deleting (id "4_zef623d93009d1b8b7fd80e1b_f1069d78f9ca03a98_d20211113_m064326_c001_v0001165_t0006") 2021/11/13 06:43:28 DEBUG : potato2: Deleting (id "4_zef623d93009d1b8b7fd80e1b_f104ed1b008296aea_d20211113_m064319_c001_v0001120_t0047") 2021/11/13 06:43:28 DEBUG : potato3: Deleting (id "4_zef623d93009d1b8b7fd80e1b_f114a305c1865d12d_d20211113_m064324_c001_v0001097_t0045") 2021/11/13 06:43:28 DEBUG : potato3: Deleting (id "4_zef623d93009d1b8b7fd80e1b_f112bda3d37894467_d20211113_m064320_c001_v0001165_t0010") 2021/11/13 06:43:28 DEBUG : potato3: Deleting (id "4_zef623d93009d1b8b7fd80e1b_f11033dfd63846231_d20211113_m064319_c001_v0001146_t0042") --- PASS: TestServerSideMoveDeleteEmptySourceDirs (16.10s) === RUN TestServerSideMoveOverlap run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:43:29 DEBUG : Creating backend with remote "TestB2:rclone-test-quzexim3motamul9cupenas5/rclone-move-test" 2021/11/13 06:43:31 DEBUG : Couldn't decode error response: EOF --- PASS: TestServerSideMoveOverlap (5.08s) === RUN TestSyncOverlap run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:43:34 DEBUG : Creating backend with remote "TestB2:rclone-test-quzexim3motamul9cupenas5/rclone-sync-test" 2021/11/13 06:43:35 DEBUG : Couldn't decode error response: EOF --- PASS: TestSyncOverlap (0.75s) === RUN TestSyncCompareDest run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:43:35 DEBUG : Creating backend with remote "TestB2:rclone-test-quzexim3motamul9cupenas5/dst" 2021/11/13 06:43:36 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:43:36 DEBUG : Creating backend with remote "TestB2:rclone-test-quzexim3motamul9cupenas5/CompareDest" 2021/11/13 06:43:36 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:43:37 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:43:37 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for checks to finish 2021/11/13 06:43:37 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for transfers to finish 2021/11/13 06:43:39 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/11/13 06:43:39 INFO : one: Copied (new) 2021/11/13 06:43:39 DEBUG : Waiting for deletions to finish 2021/11/13 06:43:39 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for checks to finish 2021/11/13 06:43:39 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:43:39 DEBUG : one: Sizes differ (src 5 vs dst 3) 2021/11/13 06:43:39 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for transfers to finish 2021/11/13 06:43:40 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2021/11/13 06:43:40 INFO : one: Copied (replaced existing) 2021/11/13 06:43:40 DEBUG : Waiting for deletions to finish 2021/11/13 06:43:42 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for checks to finish 2021/11/13 06:43:42 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/11/13 06:43:42 DEBUG : one: Destination found in --compare-dest, skipping 2021/11/13 06:43:42 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for transfers to finish 2021/11/13 06:43:42 DEBUG : Waiting for deletions to finish 2021/11/13 06:43:42 INFO : There was nothing to transfer 2021/11/13 06:43:44 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/11/13 06:43:44 DEBUG : two: Destination found in --compare-dest, skipping 2021/11/13 06:43:44 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for checks to finish 2021/11/13 06:43:45 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/11/13 06:43:45 DEBUG : one: Destination found in --compare-dest, skipping 2021/11/13 06:43:45 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for transfers to finish 2021/11/13 06:43:45 DEBUG : Waiting for deletions to finish 2021/11/13 06:43:45 INFO : There was nothing to transfer 2021/11/13 06:43:45 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/11/13 06:43:45 DEBUG : two: Destination found in --compare-dest, skipping 2021/11/13 06:43:45 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for checks to finish 2021/11/13 06:43:45 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/11/13 06:43:45 DEBUG : one: Destination found in --compare-dest, skipping 2021/11/13 06:43:45 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for transfers to finish 2021/11/13 06:43:45 DEBUG : Waiting for deletions to finish 2021/11/13 06:43:45 INFO : There was nothing to transfer 2021/11/13 06:43:46 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/11/13 06:43:46 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2021/11/13 06:43:46 DEBUG : two: Destination found in --compare-dest, skipping 2021/11/13 06:43:46 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for checks to finish 2021/11/13 06:43:46 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/11/13 06:43:46 DEBUG : one: Destination found in --compare-dest, skipping 2021/11/13 06:43:46 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for transfers to finish 2021/11/13 06:43:46 DEBUG : Waiting for deletions to finish 2021/11/13 06:43:46 INFO : There was nothing to transfer 2021/11/13 06:43:47 DEBUG : two: Sizes differ (src 5 vs dst 3) 2021/11/13 06:43:47 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for checks to finish 2021/11/13 06:43:47 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/11/13 06:43:47 DEBUG : one: Destination found in --compare-dest, skipping 2021/11/13 06:43:47 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for transfers to finish 2021/11/13 06:43:48 DEBUG : two: sha1 = a4be8877ad88f3109a6411985a1f359e10e2d930 OK 2021/11/13 06:43:48 INFO : two: Copied (new) 2021/11/13 06:43:48 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (16.96s) === RUN TestSyncMultipleCompareDest run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:43:54 DEBUG : Creating backend with remote "TestB2:rclone-test-quzexim3motamul9cupenas5/dest" 2021/11/13 06:43:56 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:43:56 DEBUG : Creating backend with remote "TestB2:rclone-test-quzexim3motamul9cupenas5/pre-dest1" 2021/11/13 06:43:56 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:43:56 DEBUG : Creating backend with remote "TestB2:rclone-test-quzexim3motamul9cupenas5/pre-dest2" 2021/11/13 06:43:56 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:43:57 DEBUG : 1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:43:57 DEBUG : 1: Destination found in --compare-dest, skipping 2021/11/13 06:43:57 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:43:57 DEBUG : 2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:43:57 DEBUG : 2: Destination found in --compare-dest, skipping 2021/11/13 06:43:58 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:43:58 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:43:58 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dest: Waiting for checks to finish 2021/11/13 06:43:58 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dest: Waiting for transfers to finish 2021/11/13 06:43:59 DEBUG : 3: sha1 = 77de68daecd823babbb58edb1c8e14d7106e83bb OK 2021/11/13 06:43:59 INFO : 3: Copied (new) 2021/11/13 06:43:59 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (11.82s) === RUN TestSyncCopyDest run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:44:04 DEBUG : Creating backend with remote "TestB2:rclone-test-quzexim3motamul9cupenas5/dst" 2021/11/13 06:44:05 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:44:05 DEBUG : Creating backend with remote "TestB2:rclone-test-quzexim3motamul9cupenas5/CopyDest" 2021/11/13 06:44:06 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:44:06 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:44:06 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for checks to finish 2021/11/13 06:44:06 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for transfers to finish 2021/11/13 06:44:08 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/11/13 06:44:08 INFO : one: Copied (new) 2021/11/13 06:44:08 DEBUG : Waiting for deletions to finish 2021/11/13 06:44:08 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for checks to finish 2021/11/13 06:44:09 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:44:09 DEBUG : one: Sizes differ (src 5 vs dst 3) 2021/11/13 06:44:09 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for transfers to finish 2021/11/13 06:44:10 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2021/11/13 06:44:10 INFO : one: Copied (replaced existing) 2021/11/13 06:44:10 DEBUG : Waiting for deletions to finish 2021/11/13 06:44:13 DEBUG : Creating backend with remote "TestB2:rclone-test-quzexim3motamul9cupenas5/BackupDir" 2021/11/13 06:44:14 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:44:14 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for checks to finish 2021/11/13 06:44:15 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/11/13 06:44:15 DEBUG : one: Sizes differ (src 5 vs dst 3) 2021/11/13 06:44:15 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:44:17 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/11/13 06:44:17 INFO : one: Copied (server-side copy) 2021/11/13 06:44:18 INFO : one: Deleted 2021/11/13 06:44:19 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2021/11/13 06:44:19 INFO : one: Copied (server-side copy) 2021/11/13 06:44:19 DEBUG : one: Destination found in --copy-dest, using server-side copy 2021/11/13 06:44:19 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for transfers to finish 2021/11/13 06:44:19 DEBUG : Waiting for deletions to finish 2021/11/13 06:44:21 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/11/13 06:44:21 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2021/11/13 06:44:21 INFO : two: Copied (server-side copy) 2021/11/13 06:44:21 DEBUG : two: Destination found in --copy-dest, using server-side copy 2021/11/13 06:44:21 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for checks to finish 2021/11/13 06:44:22 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/11/13 06:44:22 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/11/13 06:44:22 DEBUG : one: Unchanged skipping 2021/11/13 06:44:22 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for transfers to finish 2021/11/13 06:44:22 DEBUG : Waiting for deletions to finish 2021/11/13 06:44:22 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for checks to finish 2021/11/13 06:44:22 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/11/13 06:44:22 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/11/13 06:44:22 DEBUG : one: Unchanged skipping 2021/11/13 06:44:22 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/11/13 06:44:22 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/11/13 06:44:22 DEBUG : two: Unchanged skipping 2021/11/13 06:44:22 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for transfers to finish 2021/11/13 06:44:22 DEBUG : Waiting for deletions to finish 2021/11/13 06:44:22 INFO : There was nothing to transfer 2021/11/13 06:44:24 DEBUG : three: Sizes differ (src 7 vs dst 5) 2021/11/13 06:44:24 DEBUG : three: Destination not found in --copy-dest 2021/11/13 06:44:24 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for checks to finish 2021/11/13 06:44:24 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/11/13 06:44:24 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/11/13 06:44:24 DEBUG : one: Unchanged skipping 2021/11/13 06:44:24 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/11/13 06:44:24 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/11/13 06:44:24 DEBUG : two: Unchanged skipping 2021/11/13 06:44:24 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for transfers to finish 2021/11/13 06:44:25 DEBUG : three: sha1 = 370e613335f3cf2f19b2a2d35a86402f55c659f8 OK 2021/11/13 06:44:25 INFO : three: Copied (new) 2021/11/13 06:44:25 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCopyDest (38.19s) === RUN TestSyncBackupDir run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:44:46 DEBUG : Creating backend with remote "TestB2:rclone-test-quzexim3motamul9cupenas5/dst" 2021/11/13 06:44:47 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:44:47 DEBUG : Creating backend with remote "TestB2:rclone-test-quzexim3motamul9cupenas5/backup" 2021/11/13 06:44:48 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:44:48 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for checks to finish 2021/11/13 06:44:48 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/11/13 06:44:48 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:44:48 DEBUG : two: Unchanged skipping 2021/11/13 06:44:48 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:44:50 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/11/13 06:44:50 INFO : one: Copied (server-side copy) 2021/11/13 06:44:51 INFO : one: Deleted 2021/11/13 06:44:51 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for transfers to finish 2021/11/13 06:44:54 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/11/13 06:44:54 INFO : one: Copied (new) 2021/11/13 06:44:54 DEBUG : Waiting for deletions to finish 2021/11/13 06:44:55 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:44:55 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2021/11/13 06:44:55 INFO : three.txt: Copied (server-side copy) 2021/11/13 06:44:56 INFO : three.txt: Deleted 2021/11/13 06:44:56 INFO : three.txt: Moved into backup dir 2021/11/13 06:44:57 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/11/13 06:44:57 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:44:57 DEBUG : two: Unchanged skipping 2021/11/13 06:44:57 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for checks to finish 2021/11/13 06:44:59 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/11/13 06:44:59 INFO : one: Copied (server-side copy) 2021/11/13 06:45:02 INFO : one: Deleted 2021/11/13 06:45:02 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for transfers to finish 2021/11/13 06:45:03 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2021/11/13 06:45:03 INFO : one: Copied (new) 2021/11/13 06:45:03 DEBUG : Waiting for deletions to finish 2021/11/13 06:45:05 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2021/11/13 06:45:05 INFO : three.txt: Copied (server-side copy) 2021/11/13 06:45:05 INFO : three.txt: Deleted 2021/11/13 06:45:05 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (26.83s) === RUN TestSyncBackupDirWithSuffix run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:45:12 DEBUG : Creating backend with remote "TestB2:rclone-test-quzexim3motamul9cupenas5/dst" 2021/11/13 06:45:14 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:45:14 DEBUG : Creating backend with remote "TestB2:rclone-test-quzexim3motamul9cupenas5/backup" 2021/11/13 06:45:14 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:45:15 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/11/13 06:45:15 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for checks to finish 2021/11/13 06:45:15 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:45:15 DEBUG : two: Unchanged skipping 2021/11/13 06:45:15 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:45:17 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/11/13 06:45:17 INFO : one: Copied (server-side copy) to: one.bak 2021/11/13 06:45:17 INFO : one: Deleted 2021/11/13 06:45:17 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for transfers to finish 2021/11/13 06:45:19 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/11/13 06:45:19 INFO : one: Copied (new) 2021/11/13 06:45:19 DEBUG : Waiting for deletions to finish 2021/11/13 06:45:19 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:45:19 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2021/11/13 06:45:19 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2021/11/13 06:45:19 INFO : three.txt: Deleted 2021/11/13 06:45:19 INFO : three.txt: Moved into backup dir 2021/11/13 06:45:21 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/11/13 06:45:21 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for checks to finish 2021/11/13 06:45:21 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:45:21 DEBUG : two: Unchanged skipping 2021/11/13 06:45:22 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/11/13 06:45:22 INFO : one: Copied (server-side copy) to: one.bak 2021/11/13 06:45:23 INFO : one: Deleted 2021/11/13 06:45:23 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for transfers to finish 2021/11/13 06:45:24 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2021/11/13 06:45:24 INFO : one: Copied (new) 2021/11/13 06:45:24 DEBUG : Waiting for deletions to finish 2021/11/13 06:45:24 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2021/11/13 06:45:24 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2021/11/13 06:45:25 INFO : three.txt: Deleted 2021/11/13 06:45:25 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (17.89s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:45:30 DEBUG : Creating backend with remote "TestB2:rclone-test-quzexim3motamul9cupenas5/dst" 2021/11/13 06:45:31 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:45:31 DEBUG : Creating backend with remote "TestB2:rclone-test-quzexim3motamul9cupenas5/backup" 2021/11/13 06:45:32 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:45:32 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/11/13 06:45:32 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:45:32 DEBUG : two: Unchanged skipping 2021/11/13 06:45:32 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for checks to finish 2021/11/13 06:45:32 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:45:34 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/11/13 06:45:34 INFO : one: Copied (server-side copy) to: one-2019-01-01 2021/11/13 06:45:35 INFO : one: Deleted 2021/11/13 06:45:35 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for transfers to finish 2021/11/13 06:45:36 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/11/13 06:45:36 INFO : one: Copied (new) 2021/11/13 06:45:36 DEBUG : Waiting for deletions to finish 2021/11/13 06:45:36 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:45:36 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2021/11/13 06:45:36 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2021/11/13 06:45:37 INFO : three.txt: Deleted 2021/11/13 06:45:37 INFO : three.txt: Moved into backup dir 2021/11/13 06:45:39 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/11/13 06:45:39 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:45:39 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for checks to finish 2021/11/13 06:45:39 DEBUG : two: Unchanged skipping 2021/11/13 06:45:40 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/11/13 06:45:40 INFO : one: Copied (server-side copy) to: one-2019-01-01 2021/11/13 06:45:40 INFO : one: Deleted 2021/11/13 06:45:40 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for transfers to finish 2021/11/13 06:45:41 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2021/11/13 06:45:41 INFO : one: Copied (new) 2021/11/13 06:45:41 DEBUG : Waiting for deletions to finish 2021/11/13 06:45:45 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2021/11/13 06:45:45 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2021/11/13 06:45:45 INFO : three.txt: Deleted 2021/11/13 06:45:45 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (21.71s) === RUN TestSyncBackupDirSuffixOnly run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:45:52 DEBUG : Creating backend with remote "TestB2:rclone-test-quzexim3motamul9cupenas5/dst" 2021/11/13 06:45:53 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:45:54 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for checks to finish 2021/11/13 06:45:54 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/11/13 06:45:54 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:45:54 DEBUG : two: Unchanged skipping 2021/11/13 06:45:54 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:45:55 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/11/13 06:45:55 INFO : one: Copied (server-side copy) to: one.bak 2021/11/13 06:45:55 INFO : one: Deleted 2021/11/13 06:45:55 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for transfers to finish 2021/11/13 06:45:57 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/11/13 06:45:57 INFO : one: Copied (new) 2021/11/13 06:45:57 DEBUG : Waiting for deletions to finish 2021/11/13 06:45:57 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:45:58 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2021/11/13 06:45:58 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2021/11/13 06:45:59 INFO : three.txt: Deleted 2021/11/13 06:45:59 INFO : three.txt: Moved into backup dir 2021/11/13 06:46:00 DEBUG : one.bak: Excluded 2021/11/13 06:46:00 DEBUG : three.txt.bak: Excluded 2021/11/13 06:46:00 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/11/13 06:46:00 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:46:00 DEBUG : two: Unchanged skipping 2021/11/13 06:46:00 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for checks to finish 2021/11/13 06:46:05 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/11/13 06:46:05 INFO : one: Copied (server-side copy) to: one.bak 2021/11/13 06:46:06 INFO : one: Deleted 2021/11/13 06:46:06 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5 path dst: Waiting for transfers to finish 2021/11/13 06:46:08 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2021/11/13 06:46:08 INFO : one: Copied (new) 2021/11/13 06:46:08 DEBUG : Waiting for deletions to finish 2021/11/13 06:46:12 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2021/11/13 06:46:12 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2021/11/13 06:46:13 INFO : three.txt: Deleted 2021/11/13 06:46:13 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (29.06s) === RUN TestSyncSuffix run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:46:21 DEBUG : Creating backend with remote "TestB2:rclone-test-quzexim3motamul9cupenas5/dst" 2021/11/13 06:46:22 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:46:22 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/11/13 06:46:23 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:46:24 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/11/13 06:46:24 INFO : one: Copied (server-side copy) to: one.bak 2021/11/13 06:46:25 INFO : one: Deleted 2021/11/13 06:46:26 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/11/13 06:46:26 INFO : one: Copied (new) 2021/11/13 06:46:27 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:46:27 DEBUG : two: Unchanged skipping 2021/11/13 06:46:27 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2021/11/13 06:46:27 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:46:28 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2021/11/13 06:46:28 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2021/11/13 06:46:28 INFO : three.txt: Deleted 2021/11/13 06:46:30 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2021/11/13 06:46:30 INFO : three.txt: Copied (new) 2021/11/13 06:46:30 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/11/13 06:46:31 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/11/13 06:46:31 INFO : one: Copied (server-side copy) to: one.bak 2021/11/13 06:46:31 INFO : one: Deleted 2021/11/13 06:46:32 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2021/11/13 06:46:32 INFO : one: Copied (new) 2021/11/13 06:46:32 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:46:32 DEBUG : two: Unchanged skipping 2021/11/13 06:46:32 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2021/11/13 06:46:38 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2021/11/13 06:46:38 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2021/11/13 06:46:40 INFO : three.txt: Deleted 2021/11/13 06:46:41 DEBUG : three.txt: sha1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK 2021/11/13 06:46:41 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (28.67s) === RUN TestSyncSuffixKeepExtension run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:46:50 DEBUG : Creating backend with remote "TestB2:rclone-test-quzexim3motamul9cupenas5/dst" 2021/11/13 06:46:51 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:46:51 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/11/13 06:46:51 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:46:54 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/11/13 06:46:54 INFO : one: Copied (server-side copy) to: one-2019-01-01 2021/11/13 06:46:54 INFO : one: Deleted 2021/11/13 06:46:55 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/11/13 06:46:55 INFO : one: Copied (new) 2021/11/13 06:46:56 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:46:56 DEBUG : two: Unchanged skipping 2021/11/13 06:46:56 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2021/11/13 06:46:56 DEBUG : Couldn't decode error response: EOF 2021/11/13 06:46:57 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2021/11/13 06:46:57 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2021/11/13 06:46:57 INFO : three.txt: Deleted 2021/11/13 06:46:58 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2021/11/13 06:46:58 INFO : three.txt: Copied (new) 2021/11/13 06:46:58 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/11/13 06:46:59 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2021/11/13 06:46:59 INFO : one: Copied (server-side copy) to: one-2019-01-01 2021/11/13 06:46:59 INFO : one: Deleted 2021/11/13 06:47:01 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2021/11/13 06:47:01 INFO : one: Copied (new) 2021/11/13 06:47:01 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:47:01 DEBUG : two: Unchanged skipping 2021/11/13 06:47:01 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2021/11/13 06:47:01 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2021/11/13 06:47:01 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2021/11/13 06:47:03 INFO : three.txt: Deleted 2021/11/13 06:47:03 DEBUG : three.txt: sha1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK 2021/11/13 06:47:03 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (25.07s) === RUN TestSyncUTFNorm run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:47:13 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:47:13 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2021/11/13 06:47:13 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:47:15 DEBUG : Testêé: sha1 = a54d88e06612d820bc3be72877c74f257b561b19 OK 2021/11/13 06:47:15 INFO : Testêé: Copied (replaced existing) to: Testêé 2021/11/13 06:47:15 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (4.94s) === RUN TestSyncImmutable run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:47:17 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:47:17 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:47:17 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2021/11/13 06:47:17 INFO : existing: Copied (new) 2021/11/13 06:47:17 DEBUG : Waiting for deletions to finish 2021/11/13 06:47:18 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:47:18 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2021/11/13 06:47:18 ERROR : existing: Source and destination exist but do not match: immutable file modified 2021/11/13 06:47:18 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:47:18 ERROR : B2 bucket rclone-test-quzexim3motamul9cupenas5: not deleting files as there were IO errors 2021/11/13 06:47:18 ERROR : B2 bucket rclone-test-quzexim3motamul9cupenas5: not deleting directories as there were IO errors --- PASS: TestSyncImmutable (2.79s) === RUN TestSyncIgnoreCase run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:47:20 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:47:20 DEBUG : existing: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:47:20 DEBUG : existing: Unchanged skipping 2021/11/13 06:47:20 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:47:20 DEBUG : Waiting for deletions to finish 2021/11/13 06:47:20 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (3.81s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" sync_test.go:1989: This test only runs on local === RUN TestMaxTransfer/Soft run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" sync_test.go:1989: This test only runs on local === RUN TestMaxTransfer/Cautious run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" sync_test.go:1989: This test only runs on local --- PASS: TestMaxTransfer (1.08s) --- SKIP: TestMaxTransfer/Hard (0.36s) --- SKIP: TestMaxTransfer/Soft (0.36s) --- SKIP: TestMaxTransfer/Cautious (0.36s) === RUN TestSyncConcurrentDelete run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:47:47 DEBUG : both1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:47:47 DEBUG : both1: Unchanged skipping 2021/11/13 06:47:47 DEBUG : both11: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:47:47 DEBUG : both11: Unchanged skipping 2021/11/13 06:47:47 DEBUG : both12: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:47:47 DEBUG : both10: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:47:47 DEBUG : both10: Unchanged skipping 2021/11/13 06:47:47 DEBUG : both13: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:47:47 DEBUG : both13: Unchanged skipping 2021/11/13 06:47:47 DEBUG : both15: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:47:47 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:47:47 DEBUG : both12: Unchanged skipping 2021/11/13 06:47:47 DEBUG : both16: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:47:47 DEBUG : both16: Unchanged skipping 2021/11/13 06:47:47 DEBUG : both17: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:47:47 DEBUG : both17: Unchanged skipping 2021/11/13 06:47:47 DEBUG : both18: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:47:47 DEBUG : both18: Unchanged skipping 2021/11/13 06:47:47 DEBUG : both15: Unchanged skipping 2021/11/13 06:47:47 DEBUG : both19: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:47:47 DEBUG : both19: Unchanged skipping 2021/11/13 06:47:47 DEBUG : both3: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:47:47 DEBUG : both2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:47:47 DEBUG : both3: Unchanged skipping 2021/11/13 06:47:47 DEBUG : both2: Unchanged skipping 2021/11/13 06:47:47 DEBUG : both4: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:47:47 DEBUG : both5: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:47:47 DEBUG : both4: Unchanged skipping 2021/11/13 06:47:47 DEBUG : both0: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:47:47 DEBUG : both0: Unchanged skipping 2021/11/13 06:47:47 DEBUG : both7: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:47:47 DEBUG : both7: Unchanged skipping 2021/11/13 06:47:47 DEBUG : both8: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:47:47 DEBUG : both8: Unchanged skipping 2021/11/13 06:47:47 DEBUG : both9: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:47:47 DEBUG : both9: Unchanged skipping 2021/11/13 06:47:47 DEBUG : both14: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:47:47 DEBUG : both14: Unchanged skipping 2021/11/13 06:47:47 DEBUG : both5: Unchanged skipping 2021/11/13 06:47:47 DEBUG : both6: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:47:47 DEBUG : both6: Unchanged skipping 2021/11/13 06:47:47 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:47:47 DEBUG : Waiting for deletions to finish 2021/11/13 06:47:47 INFO : only11: Deleted 2021/11/13 06:47:48 INFO : only10: Deleted 2021/11/13 06:47:48 INFO : only4: Deleted 2021/11/13 06:47:48 INFO : only12: Deleted 2021/11/13 06:47:48 INFO : only17: Deleted 2021/11/13 06:47:48 INFO : only18: Deleted 2021/11/13 06:47:49 INFO : only5: Deleted 2021/11/13 06:47:49 INFO : only7: Deleted 2021/11/13 06:47:49 INFO : only8: Deleted 2021/11/13 06:47:49 INFO : only14: Deleted 2021/11/13 06:47:50 INFO : only2: Deleted 2021/11/13 06:47:50 INFO : only3: Deleted 2021/11/13 06:47:51 INFO : only6: Deleted 2021/11/13 06:47:51 INFO : only19: Deleted 2021/11/13 06:47:51 INFO : only16: Deleted 2021/11/13 06:47:51 INFO : only0: Deleted 2021/11/13 06:47:52 INFO : only1: Deleted 2021/11/13 06:47:52 INFO : only13: Deleted 2021/11/13 06:47:52 INFO : only9: Deleted 2021/11/13 06:47:52 INFO : only15: Deleted 2021/11/13 06:47:52 INFO : There was nothing to transfer --- PASS: TestSyncConcurrentDelete (47.60s) === RUN TestSyncConcurrentTruncate run.go:181: Remote "B2 bucket rclone-test-quzexim3motamul9cupenas5", Local "Local file system at /tmp/rclone3419184883", Modify Window "1ms" 2021/11/13 06:48:39 DEBUG : both1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:48:39 DEBUG : both1: Unchanged skipping 2021/11/13 06:48:39 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for checks to finish 2021/11/13 06:48:39 DEBUG : both11: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:48:39 DEBUG : both11: Unchanged skipping 2021/11/13 06:48:39 DEBUG : both12: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:48:39 DEBUG : both13: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:48:39 DEBUG : both10: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:48:39 DEBUG : both13: Unchanged skipping 2021/11/13 06:48:39 DEBUG : both14: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:48:39 DEBUG : both14: Unchanged skipping 2021/11/13 06:48:39 DEBUG : both15: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:48:39 DEBUG : both15: Unchanged skipping 2021/11/13 06:48:39 DEBUG : both12: Unchanged skipping 2021/11/13 06:48:39 DEBUG : both16: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:48:39 DEBUG : both16: Unchanged skipping 2021/11/13 06:48:39 DEBUG : both17: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:48:39 DEBUG : both17: Unchanged skipping 2021/11/13 06:48:39 DEBUG : both10: Unchanged skipping 2021/11/13 06:48:39 DEBUG : both19: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:48:39 DEBUG : both19: Unchanged skipping 2021/11/13 06:48:39 DEBUG : both2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:48:39 DEBUG : both3: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:48:39 DEBUG : both2: Unchanged skipping 2021/11/13 06:48:39 DEBUG : both4: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:48:39 DEBUG : both4: Unchanged skipping 2021/11/13 06:48:39 DEBUG : both5: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:48:39 DEBUG : both18: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:48:39 DEBUG : both5: Unchanged skipping 2021/11/13 06:48:39 DEBUG : both18: Unchanged skipping 2021/11/13 06:48:39 DEBUG : both6: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:48:39 DEBUG : both6: Unchanged skipping 2021/11/13 06:48:39 DEBUG : both7: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:48:39 DEBUG : both7: Unchanged skipping 2021/11/13 06:48:39 DEBUG : both8: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:48:39 DEBUG : both9: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:48:39 DEBUG : both8: Unchanged skipping 2021/11/13 06:48:39 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2021/11/13 06:48:39 DEBUG : both3: Unchanged skipping 2021/11/13 06:48:39 DEBUG : both9: Unchanged skipping 2021/11/13 06:48:39 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2021/11/13 06:48:39 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2021/11/13 06:48:39 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2021/11/13 06:48:39 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2021/11/13 06:48:39 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2021/11/13 06:48:39 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2021/11/13 06:48:39 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2021/11/13 06:48:39 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2021/11/13 06:48:39 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2021/11/13 06:48:39 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2021/11/13 06:48:39 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2021/11/13 06:48:39 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2021/11/13 06:48:39 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2021/11/13 06:48:39 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2021/11/13 06:48:39 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2021/11/13 06:48:39 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2021/11/13 06:48:39 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2021/11/13 06:48:39 DEBUG : both0: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/11/13 06:48:39 DEBUG : both0: Unchanged skipping 2021/11/13 06:48:39 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2021/11/13 06:48:39 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2021/11/13 06:48:39 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Waiting for transfers to finish 2021/11/13 06:48:39 DEBUG : only12: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/11/13 06:48:39 INFO : only12: Copied (replaced existing) 2021/11/13 06:48:39 DEBUG : only0: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/11/13 06:48:39 INFO : only0: Copied (replaced existing) 2021/11/13 06:48:39 DEBUG : only14: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/11/13 06:48:39 INFO : only14: Copied (replaced existing) 2021/11/13 06:48:39 DEBUG : only15: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/11/13 06:48:39 INFO : only15: Copied (replaced existing) 2021/11/13 06:48:40 DEBUG : only16: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/11/13 06:48:40 INFO : only16: Copied (replaced existing) 2021/11/13 06:48:40 DEBUG : only11: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/11/13 06:48:40 INFO : only11: Copied (replaced existing) 2021/11/13 06:48:40 DEBUG : only18: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/11/13 06:48:40 INFO : only18: Copied (replaced existing) 2021/11/13 06:48:40 DEBUG : only17: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/11/13 06:48:40 INFO : only17: Copied (replaced existing) 2021/11/13 06:48:40 DEBUG : only2: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/11/13 06:48:40 INFO : only2: Copied (replaced existing) 2021/11/13 06:48:40 DEBUG : only3: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/11/13 06:48:40 INFO : only3: Copied (replaced existing) 2021/11/13 06:48:40 DEBUG : only4: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/11/13 06:48:40 INFO : only4: Copied (replaced existing) 2021/11/13 06:48:40 DEBUG : only13: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/11/13 06:48:40 INFO : only13: Copied (replaced existing) 2021/11/13 06:48:40 DEBUG : only5: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/11/13 06:48:40 INFO : only5: Copied (replaced existing) 2021/11/13 06:48:41 DEBUG : only6: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/11/13 06:48:41 INFO : only6: Copied (replaced existing) 2021/11/13 06:48:41 DEBUG : only19: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/11/13 06:48:41 INFO : only19: Copied (replaced existing) 2021/11/13 06:48:41 DEBUG : only9: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/11/13 06:48:41 INFO : only9: Copied (replaced existing) 2021/11/13 06:48:41 DEBUG : only8: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/11/13 06:48:41 INFO : only8: Copied (replaced existing) 2021/11/13 06:48:41 DEBUG : only10: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/11/13 06:48:41 INFO : only10: Copied (replaced existing) 2021/11/13 06:48:41 DEBUG : only7: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/11/13 06:48:41 INFO : only7: Copied (replaced existing) 2021/11/13 06:48:41 DEBUG : only1: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2021/11/13 06:48:41 INFO : only1: Copied (replaced existing) 2021/11/13 06:48:41 DEBUG : Waiting for deletions to finish --- PASS: TestSyncConcurrentTruncate (74.06s) PASS 2021/11/13 06:49:26 DEBUG : B2 bucket rclone-test-quzexim3motamul9cupenas5: Purge remote 2021/11/13 06:49:26 DEBUG : BackupDir/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10724e1ae8410718_d20211113_m064426_c001_v0001039_t0023") 2021/11/13 06:49:26 DEBUG : BackupDir/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f114c3f8f289b84b9_d20211113_m064416_c001_v0001157_t0028") 2021/11/13 06:49:26 DEBUG : CompareDest/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10594f35c69307d3_d20211113_m064349_c001_v0001120_t0056") 2021/11/13 06:49:26 DEBUG : CompareDest/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecaf98d_d20211113_m064342_c001_v0001161_t0052") 2021/11/13 06:49:26 DEBUG : CompareDest/two: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1082e6325e802ce3_d20211113_m064351_c001_v0001131_t0049") 2021/11/13 06:49:26 DEBUG : CompareDest/two: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d477_d20211113_m064343_c001_v0001145_t0041") 2021/11/13 06:49:26 DEBUG : CopyDest/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f11788cbaee7cc660_d20211113_m064426_c001_v0001134_t0037") 2021/11/13 06:49:26 DEBUG : CopyDest/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf33eb_d20211113_m064412_c001_v0001154_t0015") 2021/11/13 06:49:26 DEBUG : CopyDest/three: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1138622c6ddbfaaf_d20211113_m064428_c001_v0001097_t0014") 2021/11/13 06:49:26 DEBUG : CopyDest/three: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d4c3_d20211113_m064423_c001_v0001145_t0024") 2021/11/13 06:49:27 DEBUG : CopyDest/two: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f116509a6f9a4aeaf_d20211113_m064429_c001_v0001137_t0013") 2021/11/13 06:49:27 DEBUG : CopyDest/two: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecafaa9_d20211113_m064420_c001_v0001161_t0057") 2021/11/13 06:49:27 DEBUG : EXISTING: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1086739247265930_d20211113_m064721_c001_v0001120_t0058") 2021/11/13 06:49:27 DEBUG : EXISTING: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb0044_d20211113_m064720_c001_v0001161_t0056") 2021/11/13 06:49:27 DEBUG : Testêé: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f102cefe04adf3761_d20211113_m064716_c001_v0001136_t0020") 2021/11/13 06:49:27 DEBUG : Testêé: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d5d8_d20211113_m064715_c001_v0001145_t0050") 2021/11/13 06:49:27 DEBUG : Testêé: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb0002_d20211113_m064712_c001_v0001161_t0026") 2021/11/13 06:49:27 DEBUG : a/potato2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f110f12f23a0bfaf8_d20211113_m064130_c001_v0001032_t0039") 2021/11/13 06:49:27 DEBUG : a/potato2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf32be_d20211113_m064129_c001_v0001154_t0016") 2021/11/13 06:49:27 DEBUG : a/potato2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f103a2bbf7341b5cc_d20211113_m064127_c001_v0001157_t0011") 2021/11/13 06:49:27 DEBUG : a/potato2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf32af_d20211113_m064124_c001_v0001154_t0012") 2021/11/13 06:49:27 DEBUG : a/potato2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f113a9900bdc7c96f_d20211113_m064050_c001_v0001001_t0006") 2021/11/13 06:49:27 DEBUG : a/potato2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf325a_d20211113_m064049_c001_v0001154_t0014") 2021/11/13 06:49:27 DEBUG : b/potato: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f115db7a313d18e57_d20211113_m064132_c001_v0001090_t0017") 2021/11/13 06:49:27 DEBUG : b/potato: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf32b9_d20211113_m064128_c001_v0001154_t0015") 2021/11/13 06:49:27 DEBUG : b/potato: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f112175a6faea79fc_d20211113_m064125_c001_v0001097_t0021") 2021/11/13 06:49:27 DEBUG : b/potato: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf32ab_d20211113_m064124_c001_v0001154_t0001") 2021/11/13 06:49:28 DEBUG : b/potato: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f103c5ac0c1e537e1_d20211113_m064049_c001_v0001130_t0057") 2021/11/13 06:49:28 DEBUG : b/potato: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3256_d20211113_m064048_c001_v0001154_t0024") 2021/11/13 06:49:28 DEBUG : backup/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1019abaedca7e05b_d20211113_m064505_c001_v0001012_t0027") 2021/11/13 06:49:28 DEBUG : backup/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f11713c8417dacb39_d20211113_m064457_c001_v0001042_t0010") 2021/11/13 06:49:28 DEBUG : backup/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f109acf6c99e3a248_d20211113_m064449_c001_v0001161_t0021") 2021/11/13 06:49:28 DEBUG : backup/one-2019-01-01: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1056337ed1e26480_d20211113_m064546_c001_v0001161_t0052") 2021/11/13 06:49:28 DEBUG : backup/one-2019-01-01: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f118dd9e4257efbab_d20211113_m064539_c001_v0001120_t0030") 2021/11/13 06:49:28 DEBUG : backup/one-2019-01-01: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1182f8a70f7ac42c_d20211113_m064533_c001_v0001097_t0038") 2021/11/13 06:49:28 DEBUG : backup/one.bak: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f101931d61adfddac_d20211113_m064525_c001_v0001092_t0058") 2021/11/13 06:49:28 DEBUG : backup/one.bak: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1135d768e8dec8fb_d20211113_m064521_c001_v0001029_t0010") 2021/11/13 06:49:28 DEBUG : backup/one.bak: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f11945b4f866ba76e_d20211113_m064516_c001_v0001043_t0014") 2021/11/13 06:49:28 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10842255dcff4af8_d20211113_m064546_c001_v0001042_t0051") 2021/11/13 06:49:28 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1126da8b7d2df530_d20211113_m064541_c001_v0001144_t0020") 2021/11/13 06:49:28 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1076cbce5b367fa6_d20211113_m064536_c001_v0001165_t0032") 2021/11/13 06:49:28 DEBUG : backup/three.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f116782d1088ce735_d20211113_m064506_c001_v0001097_t0020") 2021/11/13 06:49:28 DEBUG : backup/three.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f118f32c07ca253b4_d20211113_m064504_c001_v0001093_t0054") 2021/11/13 06:49:28 DEBUG : backup/three.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f114d2ece46a81102_d20211113_m064455_c001_v0001090_t0036") 2021/11/13 06:49:28 DEBUG : backup/three.txt.bak: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1132cae2dec65e5b_d20211113_m064526_c001_v0001033_t0040") 2021/11/13 06:49:28 DEBUG : backup/three.txt.bak: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f114ea8ed0bb47f6c_d20211113_m064524_c001_v0001128_t0000") 2021/11/13 06:49:28 DEBUG : backup/three.txt.bak: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f115a436a5ac9863d_d20211113_m064519_c001_v0001150_t0044") 2021/11/13 06:49:29 DEBUG : both0: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f111b690487ec48cb_d20211113_m064842_c001_v0001001_t0039") 2021/11/13 06:49:29 DEBUG : both0: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf354f_d20211113_m064812_c001_v0001154_t0000") 2021/11/13 06:49:29 DEBUG : both0: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10844bb9080ed018_d20211113_m064753_c001_v0001161_t0037") 2021/11/13 06:49:29 DEBUG : both0: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d5e9_d20211113_m064725_c001_v0001145_t0040") 2021/11/13 06:49:29 DEBUG : both1: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f116782d1088cf853_d20211113_m064842_c001_v0001097_t0015") 2021/11/13 06:49:29 DEBUG : both1: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d64d_d20211113_m064814_c001_v0001145_t0012") 2021/11/13 06:49:29 DEBUG : both1: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f118b1e923c3f1abe_d20211113_m064753_c001_v0001165_t0001") 2021/11/13 06:49:29 DEBUG : both1: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb0077_d20211113_m064727_c001_v0001161_t0017") 2021/11/13 06:49:29 DEBUG : both10: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1074c64df0bde438_d20211113_m064844_c001_v0001097_t0012") 2021/11/13 06:49:29 DEBUG : both10: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d66e_d20211113_m064824_c001_v0001145_t0009") 2021/11/13 06:49:29 DEBUG : both10: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119709330ed4669b_d20211113_m064753_c001_v0001038_t0005") 2021/11/13 06:49:29 DEBUG : both10: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb00cb_d20211113_m064736_c001_v0001161_t0058") 2021/11/13 06:49:29 DEBUG : both11: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f114c5ed7cefc1324_d20211113_m064845_c001_v0001113_t0001") 2021/11/13 06:49:29 DEBUG : both11: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb0264_d20211113_m064827_c001_v0001161_t0041") 2021/11/13 06:49:29 DEBUG : both11: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f111915d1817dace1_d20211113_m064754_c001_v0001097_t0044") 2021/11/13 06:49:29 DEBUG : both11: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf350f_d20211113_m064738_c001_v0001154_t0002") 2021/11/13 06:49:29 DEBUG : both12: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f107b2057258ed168_d20211113_m064849_c001_v0001113_t0027") 2021/11/13 06:49:29 DEBUG : both12: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3572_d20211113_m064828_c001_v0001154_t0023") 2021/11/13 06:49:29 DEBUG : both12: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10935a61ed8b70aa_d20211113_m064755_c001_v0001012_t0027") 2021/11/13 06:49:30 DEBUG : both12: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d60d_d20211113_m064738_c001_v0001145_t0005") 2021/11/13 06:49:30 DEBUG : both13: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f116782d1088cf917_d20211113_m064851_c001_v0001097_t0009") 2021/11/13 06:49:30 DEBUG : both13: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d684_d20211113_m064831_c001_v0001145_t0032") 2021/11/13 06:49:30 DEBUG : both13: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f11760a3880ca6802_d20211113_m064755_c001_v0001153_t0016") 2021/11/13 06:49:30 DEBUG : both13: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb00e6_d20211113_m064739_c001_v0001161_t0052") 2021/11/13 06:49:30 DEBUG : both14: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10936f0484607c91_d20211113_m064853_c001_v0001097_t0023") 2021/11/13 06:49:30 DEBUG : both14: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb029c_d20211113_m064832_c001_v0001161_t0040") 2021/11/13 06:49:30 DEBUG : both14: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f115f224338ddd5bd_d20211113_m064755_c001_v0001144_t0019") 2021/11/13 06:49:30 DEBUG : both14: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3515_d20211113_m064740_c001_v0001154_t0010") 2021/11/13 06:49:30 DEBUG : both15: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10536bfd3862f174_d20211113_m064854_c001_v0001090_t0009") 2021/11/13 06:49:30 DEBUG : both15: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf357c_d20211113_m064834_c001_v0001154_t0017") 2021/11/13 06:49:30 DEBUG : both15: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1074c64df0bde06c_d20211113_m064802_c001_v0001097_t0045") 2021/11/13 06:49:30 DEBUG : both15: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d61b_d20211113_m064741_c001_v0001145_t0045") 2021/11/13 06:49:30 DEBUG : both16: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f11005ad6c09d9fe9_d20211113_m064854_c001_v0001157_t0044") 2021/11/13 06:49:30 DEBUG : both16: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d68f_d20211113_m064834_c001_v0001145_t0029") 2021/11/13 06:49:30 DEBUG : both16: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f11092de87ba65728_d20211113_m064803_c001_v0001130_t0006") 2021/11/13 06:49:30 DEBUG : both16: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb0105_d20211113_m064742_c001_v0001161_t0008") 2021/11/13 06:49:30 DEBUG : both17: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10936f0484607ce4_d20211113_m064857_c001_v0001097_t0029") 2021/11/13 06:49:30 DEBUG : both17: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb02b9_d20211113_m064835_c001_v0001161_t0026") 2021/11/13 06:49:30 DEBUG : both17: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f111915d1817dad95_d20211113_m064804_c001_v0001097_t0037") 2021/11/13 06:49:30 DEBUG : both17: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf351e_d20211113_m064744_c001_v0001154_t0002") 2021/11/13 06:49:31 DEBUG : both18: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f116ebb74ea761a3b_d20211113_m064858_c001_v0001157_t0027") 2021/11/13 06:49:31 DEBUG : both18: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3583_d20211113_m064837_c001_v0001154_t0019") 2021/11/13 06:49:31 DEBUG : both18: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f114bb97b2d694fe2_d20211113_m064805_c001_v0001136_t0005") 2021/11/13 06:49:31 DEBUG : both18: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d622_d20211113_m064744_c001_v0001145_t0015") 2021/11/13 06:49:31 DEBUG : both19: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f100489863c8c0a94_d20211113_m064858_c001_v0001165_t0013") 2021/11/13 06:49:31 DEBUG : both19: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d695_d20211113_m064837_c001_v0001145_t0001") 2021/11/13 06:49:31 DEBUG : both19: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f114c3f8f289b8b26_d20211113_m064806_c001_v0001157_t0038") 2021/11/13 06:49:31 DEBUG : both19: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb0121_d20211113_m064745_c001_v0001161_t0001") 2021/11/13 06:49:31 DEBUG : both2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1183e0289439ce44_d20211113_m064859_c001_v0001144_t0028") 2021/11/13 06:49:31 DEBUG : both2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb020b_d20211113_m064816_c001_v0001161_t0002") 2021/11/13 06:49:31 DEBUG : both2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10387d604bc4c8af_d20211113_m064806_c001_v0001042_t0031") 2021/11/13 06:49:31 DEBUG : both2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf34f0_d20211113_m064728_c001_v0001154_t0008") 2021/11/13 06:49:31 DEBUG : both3: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f100489863c8c0aa5_d20211113_m064901_c001_v0001165_t0008") 2021/11/13 06:49:31 DEBUG : both3: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3558_d20211113_m064817_c001_v0001154_t0009") 2021/11/13 06:49:31 DEBUG : both3: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f11230e0c271150f2_d20211113_m064807_c001_v0001131_t0005") 2021/11/13 06:49:31 DEBUG : both3: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d5f4_d20211113_m064729_c001_v0001145_t0055") 2021/11/13 06:49:31 DEBUG : both4: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f115220f35f50b980_d20211113_m064901_c001_v0001097_t0037") 2021/11/13 06:49:31 DEBUG : both4: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d657_d20211113_m064818_c001_v0001145_t0012") 2021/11/13 06:49:31 DEBUG : both4: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1138622c6ddc0ca3_d20211113_m064807_c001_v0001097_t0037") 2021/11/13 06:49:31 DEBUG : both4: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb0094_d20211113_m064730_c001_v0001161_t0038") 2021/11/13 06:49:31 DEBUG : both5: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f104011aeb76bb186_d20211113_m064903_c001_v0001039_t0053") 2021/11/13 06:49:31 DEBUG : both5: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb0228_d20211113_m064819_c001_v0001161_t0001") 2021/11/13 06:49:32 DEBUG : both5: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f116efb10bb272dfd_d20211113_m064808_c001_v0001043_t0005") 2021/11/13 06:49:32 DEBUG : both5: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf34fe_d20211113_m064731_c001_v0001154_t0009") 2021/11/13 06:49:32 DEBUG : both6: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f104bda439de19f83_d20211113_m064903_c001_v0001097_t0035") 2021/11/13 06:49:32 DEBUG : both6: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf355f_d20211113_m064820_c001_v0001154_t0010") 2021/11/13 06:49:32 DEBUG : both6: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1138622c6ddc0cce_d20211113_m064809_c001_v0001097_t0042") 2021/11/13 06:49:32 DEBUG : both6: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d5fd_d20211113_m064732_c001_v0001145_t0026") 2021/11/13 06:49:32 DEBUG : both7: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1035ca36c178468e_d20211113_m064904_c001_v0001005_t0011") 2021/11/13 06:49:32 DEBUG : both7: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d662_d20211113_m064821_c001_v0001145_t0001") 2021/11/13 06:49:32 DEBUG : both7: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f114a305c1865e780_d20211113_m064810_c001_v0001097_t0010") 2021/11/13 06:49:32 DEBUG : both7: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb00b0_d20211113_m064734_c001_v0001161_t0043") 2021/11/13 06:49:32 DEBUG : both8: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f113f827cd559b68d_d20211113_m064905_c001_v0001157_t0005") 2021/11/13 06:49:32 DEBUG : both8: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb0240_d20211113_m064822_c001_v0001161_t0007") 2021/11/13 06:49:32 DEBUG : both8: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f111915d1817dae25_d20211113_m064810_c001_v0001097_t0059") 2021/11/13 06:49:32 DEBUG : both8: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3508_d20211113_m064735_c001_v0001154_t0019") 2021/11/13 06:49:32 DEBUG : both9: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f108e7212adb252e1_d20211113_m064905_c001_v0001032_t0051") 2021/11/13 06:49:32 DEBUG : both9: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf356a_d20211113_m064823_c001_v0001154_t0005") 2021/11/13 06:49:32 DEBUG : both9: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1171885b31dd7ce6_d20211113_m064811_c001_v0001165_t0033") 2021/11/13 06:49:32 DEBUG : both9: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d607_d20211113_m064735_c001_v0001145_t0000") 2021/11/13 06:49:32 DEBUG : c/non empty space: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1007bf8920cb98fa_d20211113_m064132_c001_v0001120_t0038") 2021/11/13 06:49:33 DEBUG : c/non empty space: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf32bb_d20211113_m064128_c001_v0001154_t0019") 2021/11/13 06:49:33 DEBUG : c/non empty space: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f11784413862e2b4f_d20211113_m064127_c001_v0001030_t0034") 2021/11/13 06:49:33 DEBUG : c/non empty space: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf32ad_d20211113_m064124_c001_v0001154_t0008") 2021/11/13 06:49:33 DEBUG : c/non empty space: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f114c83a0c3a72993_d20211113_m064051_c001_v0001093_t0017") 2021/11/13 06:49:33 DEBUG : c/non empty space: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3258_d20211113_m064048_c001_v0001154_t0002") 2021/11/13 06:49:33 DEBUG : check sum: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10367d7ffafae0b2_d20211113_m064039_c001_v0001097_t0047") 2021/11/13 06:49:33 DEBUG : check sum: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf323f_d20211113_m064038_c001_v0001154_t0009") 2021/11/13 06:49:33 DEBUG : dest/3: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1183e0289439cb23_d20211113_m064400_c001_v0001144_t0020") 2021/11/13 06:49:33 DEBUG : dest/3: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f116b6982ae0b5041_d20211113_m064359_c001_v0001044_t0001") 2021/11/13 06:49:33 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10892a1c5780de0a_d20211113_m064704_c001_v0001150_t0027") 2021/11/13 06:49:33 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10587a5952b308a4_d20211113_m064700_c001_v0001157_t0029") 2021/11/13 06:49:33 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1017a522f0c0ae73_d20211113_m064659_c001_v0001161_t0045") 2021/11/13 06:49:33 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10587a5952b30884_d20211113_m064655_c001_v0001157_t0030") 2021/11/13 06:49:33 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10046a879fb8dca0_d20211113_m064654_c001_v0001150_t0050") 2021/11/13 06:49:33 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecaff2a_d20211113_m064647_c001_v0001161_t0020") 2021/11/13 06:49:33 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1074c64df0bdd983_d20211113_m064641_c001_v0001097_t0008") 2021/11/13 06:49:33 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1023cf617a8a4e6b_d20211113_m064632_c001_v0001033_t0035") 2021/11/13 06:49:33 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1067cc7bac182da4_d20211113_m064631_c001_v0001137_t0010") 2021/11/13 06:49:33 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1023cf617a8a4e66_d20211113_m064626_c001_v0001033_t0030") 2021/11/13 06:49:33 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10367d7ffafafb94_d20211113_m064624_c001_v0001097_t0005") 2021/11/13 06:49:33 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecafe3c_d20211113_m064618_c001_v0001161_t0011") 2021/11/13 06:49:34 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f104f48e6569a425e_d20211113_m064613_c001_v0001144_t0025") 2021/11/13 06:49:34 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f109f69cff9ad787e_d20211113_m064606_c001_v0001144_t0001") 2021/11/13 06:49:34 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1012598560407e00_d20211113_m064605_c001_v0001097_t0014") 2021/11/13 06:49:34 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f109f69cff9ad7862_d20211113_m064556_c001_v0001144_t0024") 2021/11/13 06:49:34 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1198ac7364d90211_d20211113_m064555_c001_v0001032_t0033") 2021/11/13 06:49:34 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3462_d20211113_m064549_c001_v0001154_t0015") 2021/11/13 06:49:34 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1129c6f4ef54fada_d20211113_m064547_c001_v0001120_t0026") 2021/11/13 06:49:34 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f104b306bf518d7ab_d20211113_m064541_c001_v0001029_t0025") 2021/11/13 06:49:34 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10119be173aa66d2_d20211113_m064540_c001_v0001136_t0059") 2021/11/13 06:49:34 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f104b306bf518d79f_d20211113_m064535_c001_v0001029_t0002") 2021/11/13 06:49:34 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f116423affc564bf6_d20211113_m064534_c001_v0001032_t0036") 2021/11/13 06:49:34 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d52b_d20211113_m064527_c001_v0001145_t0050") 2021/11/13 06:49:34 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119fdb0b72655591_d20211113_m064526_c001_v0001146_t0024") 2021/11/13 06:49:34 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1138622c6ddbff6f_d20211113_m064523_c001_v0001097_t0004") 2021/11/13 06:49:34 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f111a775a467dcd3b_d20211113_m064522_c001_v0001030_t0006") 2021/11/13 06:49:34 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1138622c6ddbfefc_d20211113_m064518_c001_v0001097_t0030") 2021/11/13 06:49:34 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f108c13b2564148fd_d20211113_m064517_c001_v0001137_t0011") 2021/11/13 06:49:34 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecafc18_d20211113_m064510_c001_v0001161_t0053") 2021/11/13 06:49:34 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1074c64df0bdd1b3_d20211113_m064507_c001_v0001097_t0054") 2021/11/13 06:49:34 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1175e86690b59bff_d20211113_m064503_c001_v0001097_t0043") 2021/11/13 06:49:35 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1012dd891d8f7c41_d20211113_m064459_c001_v0001040_t0001") 2021/11/13 06:49:35 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1175e86690b59b0c_d20211113_m064452_c001_v0001097_t0008") 2021/11/13 06:49:35 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10102d43d94e19ed_d20211113_m064450_c001_v0001120_t0023") 2021/11/13 06:49:35 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3415_d20211113_m064443_c001_v0001154_t0001") 2021/11/13 06:49:35 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f11058df31a2b5a26_d20211113_m064430_c001_v0001113_t0023") 2021/11/13 06:49:35 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f110692bfb47f63b7_d20211113_m064418_c001_v0001120_t0035") 2021/11/13 06:49:35 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10656753e5d45c48_d20211113_m064417_c001_v0001120_t0049") 2021/11/13 06:49:35 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d4ac_d20211113_m064411_c001_v0001145_t0020") 2021/11/13 06:49:35 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f115220f35f50a08b_d20211113_m064409_c001_v0001097_t0040") 2021/11/13 06:49:35 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f115220f35f50a069_d20211113_m064407_c001_v0001097_t0027") 2021/11/13 06:49:35 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f114e70e6d00b6d43_d20211113_m064351_c001_v0001004_t0014") 2021/11/13 06:49:35 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf33c3_d20211113_m064341_c001_v0001154_t0014") 2021/11/13 06:49:35 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10193331d19a2cc4_d20211113_m064339_c001_v0001134_t0016") 2021/11/13 06:49:35 DEBUG : dst/one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10193331d19a2cbf_d20211113_m064337_c001_v0001134_t0045") 2021/11/13 06:49:35 DEBUG : dst/one-2019-01-01: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f11959f6c574bce4a_d20211113_m064704_c001_v0001026_t0015") 2021/11/13 06:49:35 DEBUG : dst/one-2019-01-01: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1056337ed1e266cd_d20211113_m064659_c001_v0001161_t0034") 2021/11/13 06:49:35 DEBUG : dst/one-2019-01-01: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10598ad220f562f5_d20211113_m064652_c001_v0001040_t0049") 2021/11/13 06:49:35 DEBUG : dst/one.bak: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f113ff12c2529e95c_d20211113_m064642_c001_v0001150_t0057") 2021/11/13 06:49:35 DEBUG : dst/one.bak: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f114ff0cf9f2cbb1b_d20211113_m064631_c001_v0001092_t0037") 2021/11/13 06:49:35 DEBUG : dst/one.bak: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f11804d53d9fc9002_d20211113_m064624_c001_v0001130_t0021") 2021/11/13 06:49:36 DEBUG : dst/one.bak: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10749f72330fe689_d20211113_m064615_c001_v0001150_t0058") 2021/11/13 06:49:36 DEBUG : dst/one.bak: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10923fbe49345a25_d20211113_m064601_c001_v0001165_t0011") 2021/11/13 06:49:36 DEBUG : dst/one.bak: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10945f905c200c4a_d20211113_m064554_c001_v0001120_t0027") 2021/11/13 06:49:36 DEBUG : dst/three: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10480186d09d51dd_d20211113_m064438_c001_v0001032_t0029") 2021/11/13 06:49:36 DEBUG : dst/three: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f115220f35f50a22c_d20211113_m064425_c001_v0001097_t0053") 2021/11/13 06:49:36 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10682406a5aaa61c_d20211113_m064705_c001_v0001090_t0021") 2021/11/13 06:49:36 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f11523e655561456d_d20211113_m064701_c001_v0001013_t0027") 2021/11/13 06:49:36 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1063fdbcbe8cde52_d20211113_m064656_c001_v0001015_t0023") 2021/11/13 06:49:36 DEBUG : dst/three.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f111915d1817da908_d20211113_m064708_c001_v0001097_t0048") 2021/11/13 06:49:36 DEBUG : dst/three.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10587a5952b308bc_d20211113_m064703_c001_v0001157_t0013") 2021/11/13 06:49:36 DEBUG : dst/three.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1182f8a70f7acc4d_d20211113_m064702_c001_v0001097_t0041") 2021/11/13 06:49:36 DEBUG : dst/three.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10587a5952b30893_d20211113_m064658_c001_v0001157_t0007") 2021/11/13 06:49:36 DEBUG : dst/three.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f100489863c8c0769_d20211113_m064657_c001_v0001165_t0054") 2021/11/13 06:49:36 DEBUG : dst/three.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf34a6_d20211113_m064649_c001_v0001154_t0003") 2021/11/13 06:49:36 DEBUG : dst/three.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f102afed114583a55_d20211113_m064643_c001_v0001030_t0034") 2021/11/13 06:49:36 DEBUG : dst/three.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1023cf617a8a4e7d_d20211113_m064640_c001_v0001033_t0050") 2021/11/13 06:49:36 DEBUG : dst/three.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f108a042ebe33cb5e_d20211113_m064639_c001_v0001097_t0022") 2021/11/13 06:49:36 DEBUG : dst/three.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1023cf617a8a4e68_d20211113_m064629_c001_v0001033_t0030") 2021/11/13 06:49:36 DEBUG : dst/three.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f117892847187d202_d20211113_m064628_c001_v0001128_t0036") 2021/11/13 06:49:36 DEBUG : dst/three.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3484_d20211113_m064620_c001_v0001154_t0006") 2021/11/13 06:49:37 DEBUG : dst/three.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1072f216b33fb5d1_d20211113_m064612_c001_v0001120_t0047") 2021/11/13 06:49:37 DEBUG : dst/three.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3470_d20211113_m064600_c001_v0001154_t0011") 2021/11/13 06:49:37 DEBUG : dst/three.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f111a824eaf5803cf_d20211113_m064558_c001_v0001113_t0023") 2021/11/13 06:49:37 DEBUG : dst/three.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d545_d20211113_m064551_c001_v0001145_t0024") 2021/11/13 06:49:37 DEBUG : dst/three.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1093fdab14ab8dcb_d20211113_m064545_c001_v0001040_t0021") 2021/11/13 06:49:37 DEBUG : dst/three.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d534_d20211113_m064537_c001_v0001145_t0047") 2021/11/13 06:49:37 DEBUG : dst/three.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1092b0e6d2e4fb7f_d20211113_m064536_c001_v0001021_t0039") 2021/11/13 06:49:37 DEBUG : dst/three.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecafca6_d20211113_m064529_c001_v0001161_t0006") 2021/11/13 06:49:37 DEBUG : dst/three.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1123246d75e2f509_d20211113_m064524_c001_v0001128_t0009") 2021/11/13 06:49:37 DEBUG : dst/three.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecafc55_d20211113_m064520_c001_v0001161_t0018") 2021/11/13 06:49:37 DEBUG : dst/three.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1052c3c325493507_d20211113_m064519_c001_v0001131_t0041") 2021/11/13 06:49:37 DEBUG : dst/three.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf343d_d20211113_m064512_c001_v0001154_t0005") 2021/11/13 06:49:37 DEBUG : dst/three.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1072254e7a9cee3f_d20211113_m064505_c001_v0001157_t0045") 2021/11/13 06:49:37 DEBUG : dst/three.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3429_d20211113_m064456_c001_v0001154_t0002") 2021/11/13 06:49:37 DEBUG : dst/three.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1196e09a355fe5b6_d20211113_m064455_c001_v0001128_t0058") 2021/11/13 06:49:37 DEBUG : dst/three.txt: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d4e5_d20211113_m064445_c001_v0001145_t0029") 2021/11/13 06:49:37 DEBUG : dst/three.txt.bak: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f101fe9cbe5f4d2de_d20211113_m064643_c001_v0001001_t0030") 2021/11/13 06:49:37 DEBUG : dst/three.txt.bak: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f101423de08d80662_d20211113_m064632_c001_v0001113_t0008") 2021/11/13 06:49:37 DEBUG : dst/three.txt.bak: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1074c64df0bdd815_d20211113_m064627_c001_v0001097_t0030") 2021/11/13 06:49:37 DEBUG : dst/three.txt.bak: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f115907d9e2ec36af_d20211113_m064616_c001_v0001042_t0045") 2021/11/13 06:49:37 DEBUG : dst/three.txt.bak: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f110704eb6f4d7d1c_d20211113_m064609_c001_v0001042_t0003") 2021/11/13 06:49:38 DEBUG : dst/three.txt.bak: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f107eb76157bf7538_d20211113_m064557_c001_v0001032_t0002") 2021/11/13 06:49:38 DEBUG : dst/two: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f116c621443dd93ba_d20211113_m064711_c001_v0001134_t0026") 2021/11/13 06:49:38 DEBUG : dst/two: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d5af_d20211113_m064648_c001_v0001145_t0051") 2021/11/13 06:49:38 DEBUG : dst/two: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1147a59f443270b4_d20211113_m064644_c001_v0001144_t0011") 2021/11/13 06:49:38 DEBUG : dst/two: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d582_d20211113_m064619_c001_v0001145_t0029") 2021/11/13 06:49:38 DEBUG : dst/two: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1129c6f4ef54fb2f_d20211113_m064617_c001_v0001120_t0015") 2021/11/13 06:49:38 DEBUG : dst/two: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecafd50_d20211113_m064550_c001_v0001161_t0026") 2021/11/13 06:49:38 DEBUG : dst/two: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f100da147d20ea91b_d20211113_m064548_c001_v0001008_t0022") 2021/11/13 06:49:38 DEBUG : dst/two: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3453_d20211113_m064529_c001_v0001154_t0017") 2021/11/13 06:49:38 DEBUG : dst/two: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f112bda3d37894b6b_d20211113_m064526_c001_v0001165_t0028") 2021/11/13 06:49:38 DEBUG : dst/two: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d50f_d20211113_m064511_c001_v0001145_t0030") 2021/11/13 06:49:38 DEBUG : dst/two: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f102b0469a79160ca_d20211113_m064508_c001_v0001037_t0051") 2021/11/13 06:49:38 DEBUG : dst/two: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecafb6b_d20211113_m064443_c001_v0001161_t0038") 2021/11/13 06:49:38 DEBUG : dst/two: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1065ca577602709a_d20211113_m064442_c001_v0001005_t0008") 2021/11/13 06:49:38 DEBUG : dst/two: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f111e56cca31f65c0_d20211113_m064421_c001_v0001150_t0031") 2021/11/13 06:49:38 DEBUG : dst/two: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f112bda3d37894622_d20211113_m064352_c001_v0001165_t0028") 2021/11/13 06:49:38 DEBUG : dst/two: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10193331d19a2cd8_d20211113_m064348_c001_v0001134_t0054") 2021/11/13 06:49:38 DEBUG : empty space: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10936f048460635d_d20211113_m064319_c001_v0001097_t0000") 2021/11/13 06:49:38 DEBUG : empty space: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf339d_d20211113_m064316_c001_v0001154_t0005") 2021/11/13 06:49:38 DEBUG : empty space: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1015eb1f9e194269_d20211113_m064313_c001_v0001032_t0024") 2021/11/13 06:49:39 DEBUG : empty space: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf337b_d20211113_m064255_c001_v0001154_t0000") 2021/11/13 06:49:39 DEBUG : empty space: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10212155b5bd1ce2_d20211113_m064244_c001_v0001032_t0014") 2021/11/13 06:49:39 DEBUG : empty space: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf335f_d20211113_m064239_c001_v0001154_t0022") 2021/11/13 06:49:39 DEBUG : empty space: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f115a4eadf7f97c99_d20211113_m064149_c001_v0001038_t0036") 2021/11/13 06:49:39 DEBUG : empty space: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf32ef_d20211113_m064146_c001_v0001154_t0002") 2021/11/13 06:49:39 DEBUG : empty space: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f11092de87ba650c4_d20211113_m064144_c001_v0001130_t0048") 2021/11/13 06:49:39 DEBUG : empty space: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf32e9_d20211113_m064143_c001_v0001154_t0009") 2021/11/13 06:49:39 DEBUG : empty space: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f114a305c1865c8c8_d20211113_m064139_c001_v0001097_t0025") 2021/11/13 06:49:39 DEBUG : empty space: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf32d8_d20211113_m064137_c001_v0001154_t0014") 2021/11/13 06:49:39 DEBUG : empty space: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f112ce45e187a2164_d20211113_m064136_c001_v0001130_t0010") 2021/11/13 06:49:39 DEBUG : empty space: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf32c7_d20211113_m064133_c001_v0001154_t0011") 2021/11/13 06:49:39 DEBUG : empty space: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f108136b3e239ae5a_d20211113_m064122_c001_v0001036_t0020") 2021/11/13 06:49:39 DEBUG : empty space: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf32a0_d20211113_m064120_c001_v0001154_t0002") 2021/11/13 06:49:39 DEBUG : empty space: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f103d32037f31bf96_d20211113_m064119_c001_v0001120_t0040") 2021/11/13 06:49:39 DEBUG : empty space: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3297_d20211113_m064118_c001_v0001154_t0020") 2021/11/13 06:49:39 DEBUG : empty space: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f117d3754eb52181c_d20211113_m064102_c001_v0001113_t0048") 2021/11/13 06:49:39 DEBUG : empty space: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3275_d20211113_m064101_c001_v0001154_t0007") 2021/11/13 06:49:39 DEBUG : empty space: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f116782d1088cd31a_d20211113_m064057_c001_v0001097_t0046") 2021/11/13 06:49:39 DEBUG : empty space: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3263_d20211113_m064056_c001_v0001154_t0008") 2021/11/13 06:49:39 DEBUG : empty space: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1030e1fe15d15cdd_d20211113_m064055_c001_v0001022_t0030") 2021/11/13 06:49:39 DEBUG : empty space: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1138eb9ec0827505_d20211113_m064054_c001_v0001039_t0040") 2021/11/13 06:49:40 DEBUG : empty space: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf325e_d20211113_m064052_c001_v0001154_t0019") 2021/11/13 06:49:40 DEBUG : enormous: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1028bd316cade626_d20211113_m064147_c001_v0001091_t0020") 2021/11/13 06:49:40 DEBUG : enormous: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf32f5_d20211113_m064146_c001_v0001154_t0007") 2021/11/13 06:49:40 DEBUG : existing: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119bc8bacd975194_d20211113_m064718_c001_v0001136_t0045") 2021/11/13 06:49:40 DEBUG : existing: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf34e4_d20211113_m064717_c001_v0001154_t0011") 2021/11/13 06:49:40 DEBUG : existing: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f103a78f2dd9014a0_d20211113_m064236_c001_v0001161_t0004") 2021/11/13 06:49:40 DEBUG : existing: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecaf7c9_d20211113_m064235_c001_v0001161_t0003") 2021/11/13 06:49:40 DEBUG : existing: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f114bf2b140c47a9d_d20211113_m064048_c001_v0001165_t0014") 2021/11/13 06:49:40 DEBUG : existing: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3252_d20211113_m064047_c001_v0001154_t0007") 2021/11/13 06:49:40 DEBUG : existing: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1175e86690b587aa_d20211113_m064046_c001_v0001097_t0050") 2021/11/13 06:49:40 DEBUG : existing: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf324d_d20211113_m064045_c001_v0001154_t0024") 2021/11/13 06:49:40 DEBUG : existing: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf324b_d20211113_m064044_c001_v0001154_t0013") 2021/11/13 06:49:40 DEBUG : existing-b: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10892a1c5780d9b5_d20211113_m064237_c001_v0001150_t0027") 2021/11/13 06:49:40 DEBUG : existing-b: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3358_d20211113_m064234_c001_v0001154_t0015") 2021/11/13 06:49:40 DEBUG : five: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1037838cc9a2d0e8_d20211113_m064154_c001_v0001033_t0028") 2021/11/13 06:49:40 DEBUG : five: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecaf68a_d20211113_m064152_c001_v0001161_t0023") 2021/11/13 06:49:40 DEBUG : foo: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1143c681acbf3065_d20211113_m064100_c001_v0001026_t0031") 2021/11/13 06:49:40 DEBUG : foo: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf326d_d20211113_m064059_c001_v0001154_t0006") 2021/11/13 06:49:40 DEBUG : foo: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf326a_d20211113_m064058_c001_v0001154_t0009") 2021/11/13 06:49:40 DEBUG : four: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f113d7747011bc77a_d20211113_m064155_c001_v0001136_t0016") 2021/11/13 06:49:40 DEBUG : four: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3306_d20211113_m064152_c001_v0001154_t0012") 2021/11/13 06:49:41 DEBUG : four: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3304_d20211113_m064151_c001_v0001154_t0005") 2021/11/13 06:49:41 DEBUG : hello world2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1054b3e142c98b1c_d20211113_m064015_c001_v0001113_t0042") 2021/11/13 06:49:41 DEBUG : hello world2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1134436731b2023e_d20211113_m064014_c001_v0001032_t0023") 2021/11/13 06:49:41 DEBUG : ignore-size: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1088c1be40644896_d20211113_m064044_c001_v0001128_t0047") 2021/11/13 06:49:41 DEBUG : ignore-size: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3246_d20211113_m064042_c001_v0001154_t0023") 2021/11/13 06:49:41 DEBUG : nested/sub dir/file: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f115468e4bafae07b_d20211113_m064232_c001_v0001040_t0049") 2021/11/13 06:49:41 DEBUG : nested/sub dir/file: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf334f_d20211113_m064230_c001_v0001154_t0019") 2021/11/13 06:49:41 DEBUG : nested/sub dir/file: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f105aad3d034e6b58_d20211113_m064227_c001_v0001042_t0005") 2021/11/13 06:49:41 DEBUG : nested/sub dir/file: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3347_d20211113_m064226_c001_v0001154_t0011") 2021/11/13 06:49:41 DEBUG : one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f114bf2b140c47ce0_d20211113_m064156_c001_v0001165_t0017") 2021/11/13 06:49:41 DEBUG : one: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf32fd_d20211113_m064150_c001_v0001154_t0018") 2021/11/13 06:49:41 DEBUG : only0: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f106f8a6dde6b7eb5_d20211113_m064909_c001_v0001144_t0000") 2021/11/13 06:49:41 DEBUG : only0: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb02dc_d20211113_m064839_c001_v0001161_t0029") 2021/11/13 06:49:41 DEBUG : only0: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb01e6_d20211113_m064813_c001_v0001161_t0053") 2021/11/13 06:49:41 DEBUG : only0: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f101de64c7545532b_d20211113_m064751_c001_v0001037_t0006") 2021/11/13 06:49:41 DEBUG : only0: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf34ed_d20211113_m064726_c001_v0001154_t0018") 2021/11/13 06:49:41 DEBUG : only1: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10005d4a1d8eb553_d20211113_m064910_c001_v0001137_t0010") 2021/11/13 06:49:41 DEBUG : only1: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d69d_d20211113_m064841_c001_v0001145_t0014") 2021/11/13 06:49:41 DEBUG : only1: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3553_d20211113_m064816_c001_v0001154_t0007") 2021/11/13 06:49:41 DEBUG : only1: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10741dda6934b374_d20211113_m064751_c001_v0001161_t0008") 2021/11/13 06:49:42 DEBUG : only1: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d5f2_d20211113_m064727_c001_v0001145_t0054") 2021/11/13 06:49:42 DEBUG : only10: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119dc763606179ad_d20211113_m064910_c001_v0001040_t0004") 2021/11/13 06:49:42 DEBUG : only10: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf35a1_d20211113_m064841_c001_v0001154_t0005") 2021/11/13 06:49:42 DEBUG : only10: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf356c_d20211113_m064825_c001_v0001154_t0025") 2021/11/13 06:49:42 DEBUG : only10: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f108a0de1b1261041_d20211113_m064748_c001_v0001165_t0006") 2021/11/13 06:49:42 DEBUG : only10: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d60b_d20211113_m064737_c001_v0001145_t0026") 2021/11/13 06:49:42 DEBUG : only11: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f113bc31d996472f5_d20211113_m064911_c001_v0001012_t0039") 2021/11/13 06:49:42 DEBUG : only11: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d697_d20211113_m064839_c001_v0001145_t0045") 2021/11/13 06:49:42 DEBUG : only11: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d67e_d20211113_m064827_c001_v0001145_t0033") 2021/11/13 06:49:42 DEBUG : only11: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1133df744da2e95a_d20211113_m064747_c001_v0001091_t0028") 2021/11/13 06:49:42 DEBUG : only11: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb00dc_d20211113_m064738_c001_v0001161_t0018") 2021/11/13 06:49:42 DEBUG : only12: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f105abbdca30f219f_d20211113_m064911_c001_v0001029_t0017") 2021/11/13 06:49:42 DEBUG : only12: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf358b_d20211113_m064839_c001_v0001154_t0010") 2021/11/13 06:49:42 DEBUG : only12: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb028c_d20211113_m064831_c001_v0001161_t0047") 2021/11/13 06:49:42 DEBUG : only12: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1175e86690b5a859_d20211113_m064747_c001_v0001097_t0023") 2021/11/13 06:49:42 DEBUG : only12: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3511_d20211113_m064739_c001_v0001154_t0011") 2021/11/13 06:49:42 DEBUG : only13: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1074c64df0bde6c9_d20211113_m064912_c001_v0001097_t0014") 2021/11/13 06:49:42 DEBUG : only13: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f111915d1817db087_d20211113_m064840_c001_v0001097_t0032") 2021/11/13 06:49:42 DEBUG : only13: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3578_d20211113_m064832_c001_v0001154_t0008") 2021/11/13 06:49:42 DEBUG : only13: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f105bda026b8a3ba1_d20211113_m064752_c001_v0001165_t0004") 2021/11/13 06:49:43 DEBUG : only13: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d613_d20211113_m064739_c001_v0001145_t0049") 2021/11/13 06:49:43 DEBUG : only14: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f106f8a6dde6b7eb9_d20211113_m064913_c001_v0001144_t0002") 2021/11/13 06:49:43 DEBUG : only14: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf358f_d20211113_m064839_c001_v0001154_t0021") 2021/11/13 06:49:43 DEBUG : only14: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d686_d20211113_m064833_c001_v0001145_t0021") 2021/11/13 06:49:43 DEBUG : only14: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1138622c6ddc0af0_d20211113_m064748_c001_v0001097_t0035") 2021/11/13 06:49:43 DEBUG : only14: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb00f6_d20211113_m064741_c001_v0001161_t0056") 2021/11/13 06:49:43 DEBUG : only15: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10873601e2576fcc_d20211113_m064915_c001_v0001000_t0007") 2021/11/13 06:49:43 DEBUG : only15: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb02de_d20211113_m064839_c001_v0001161_t0026") 2021/11/13 06:49:43 DEBUG : only15: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb02ac_d20211113_m064834_c001_v0001161_t0017") 2021/11/13 06:49:43 DEBUG : only15: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1094bc8e60d75c57_d20211113_m064750_c001_v0001090_t0027") 2021/11/13 06:49:43 DEBUG : only15: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf351b_d20211113_m064742_c001_v0001154_t0012") 2021/11/13 06:49:43 DEBUG : only16: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10936f0484607e7d_d20211113_m064916_c001_v0001097_t0026") 2021/11/13 06:49:43 DEBUG : only16: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3591_d20211113_m064839_c001_v0001154_t0024") 2021/11/13 06:49:43 DEBUG : only16: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf357f_d20211113_m064835_c001_v0001154_t0012") 2021/11/13 06:49:43 DEBUG : only16: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f116ebb74ea76195f_d20211113_m064749_c001_v0001157_t0006") 2021/11/13 06:49:43 DEBUG : only16: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d61e_d20211113_m064743_c001_v0001145_t0054") 2021/11/13 06:49:43 DEBUG : only17: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f11044cbfd34aadda_d20211113_m064917_c001_v0001044_t0007") 2021/11/13 06:49:44 DEBUG : only17: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb02e4_d20211113_m064840_c001_v0001161_t0055") 2021/11/13 06:49:44 DEBUG : only17: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d692_d20211113_m064836_c001_v0001145_t0026") 2021/11/13 06:49:44 DEBUG : only17: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f11445c635f2a88e8_d20211113_m064748_c001_v0001154_t0003") 2021/11/13 06:49:44 DEBUG : only17: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb0118_d20211113_m064744_c001_v0001161_t0034") 2021/11/13 06:49:44 DEBUG : only18: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1052004d38becfa0_d20211113_m064918_c001_v0001128_t0015") 2021/11/13 06:49:44 DEBUG : only18: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3593_d20211113_m064840_c001_v0001154_t0009") 2021/11/13 06:49:44 DEBUG : only18: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb02c2_d20211113_m064837_c001_v0001161_t0059") 2021/11/13 06:49:44 DEBUG : only18: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1050533fbadfa694_d20211113_m064748_c001_v0001093_t0015") 2021/11/13 06:49:44 DEBUG : only18: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3522_d20211113_m064745_c001_v0001154_t0010") 2021/11/13 06:49:44 DEBUG : only19: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1102e32b37378bed_d20211113_m064918_c001_v0001092_t0033") 2021/11/13 06:49:44 DEBUG : only19: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d69b_d20211113_m064840_c001_v0001145_t0001") 2021/11/13 06:49:44 DEBUG : only19: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3589_d20211113_m064838_c001_v0001154_t0006") 2021/11/13 06:49:44 DEBUG : only19: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f100669ba5ecf5ebc_d20211113_m064749_c001_v0001144_t0004") 2021/11/13 06:49:44 DEBUG : only19: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d624_d20211113_m064745_c001_v0001145_t0050") 2021/11/13 06:49:44 DEBUG : only2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f110e0e4c3708a45c_d20211113_m064919_c001_v0001040_t0058") 2021/11/13 06:49:44 DEBUG : only2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3595_d20211113_m064840_c001_v0001154_t0005") 2021/11/13 06:49:44 DEBUG : only2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d655_d20211113_m064816_c001_v0001145_t0054") 2021/11/13 06:49:44 DEBUG : only2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1114d1fd42a572e6_d20211113_m064749_c001_v0001120_t0023") 2021/11/13 06:49:44 DEBUG : only2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb008a_d20211113_m064729_c001_v0001161_t0056") 2021/11/13 06:49:44 DEBUG : only3: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1099b8110573b68b_d20211113_m064921_c001_v0001113_t0052") 2021/11/13 06:49:44 DEBUG : only3: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb02e8_d20211113_m064840_c001_v0001161_t0009") 2021/11/13 06:49:45 DEBUG : only3: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb0215_d20211113_m064817_c001_v0001161_t0027") 2021/11/13 06:49:45 DEBUG : only3: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1123246d75e2f70c_d20211113_m064750_c001_v0001128_t0024") 2021/11/13 06:49:45 DEBUG : only3: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf34f6_d20211113_m064730_c001_v0001154_t0011") 2021/11/13 06:49:45 DEBUG : only4: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f11044cbfd34aade7_d20211113_m064921_c001_v0001044_t0048") 2021/11/13 06:49:45 DEBUG : only4: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3599_d20211113_m064840_c001_v0001154_t0019") 2021/11/13 06:49:45 DEBUG : only4: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf355b_d20211113_m064819_c001_v0001154_t0000") 2021/11/13 06:49:45 DEBUG : only4: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1087364d3d4ef6e7_d20211113_m064747_c001_v0001001_t0010") 2021/11/13 06:49:45 DEBUG : only4: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d5f9_d20211113_m064731_c001_v0001145_t0059") 2021/11/13 06:49:45 DEBUG : only5: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f100a6aaf2399b703_d20211113_m064922_c001_v0001134_t0036") 2021/11/13 06:49:45 DEBUG : only5: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb02ea_d20211113_m064840_c001_v0001161_t0030") 2021/11/13 06:49:45 DEBUG : only5: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d659_d20211113_m064819_c001_v0001145_t0056") 2021/11/13 06:49:45 DEBUG : only5: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1122593fd0f15b90_d20211113_m064748_c001_v0001153_t0020") 2021/11/13 06:49:45 DEBUG : only5: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb00a1_d20211113_m064732_c001_v0001161_t0031") 2021/11/13 06:49:45 DEBUG : only6: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1170a368caed901e_d20211113_m064923_c001_v0001037_t0034") 2021/11/13 06:49:45 DEBUG : only6: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf359b_d20211113_m064840_c001_v0001154_t0001") 2021/11/13 06:49:45 DEBUG : only6: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb022c_d20211113_m064820_c001_v0001161_t0037") 2021/11/13 06:49:45 DEBUG : only6: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1196e09a355fe822_d20211113_m064750_c001_v0001128_t0055") 2021/11/13 06:49:45 DEBUG : only6: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3505_d20211113_m064733_c001_v0001154_t0009") 2021/11/13 06:49:45 DEBUG : only7: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1134ffcf315e7f3f_d20211113_m064924_c001_v0001000_t0011") 2021/11/13 06:49:45 DEBUG : only7: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f111915d1817db092_d20211113_m064840_c001_v0001097_t0000") 2021/11/13 06:49:45 DEBUG : only7: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3563_d20211113_m064822_c001_v0001154_t0000") 2021/11/13 06:49:46 DEBUG : only7: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f115022dbd3a7fc49_d20211113_m064748_c001_v0001134_t0037") 2021/11/13 06:49:46 DEBUG : only7: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d5ff_d20211113_m064734_c001_v0001145_t0046") 2021/11/13 06:49:46 DEBUG : only8: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1132cae2dec66190_d20211113_m064925_c001_v0001033_t0051") 2021/11/13 06:49:46 DEBUG : only8: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb02ee_d20211113_m064841_c001_v0001161_t0013") 2021/11/13 06:49:46 DEBUG : only8: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d66a_d20211113_m064823_c001_v0001145_t0006") 2021/11/13 06:49:46 DEBUG : only8: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf352b_d20211113_m064749_c001_v0001154_t0023") 2021/11/13 06:49:46 DEBUG : only8: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb00b8_d20211113_m064735_c001_v0001161_t0051") 2021/11/13 06:49:46 DEBUG : only9: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f108a0de1b1261430_d20211113_m064925_c001_v0001165_t0041") 2021/11/13 06:49:46 DEBUG : only9: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf359d_d20211113_m064841_c001_v0001154_t0008") 2021/11/13 06:49:46 DEBUG : only9: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecb024e_d20211113_m064824_c001_v0001161_t0047") 2021/11/13 06:49:46 DEBUG : only9: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f103d32037f31c6f8_d20211113_m064751_c001_v0001120_t0025") 2021/11/13 06:49:46 DEBUG : only9: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf350b_d20211113_m064736_c001_v0001154_t0011") 2021/11/13 06:49:46 DEBUG : potato: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1198f171da635382_d20211113_m064224_c001_v0001120_t0013") 2021/11/13 06:49:46 DEBUG : potato: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d3ea_d20211113_m064215_c001_v0001145_t0030") 2021/11/13 06:49:46 DEBUG : potato: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f105cac22407fb91c_d20211113_m064213_c001_v0001097_t0014") 2021/11/13 06:49:46 DEBUG : potato: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecaf700_d20211113_m064209_c001_v0001161_t0047") 2021/11/13 06:49:46 DEBUG : potato: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10367d7ffafae807_d20211113_m064205_c001_v0001097_t0006") 2021/11/13 06:49:46 DEBUG : potato: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecaf6c3_d20211113_m064201_c001_v0001161_t0057") 2021/11/13 06:49:46 DEBUG : potato: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10724e1ae841044c_d20211113_m064142_c001_v0001039_t0015") 2021/11/13 06:49:46 DEBUG : potato: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf32df_d20211113_m064140_c001_v0001154_t0022") 2021/11/13 06:49:46 DEBUG : potato: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f114bf2b140c47c51_d20211113_m064138_c001_v0001165_t0020") 2021/11/13 06:49:47 DEBUG : potato: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf32d6_d20211113_m064137_c001_v0001154_t0019") 2021/11/13 06:49:47 DEBUG : potato: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f118dd9e4257ef7f3_d20211113_m064134_c001_v0001120_t0051") 2021/11/13 06:49:47 DEBUG : potato: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf32c5_d20211113_m064133_c001_v0001154_t0018") 2021/11/13 06:49:47 DEBUG : potato: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1166b2189f959f54_d20211113_m064123_c001_v0001092_t0053") 2021/11/13 06:49:47 DEBUG : potato: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf329c_d20211113_m064122_c001_v0001154_t0011") 2021/11/13 06:49:47 DEBUG : potato: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f102ad2dc2bf683f2_d20211113_m064121_c001_v0001150_t0051") 2021/11/13 06:49:47 DEBUG : potato: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3295_d20211113_m064120_c001_v0001154_t0012") 2021/11/13 06:49:47 DEBUG : potato: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1007aa3ed524fa84_d20211113_m064119_c001_v0001097_t0059") 2021/11/13 06:49:47 DEBUG : potato: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3293_d20211113_m064118_c001_v0001154_t0004") 2021/11/13 06:49:47 DEBUG : potato: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf328f_d20211113_m064117_c001_v0001154_t0001") 2021/11/13 06:49:47 DEBUG : potato: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f114bb97b2d694a4d_d20211113_m064116_c001_v0001136_t0011") 2021/11/13 06:49:47 DEBUG : potato: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf328d_d20211113_m064115_c001_v0001154_t0020") 2021/11/13 06:49:47 DEBUG : potato: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf328b_d20211113_m064114_c001_v0001154_t0025") 2021/11/13 06:49:47 DEBUG : potato: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f105abbdca30f1fc0_d20211113_m064112_c001_v0001029_t0006") 2021/11/13 06:49:47 DEBUG : potato: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3277_d20211113_m064101_c001_v0001154_t0016") 2021/11/13 06:49:47 DEBUG : potato2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10367d7ffafaeeb9_d20211113_m064333_c001_v0001097_t0017") 2021/11/13 06:49:47 DEBUG : potato2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d463_d20211113_m064331_c001_v0001145_t0009") 2021/11/13 06:49:47 DEBUG : potato2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f111915d1817d9834_d20211113_m064320_c001_v0001097_t0009") 2021/11/13 06:49:47 DEBUG : potato2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d449_d20211113_m064315_c001_v0001145_t0011") 2021/11/13 06:49:47 DEBUG : potato2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f11154a56ce3b7132_d20211113_m064301_c001_v0001019_t0030") 2021/11/13 06:49:48 DEBUG : potato2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d42c_d20211113_m064254_c001_v0001145_t0053") 2021/11/13 06:49:48 DEBUG : potato2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1175e86690b59143_d20211113_m064246_c001_v0001097_t0008") 2021/11/13 06:49:48 DEBUG : potato2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d419_d20211113_m064239_c001_v0001145_t0002") 2021/11/13 06:49:48 DEBUG : potato2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f110355562e08def1_d20211113_m064147_c001_v0001097_t0031") 2021/11/13 06:49:48 DEBUG : potato2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf32ed_d20211113_m064146_c001_v0001154_t0025") 2021/11/13 06:49:48 DEBUG : potato2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1138622c6ddbedd8_d20211113_m064144_c001_v0001097_t0042") 2021/11/13 06:49:48 DEBUG : potato2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf32e7_d20211113_m064143_c001_v0001154_t0000") 2021/11/13 06:49:48 DEBUG : potato2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1022274d0e5cb9b7_d20211113_m064142_c001_v0001026_t0003") 2021/11/13 06:49:48 DEBUG : potato2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf32e1_d20211113_m064141_c001_v0001154_t0017") 2021/11/13 06:49:48 DEBUG : potato2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f114c1c35a41dd7eb_d20211113_m064140_c001_v0001130_t0056") 2021/11/13 06:49:48 DEBUG : potato2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf32dc_d20211113_m064138_c001_v0001154_t0015") 2021/11/13 06:49:48 DEBUG : potato2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f11215245e3057e1c_d20211113_m064136_c001_v0001029_t0034") 2021/11/13 06:49:48 DEBUG : potato2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf32cb_d20211113_m064134_c001_v0001154_t0005") 2021/11/13 06:49:48 DEBUG : potato2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f111915d1817d8ede_d20211113_m064122_c001_v0001097_t0057") 2021/11/13 06:49:48 DEBUG : potato2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf32a4_d20211113_m064121_c001_v0001154_t0020") 2021/11/13 06:49:48 DEBUG : potato2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f118ec06e57d01a09_d20211113_m064023_c001_v0001145_t0016") 2021/11/13 06:49:48 DEBUG : potato2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3214_d20211113_m064022_c001_v0001154_t0008") 2021/11/13 06:49:48 DEBUG : potato2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f109f11995c03b09c_d20211113_m064021_c001_v0001146_t0040") 2021/11/13 06:49:48 DEBUG : potato2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf320e_d20211113_m064020_c001_v0001154_t0004") 2021/11/13 06:49:48 DEBUG : potato3: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f111e9d04e91f24f2_d20211113_m064320_c001_v0001093_t0023") 2021/11/13 06:49:48 DEBUG : potato3: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecaf8f2_d20211113_m064316_c001_v0001161_t0002") 2021/11/13 06:49:49 DEBUG : potato3: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1007bf8920cb9b5d_d20211113_m064305_c001_v0001120_t0028") 2021/11/13 06:49:49 DEBUG : potato3: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecaf86c_d20211113_m064256_c001_v0001161_t0054") 2021/11/13 06:49:49 DEBUG : potato3: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1050112fc8093941_d20211113_m064244_c001_v0001146_t0008") 2021/11/13 06:49:49 DEBUG : potato3: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecaf7e3_d20211113_m064239_c001_v0001161_t0011") 2021/11/13 06:49:49 DEBUG : pre-dest1/1: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10052643a45dfd9a_d20211113_m064402_c001_v0001013_t0023") 2021/11/13 06:49:49 DEBUG : pre-dest1/1: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf33d4_d20211113_m064353_c001_v0001154_t0003") 2021/11/13 06:49:49 DEBUG : pre-dest2/2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f110de01c00f27b1f_d20211113_m064403_c001_v0001026_t0011") 2021/11/13 06:49:49 DEBUG : pre-dest2/2: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecaf9e1_d20211113_m064354_c001_v0001161_t0029") 2021/11/13 06:49:49 DEBUG : sizeonly: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1029475a79d9d417_d20211113_m064041_c001_v0001128_t0002") 2021/11/13 06:49:49 DEBUG : sizeonly: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3243_d20211113_m064040_c001_v0001154_t0013") 2021/11/13 06:49:49 DEBUG : sub dir/hello world: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1185436e40833a23_d20211113_m064233_c001_v0001036_t0046") 2021/11/13 06:49:49 DEBUG : sub dir/hello world: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d40c_d20211113_m064231_c001_v0001145_t0052") 2021/11/13 06:49:49 DEBUG : sub dir/hello world: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1115822558b98e31_d20211113_m064228_c001_v0001144_t0021") 2021/11/13 06:49:49 DEBUG : sub dir/hello world: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1108d58b7ecaf78f_d20211113_m064226_c001_v0001161_t0002") 2021/11/13 06:49:49 DEBUG : sub dir/hello world: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f100b3db11e071d11_d20211113_m064037_c001_v0001157_t0039") 2021/11/13 06:49:49 DEBUG : sub dir/hello world: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3238_d20211113_m064036_c001_v0001154_t0011") 2021/11/13 06:49:49 DEBUG : sub dir/hello world: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10846bd563372bc0_d20211113_m064035_c001_v0001015_t0024") 2021/11/13 06:49:49 DEBUG : sub dir/hello world: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3235_d20211113_m064034_c001_v0001154_t0011") 2021/11/13 06:49:49 DEBUG : sub dir/hello world: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10587a5952b2ff2b_d20211113_m064033_c001_v0001157_t0015") 2021/11/13 06:49:49 DEBUG : sub dir/hello world: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf322b_d20211113_m064030_c001_v0001154_t0020") 2021/11/13 06:49:50 DEBUG : sub dir/hello world: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f103e8dfbc093353e_d20211113_m064029_c001_v0001003_t0030") 2021/11/13 06:49:50 DEBUG : sub dir/hello world: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3227_d20211113_m064028_c001_v0001154_t0018") 2021/11/13 06:49:50 DEBUG : sub dir/hello world: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f112cd3705a5c5545_d20211113_m064027_c001_v0001136_t0027") 2021/11/13 06:49:50 DEBUG : sub dir/hello world: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3224_d20211113_m064026_c001_v0001154_t0018") 2021/11/13 06:49:50 DEBUG : sub dir/hello world: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1074c64df0bdb9d7_d20211113_m064025_c001_v0001097_t0040") 2021/11/13 06:49:50 DEBUG : sub dir/hello world: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf321d_d20211113_m064024_c001_v0001154_t0018") 2021/11/13 06:49:50 DEBUG : sub dir/hello world: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1099782548986936_d20211113_m064013_c001_v0001038_t0006") 2021/11/13 06:49:50 DEBUG : sub dir/hello world: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1134436731b20238_d20211113_m064012_c001_v0001032_t0038") 2021/11/13 06:49:50 DEBUG : sub dir/hello world: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1198f171da6350f6_d20211113_m064011_c001_v0001120_t0053") 2021/11/13 06:49:50 DEBUG : sub dir/hello world: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1134436731b20234_d20211113_m064010_c001_v0001032_t0029") 2021/11/13 06:49:50 DEBUG : sub dir/hello world: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1069d78f9ca033a5_d20211113_m064009_c001_v0001165_t0036") 2021/11/13 06:49:50 DEBUG : sub dir/hello world: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1134436731b20230_d20211113_m064007_c001_v0001032_t0029") 2021/11/13 06:49:50 DEBUG : sub dir/hello world: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f102cefe04adf3305_d20211113_m064006_c001_v0001136_t0042") 2021/11/13 06:49:50 DEBUG : sub dir/hello world: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1134436731b2022c_d20211113_m064005_c001_v0001032_t0028") 2021/11/13 06:49:50 DEBUG : sub/yam: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10293d94605979d7_d20211113_m064219_c001_v0001113_t0022") 2021/11/13 06:49:50 DEBUG : sub/yam: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3339_d20211113_m064215_c001_v0001154_t0020") 2021/11/13 06:49:50 DEBUG : three: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f11783539c09af453_d20211113_m064156_c001_v0001120_t0002") 2021/11/13 06:49:50 DEBUG : three: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf330c_d20211113_m064153_c001_v0001154_t0015") 2021/11/13 06:49:50 DEBUG : three: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3302_d20211113_m064150_c001_v0001154_t0020") 2021/11/13 06:49:50 DEBUG : two: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1138622c6ddbeecb_d20211113_m064159_c001_v0001097_t0054") 2021/11/13 06:49:51 DEBUG : two: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d3bc_d20211113_m064152_c001_v0001145_t0049") 2021/11/13 06:49:51 DEBUG : two: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf3300_d20211113_m064150_c001_v0001154_t0002") 2021/11/13 06:49:51 DEBUG : yam: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f116f441784a3b81a_d20211113_m064225_c001_v0001136_t0030") 2021/11/13 06:49:51 DEBUG : yam: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f116ebb74ea7614e7_d20211113_m064217_c001_v0001157_t0029") 2021/11/13 06:49:51 DEBUG : yam: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f114a305c1865cb63_d20211113_m064211_c001_v0001097_t0032") 2021/11/13 06:49:51 DEBUG : yam: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f10358ff58ccf332f_d20211113_m064209_c001_v0001154_t0005") 2021/11/13 06:49:51 DEBUG : yam: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f111c0f121ca3f0f4_d20211113_m064204_c001_v0001038_t0041") 2021/11/13 06:49:51 DEBUG : yam: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f119501d502b4d3d3_d20211113_m064201_c001_v0001145_t0029") 2021/11/13 06:49:51 DEBUG : yaml: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f116f441784a3b7f8_d20211113_m064214_c001_v0001136_t0009") 2021/11/13 06:49:51 DEBUG : yaml: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1074c64df0bdc2ee_d20211113_m064211_c001_v0001097_t0008") 2021/11/13 06:49:51 DEBUG : yaml: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f1148a8cc2cea21f1_d20211113_m064207_c001_v0001044_t0049") 2021/11/13 06:49:51 DEBUG : yaml: Deleting (id "4_zdf424d03006d1b8b7fd80e1b_f100735c48d78e7f9_d20211113_m064203_c001_v0001012_t0001") "./sync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Finished OK in 9m51.372976748s (try 1/5)