"./sync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Starting (try 1/5) 2022/03/23 06:46:41 DEBUG : Creating backend with remote "TestB2:rclone-test-fovakim7cuwafen2jisigaz4" 2022/03/23 06:46:41 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2022/03/23 06:46:41 DEBUG : Creating backend with remote "/tmp/rclone958659976" === 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-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:46:42 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:46:42 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:46:42 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) --- PASS: TestCopyWithDryRun (1.64s) === RUN TestCopy run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:46:43 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:46:43 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:46:46 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/03/23 06:46:46 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopy (3.58s) === RUN TestCopyMissingDirectory run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:46:47 DEBUG : Creating backend with remote "/non-existing" 2022/03/23 06:46:47 ERROR : Local file system at /non-existing: error reading source root directory: directory not found 2022/03/23 06:46:47 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:46:47 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish --- PASS: TestCopyMissingDirectory (0.51s) === RUN TestCopyNoTraverse run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:46:48 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:46:48 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:46:48 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:46:51 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/03/23 06:46:51 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoTraverse (4.93s) === RUN TestCopyCheckFirst run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:46:52 INFO : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Running all checks before starting transfers 2022/03/23 06:46:52 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:46:52 INFO : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Checks finished, now starting transfers 2022/03/23 06:46:52 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:46:52 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/03/23 06:46:52 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyCheckFirst (2.70s) === RUN TestSyncNoTraverse run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:46:55 ERROR : Ignoring --no-traverse with sync 2022/03/23 06:46:55 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:46:55 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:46:55 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/03/23 06:46:55 INFO : sub dir/hello world: Copied (new) 2022/03/23 06:46:55 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoTraverse (3.63s) === RUN TestCopyWithDepth run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:46:58 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:46:58 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:47:02 DEBUG : hello world2: sha1 = c0bf117f9c93d02c894fe8ffd6e5cecf3545c209 OK 2022/03/23 06:47:02 INFO : hello world2: Copied (new) --- PASS: TestCopyWithDepth (6.15s) === RUN TestCopyWithFilesFrom run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:47:04 DEBUG : hello world2: Excluded 2022/03/23 06:47:05 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:47:05 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:47:07 DEBUG : potato2: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/03/23 06:47:07 INFO : potato2: Copied (new) --- PASS: TestCopyWithFilesFrom (3.17s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:47:08 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:47:08 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:47:08 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:47:09 DEBUG : potato2: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/03/23 06:47:09 INFO : potato2: Copied (new) --- PASS: TestCopyWithFilesFromAndNoTraverse (2.36s) === RUN TestCopyEmptyDirectories run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:47:10 DEBUG : sub dir2: Making directory 2022/03/23 06:47:10 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:47:10 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:47:15 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/03/23 06:47:15 INFO : sub dir/hello world: Copied (new) 2022/03/23 06:47:15 DEBUG : sub dir2: Making directory 2022/03/23 06:47:15 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: copied 1 directories fstest.go:251: Filtering empty directory "sub dir2" 2022/03/23 06:47:15 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_list_file_names": EOF) 2022/03/23 06:47:15 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2022/03/23 06:47:16 DEBUG : pacer: Reducing sleep to 10ms --- PASS: TestCopyEmptyDirectories (6.78s) === RUN TestMoveEmptyDirectories run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:47:17 DEBUG : sub dir2: Making directory 2022/03/23 06:47:17 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:47:17 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:47:17 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/03/23 06:47:17 INFO : sub dir/hello world: Copied (new) 2022/03/23 06:47:17 INFO : sub dir/hello world: Deleted 2022/03/23 06:47:17 DEBUG : sub dir2: Making directory 2022/03/23 06:47:17 DEBUG : sub dir: Making directory 2022/03/23 06:47:17 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: copied 2 directories fstest.go:251: Filtering empty directory "sub dir2" --- PASS: TestMoveEmptyDirectories (1.66s) === RUN TestSyncEmptyDirectories run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:47:18 DEBUG : sub dir2: Making directory 2022/03/23 06:47:19 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:47:19 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:47:20 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/03/23 06:47:20 INFO : sub dir/hello world: Copied (new) 2022/03/23 06:47:20 DEBUG : sub dir2: Making directory 2022/03/23 06:47:20 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: copied 1 directories 2022/03/23 06:47:20 DEBUG : Waiting for deletions to finish fstest.go:251: Filtering empty directory "sub dir2" --- PASS: TestSyncEmptyDirectories (3.10s) === RUN TestServerSideCopy run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:47:23 DEBUG : Creating backend with remote "TestB2:rclone-test-nabovom1navenif3lasemej8" sync_test.go:275: Server side copy (if possible) B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 -> B2 bucket rclone-test-nabovom1navenif3lasemej8 2022/03/23 06:47:24 DEBUG : B2 bucket rclone-test-nabovom1navenif3lasemej8: Waiting for checks to finish 2022/03/23 06:47:24 DEBUG : B2 bucket rclone-test-nabovom1navenif3lasemej8: Waiting for transfers to finish 2022/03/23 06:47:25 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/03/23 06:47:25 INFO : sub dir/hello world: Copied (server-side copy) 2022/03/23 06:47:25 DEBUG : B2 bucket rclone-test-nabovom1navenif3lasemej8: Purge remote 2022/03/23 06:47:26 DEBUG : sub dir/hello world: Deleting (id "4_zef22bd73807dbb5b7ff80e1b_f1108741eb8781d87_d20220323_m064725_c001_v0001105_t0028_u01648018045329") --- PASS: TestServerSideCopy (5.49s) === RUN TestCopyAfterDelete run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:47:28 ERROR : : error listing: directory not found 2022/03/23 06:47:28 DEBUG : Local file system at /tmp/rclone958659976: Making directory 2022/03/23 06:47:28 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:47:28 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish --- PASS: TestCopyAfterDelete (1.92s) === RUN TestCopyRedownload run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:47:31 DEBUG : Local file system at /tmp/rclone958659976: Waiting for checks to finish 2022/03/23 06:47:31 DEBUG : Local file system at /tmp/rclone958659976: Waiting for transfers to finish 2022/03/23 06:47:32 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/03/23 06:47:32 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyRedownload (3.98s) === RUN TestSyncBasedOnCheckSum run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:47:33 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:47:33 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:47:36 DEBUG : check sum: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/03/23 06:47:36 INFO : check sum: Copied (new) 2022/03/23 06:47:36 DEBUG : Waiting for deletions to finish 2022/03/23 06:47:36 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:47:36 DEBUG : check sum: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/03/23 06:47:36 DEBUG : check sum: Size and sha1 of src and dst objects identical 2022/03/23 06:47:36 DEBUG : check sum: Unchanged skipping 2022/03/23 06:47:36 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:47:36 DEBUG : Waiting for deletions to finish 2022/03/23 06:47:36 INFO : There was nothing to transfer --- PASS: TestSyncBasedOnCheckSum (4.26s) === RUN TestSyncSizeOnly run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:47:37 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:47:37 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:47:38 DEBUG : sizeonly: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2022/03/23 06:47:38 INFO : sizeonly: Copied (new) 2022/03/23 06:47:38 DEBUG : Waiting for deletions to finish 2022/03/23 06:47:38 DEBUG : sizeonly: Sizes identical 2022/03/23 06:47:38 DEBUG : sizeonly: Unchanged skipping 2022/03/23 06:47:38 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:47:38 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:47:38 DEBUG : Waiting for deletions to finish 2022/03/23 06:47:38 INFO : There was nothing to transfer --- PASS: TestSyncSizeOnly (2.27s) === RUN TestSyncIgnoreSize run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:47:40 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:47:40 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:47:40 DEBUG : ignore-size: sha1 = 4a756ca07e9487f482465a99e8286abc86ba4dc7 OK 2022/03/23 06:47:40 INFO : ignore-size: Copied (new) 2022/03/23 06:47:40 DEBUG : Waiting for deletions to finish 2022/03/23 06:47:40 DEBUG : ignore-size: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:47:40 DEBUG : ignore-size: Unchanged skipping 2022/03/23 06:47:40 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:47:40 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:47:40 DEBUG : Waiting for deletions to finish 2022/03/23 06:47:40 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreSize (2.52s) === RUN TestSyncIgnoreTimes run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:47:45 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:47:45 DEBUG : existing: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:47:45 DEBUG : existing: Unchanged skipping 2022/03/23 06:47:45 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:47:45 DEBUG : Waiting for deletions to finish 2022/03/23 06:47:45 INFO : There was nothing to transfer 2022/03/23 06:47:45 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2022/03/23 06:47:45 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:47:45 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:47:47 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2022/03/23 06:47:47 INFO : existing: Copied (replaced existing) 2022/03/23 06:47:47 DEBUG : Waiting for deletions to finish --- PASS: TestSyncIgnoreTimes (5.89s) === RUN TestSyncIgnoreExisting run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:47:48 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:47:48 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:47:51 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2022/03/23 06:47:51 INFO : existing: Copied (new) 2022/03/23 06:47:51 DEBUG : Waiting for deletions to finish 2022/03/23 06:47:51 DEBUG : existing: Destination exists, skipping 2022/03/23 06:47:51 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:47:51 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:47:51 DEBUG : Waiting for deletions to finish 2022/03/23 06:47:51 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreExisting (4.32s) === RUN TestSyncIgnoreErrors run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:47:54 DEBUG : d: Making directory fstest.go:251: Filtering empty directory "d" 2022/03/23 06:47:55 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/03/23 06:47:55 DEBUG : c/non empty space: Unchanged skipping 2022/03/23 06:47:55 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:47:55 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:47:55 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/03/23 06:47:55 INFO : a/potato2: Copied (new) 2022/03/23 06:47:55 DEBUG : Waiting for deletions to finish 2022/03/23 06:47:56 INFO : b/potato: Deleted --- PASS: TestSyncIgnoreErrors (5.19s) === RUN TestSyncAfterChangingModtimeOnly run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:47:58 DEBUG : empty space: Modification times differ by -95456h54m52.624456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499 +0000 UTC 2022/03/23 06:47:58 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:47:58 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/03/23 06:47:58 NOTICE: empty space: Skipped update modification time as --dry-run is set (size 1) 2022/03/23 06:47:58 DEBUG : empty space: Unchanged skipping 2022/03/23 06:47:58 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:47:58 DEBUG : Waiting for deletions to finish 2022/03/23 06:47:58 INFO : There was nothing to transfer 2022/03/23 06:47:59 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:47:59 DEBUG : empty space: Modification times differ by -95456h54m52.624456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499 +0000 UTC 2022/03/23 06:47:59 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/03/23 06:48:01 INFO : empty space: Updated modification time in destination 2022/03/23 06:48:01 DEBUG : empty space: Unchanged skipping 2022/03/23 06:48:01 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:48:01 DEBUG : Waiting for deletions to finish 2022/03/23 06:48:01 INFO : There was nothing to transfer --- PASS: TestSyncAfterChangingModtimeOnly (4.20s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:48:02 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:48:02 DEBUG : empty space: Modification times differ by -95456h54m52.624456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499 +0000 UTC 2022/03/23 06:48:02 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/03/23 06:48:02 DEBUG : empty space: Unchanged skipping 2022/03/23 06:48:02 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:48:02 DEBUG : Waiting for deletions to finish 2022/03/23 06:48:02 INFO : There was nothing to transfer --- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (2.22s) === RUN TestSyncDoesntUpdateModtime run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:48:45 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:48:45 DEBUG : foo: Modification times differ by -95456h54m52.624456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499 +0000 UTC 2022/03/23 06:48:45 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 (Local file system at /tmp/rclone958659976) 2022/03/23 06:48:45 DEBUG : foo: sha1 = 62cdb7020ff920e5aa642c3d4066950dd1f01f4d (B2 bucket rclone-test-fovakim7cuwafen2jisigaz4) 2022/03/23 06:48:45 DEBUG : foo: sha1 differ 2022/03/23 06:48:45 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:48:46 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 OK 2022/03/23 06:48:46 INFO : foo: Copied (replaced existing) 2022/03/23 06:48:46 DEBUG : Waiting for deletions to finish --- PASS: TestSyncDoesntUpdateModtime (42.74s) === RUN TestSyncAfterAddingAFile run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:48:48 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/03/23 06:48:48 DEBUG : empty space: Unchanged skipping 2022/03/23 06:48:48 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:48:48 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:48:49 DEBUG : potato: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/03/23 06:48:49 INFO : potato: Copied (new) 2022/03/23 06:48:49 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterAddingAFile (4.23s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:49:30 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2022/03/23 06:49:30 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:49:30 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:49:30 DEBUG : potato: sha1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f OK 2022/03/23 06:49:30 INFO : potato: Copied (replaced existing) 2022/03/23 06:49:30 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingFilesSizeOnly (40.52s) === RUN TestSyncAfterChangingContentsOnly run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:49:32 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:49:32 DEBUG : potato: Modification times differ by 119h59m59.876543211s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2011-12-30 12:59:59 +0000 UTC 2022/03/23 06:49:32 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f (Local file system at /tmp/rclone958659976) 2022/03/23 06:49:32 DEBUG : potato: sha1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f (B2 bucket rclone-test-fovakim7cuwafen2jisigaz4) 2022/03/23 06:49:32 DEBUG : potato: sha1 differ 2022/03/23 06:49:32 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:49:34 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f OK 2022/03/23 06:49:34 INFO : potato: Copied (replaced existing) 2022/03/23 06:49:34 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingContentsOnly (4.21s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:49:37 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2022/03/23 06:49:37 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/03/23 06:49:37 DEBUG : empty space: Unchanged skipping 2022/03/23 06:49:37 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:49:37 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:49:37 DEBUG : Waiting for deletions to finish 2022/03/23 06:49:37 NOTICE: potato: Skipped delete as --dry-run is set (size 21) --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (4.67s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:49:41 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/03/23 06:49:41 DEBUG : empty space: Unchanged skipping 2022/03/23 06:49:41 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:49:41 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:49:42 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/03/23 06:49:42 INFO : potato2: Copied (new) 2022/03/23 06:49:42 DEBUG : Waiting for deletions to finish 2022/03/23 06:49:44 INFO : potato: Deleted --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (8.48s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:49:50 DEBUG : d: Making directory 2022/03/23 06:49:50 DEBUG : d/e: Making directory fstest.go:251: Filtering empty directory "d" fstest.go:251: Filtering empty directory "d/e" 2022/03/23 06:49:51 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/03/23 06:49:51 DEBUG : c/non empty space: Unchanged skipping 2022/03/23 06:49:51 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:49:51 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:49:51 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/03/23 06:49:51 INFO : a/potato2: Copied (new) 2022/03/23 06:49:51 DEBUG : Waiting for deletions to finish 2022/03/23 06:49:52 INFO : b/potato: Deleted --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (5.18s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:49:57 DEBUG : d: Making directory fstest.go:251: Filtering empty directory "d" 2022/03/23 06:49:57 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/03/23 06:49:57 DEBUG : c/non empty space: Unchanged skipping 2022/03/23 06:49:57 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:49:57 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:49:57 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/03/23 06:49:57 INFO : a/potato2: Copied (new) 2022/03/23 06:49:57 ERROR : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: not deleting files as there were IO errors 2022/03/23 06:49:57 ERROR : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: not deleting directories as there were IO errors fstest.go:251: Filtering empty directory "d" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (7.19s) === RUN TestSyncDeleteAfter --- PASS: TestSyncDeleteAfter (0.00s) === RUN TestSyncDeleteDuring run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:50:02 DEBUG : Waiting for deletions to finish 2022/03/23 06:50:02 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/03/23 06:50:02 DEBUG : empty space: Unchanged skipping 2022/03/23 06:50:02 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:50:02 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:50:03 INFO : potato: Deleted 2022/03/23 06:50:03 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/03/23 06:50:03 INFO : potato2: Copied (new) --- PASS: TestSyncDeleteDuring (6.45s) === RUN TestSyncDeleteBefore run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:50:09 DEBUG : Waiting for deletions to finish 2022/03/23 06:50:09 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:50:09 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:50:09 INFO : potato: Deleted 2022/03/23 06:50:09 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/03/23 06:50:09 DEBUG : empty space: Unchanged skipping 2022/03/23 06:50:09 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:50:09 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:50:10 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/03/23 06:50:10 INFO : potato2: Copied (new) --- PASS: TestSyncDeleteBefore (4.23s) === RUN TestCopyDeleteBefore run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:50:13 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:50:13 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:50:14 DEBUG : potato2: sha1 = 810274f0df19dab60a894a562b7a8ff04c072623 OK 2022/03/23 06:50:14 INFO : potato2: Copied (new) --- PASS: TestCopyDeleteBefore (4.63s) === RUN TestSyncWithExclude run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:50:21 DEBUG : enormous: Excluded 2022/03/23 06:50:21 DEBUG : potato2: Excluded 2022/03/23 06:50:21 DEBUG : potato2: Excluded 2022/03/23 06:50:21 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/03/23 06:50:21 DEBUG : empty space: Unchanged skipping 2022/03/23 06:50:21 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:50:21 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:50:21 DEBUG : Waiting for deletions to finish 2022/03/23 06:50:21 INFO : There was nothing to transfer 2022/03/23 06:50:21 DEBUG : enormous: Excluded 2022/03/23 06:50:21 DEBUG : potato2: Excluded 2022/03/23 06:50:21 DEBUG : potato2: Excluded 2022/03/23 06:50:21 DEBUG : Local file system at /tmp/rclone958659976: Waiting for checks to finish 2022/03/23 06:50:21 DEBUG : empty space: Size and modification time the same (differ by 456.789µs, within tolerance 1ms) 2022/03/23 06:50:21 DEBUG : empty space: Unchanged skipping 2022/03/23 06:50:21 DEBUG : Local file system at /tmp/rclone958659976: Waiting for transfers to finish 2022/03/23 06:50:21 DEBUG : Waiting for deletions to finish 2022/03/23 06:50:21 INFO : There was nothing to transfer --- PASS: TestSyncWithExclude (6.45s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:50:26 DEBUG : enormous: Excluded 2022/03/23 06:50:26 DEBUG : potato2: Excluded 2022/03/23 06:50:26 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:50:26 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/03/23 06:50:26 DEBUG : empty space: Unchanged skipping 2022/03/23 06:50:26 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:50:26 DEBUG : Waiting for deletions to finish 2022/03/23 06:50:27 INFO : potato2: Deleted 2022/03/23 06:50:28 INFO : enormous: Deleted 2022/03/23 06:50:28 INFO : There was nothing to transfer 2022/03/23 06:50:28 DEBUG : empty space: Size and modification time the same (differ by 456.789µs, within tolerance 1ms) 2022/03/23 06:50:28 DEBUG : empty space: Unchanged skipping 2022/03/23 06:50:28 DEBUG : Local file system at /tmp/rclone958659976: Waiting for checks to finish 2022/03/23 06:50:28 DEBUG : Local file system at /tmp/rclone958659976: Waiting for transfers to finish 2022/03/23 06:50:28 DEBUG : Waiting for deletions to finish 2022/03/23 06:50:28 INFO : enormous: Deleted 2022/03/23 06:50:28 INFO : potato2: Deleted 2022/03/23 06:50:28 INFO : There was nothing to transfer --- PASS: TestSyncWithExcludeAndDeleteExcluded (6.14s) === RUN TestSyncWithUpdateOlder run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:50:35 DEBUG : four: Sizes differ (src 4 vs dst 8) 2022/03/23 06:50:35 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2022/03/23 06:50:35 DEBUG : one: Destination is newer than source, skipping 2022/03/23 06:50:35 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:50:35 DEBUG : three: Sizes identical 2022/03/23 06:50:35 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2022/03/23 06:50:35 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b (Local file system at /tmp/rclone958659976) 2022/03/23 06:50:35 DEBUG : two: sha1 = b10e0da85e90399abfec36c7376b20aa4596461b (B2 bucket rclone-test-fovakim7cuwafen2jisigaz4) 2022/03/23 06:50:35 DEBUG : two: sha1 differ 2022/03/23 06:50:35 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:50:35 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2022/03/23 06:50:35 INFO : five: Copied (new) 2022/03/23 06:50:36 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2022/03/23 06:50:36 INFO : four: Copied (replaced existing) 2022/03/23 06:50:40 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2022/03/23 06:50:40 INFO : two: Copied (replaced existing) 2022/03/23 06:50:40 DEBUG : Waiting for deletions to finish 2022/03/23 06:50:41 DEBUG : one: Destination is newer than source, skipping 2022/03/23 06:50:41 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:50:41 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2022/03/23 06:50:41 DEBUG : five: Size and sha1 of src and dst objects identical 2022/03/23 06:50:41 DEBUG : five: Destination mod time is within 1s of source and files identical, skipping 2022/03/23 06:50:41 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2022/03/23 06:50:41 DEBUG : four: Size and sha1 of src and dst objects identical 2022/03/23 06:50:41 DEBUG : four: Destination mod time is within 1s of source and files identical, skipping 2022/03/23 06:50:41 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2022/03/23 06:50:41 DEBUG : two: Size and sha1 of src and dst objects identical 2022/03/23 06:50:41 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb (Local file system at /tmp/rclone958659976) 2022/03/23 06:50:41 DEBUG : two: Destination mod time is within 1s of source and files identical, skipping 2022/03/23 06:50:41 DEBUG : three: sha1 = 03731cad13f4cf7b59703c77529381cdec1632e5 (B2 bucket rclone-test-fovakim7cuwafen2jisigaz4) 2022/03/23 06:50:41 DEBUG : three: sha1 differ 2022/03/23 06:50:41 DEBUG : three: Destination mod time is within 1s of source but files differ, transferring 2022/03/23 06:50:41 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:50:43 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/03/23 06:50:43 INFO : three: Copied (replaced existing) 2022/03/23 06:50:43 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithUpdateOlder (19.62s) === 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-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" sync_test.go:1058: Can track renames: true 2022/03/23 06:50:49 INFO : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Making map for --track-renames 2022/03/23 06:50:49 INFO : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Finished making map for --track-renames 2022/03/23 06:50:49 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:50:49 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for renames to finish 2022/03/23 06:50:49 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:50:50 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2022/03/23 06:50:50 INFO : potato: Copied (new) 2022/03/23 06:50:50 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2022/03/23 06:50:50 INFO : yam: Copied (new) 2022/03/23 06:50:50 DEBUG : Waiting for deletions to finish 2022/03/23 06:50:50 INFO : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Making map for --track-renames 2022/03/23 06:50:50 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:50:50 DEBUG : potato: Unchanged skipping 2022/03/23 06:50:50 INFO : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Finished making map for --track-renames 2022/03/23 06:50:50 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:50:50 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for renames to finish 2022/03/23 06:50:51 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:50:51 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2022/03/23 06:50:51 INFO : yam: Copied (server-side copy) to: yaml 2022/03/23 06:50:52 INFO : yam: Deleted 2022/03/23 06:50:52 INFO : yaml: Renamed from "yam" 2022/03/23 06:50:52 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:50:52 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenames (6.97s) === RUN TestParseRenamesStrategyModtime --- PASS: TestParseRenamesStrategyModtime (0.00s) === RUN TestRenamesStrategyModtime --- PASS: TestRenamesStrategyModtime (0.00s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" sync_test.go:1127: Can track renames: true 2022/03/23 06:50:56 INFO : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Making map for --track-renames 2022/03/23 06:50:56 INFO : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Finished making map for --track-renames 2022/03/23 06:50:56 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:50:56 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for renames to finish 2022/03/23 06:50:56 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:50:57 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2022/03/23 06:50:57 INFO : yam: Copied (new) 2022/03/23 06:50:57 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2022/03/23 06:50:57 INFO : potato: Copied (new) 2022/03/23 06:50:57 DEBUG : Waiting for deletions to finish 2022/03/23 06:50:58 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:50:58 DEBUG : potato: Unchanged skipping 2022/03/23 06:50:58 INFO : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Making map for --track-renames 2022/03/23 06:50:58 INFO : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Finished making map for --track-renames 2022/03/23 06:50:58 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:50:58 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for renames to finish 2022/03/23 06:50:58 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:50:59 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2022/03/23 06:50:59 INFO : yam: Copied (server-side copy) to: yaml 2022/03/23 06:51:00 INFO : yam: Deleted 2022/03/23 06:51:00 INFO : yaml: Renamed from "yam" 2022/03/23 06:51:00 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:51:00 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenamesStrategyModtime (8.89s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" sync_test.go:1163: Can track renames: true 2022/03/23 06:51:05 INFO : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Making map for --track-renames 2022/03/23 06:51:05 INFO : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Finished making map for --track-renames 2022/03/23 06:51:05 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:51:05 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for renames to finish 2022/03/23 06:51:05 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:51:05 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2022/03/23 06:51:05 INFO : sub/yam: Copied (new) 2022/03/23 06:51:06 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2022/03/23 06:51:06 INFO : potato: Copied (new) 2022/03/23 06:51:06 DEBUG : Waiting for deletions to finish 2022/03/23 06:51:06 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:51:06 DEBUG : potato: Unchanged skipping 2022/03/23 06:51:06 INFO : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Making map for --track-renames 2022/03/23 06:51:06 INFO : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Finished making map for --track-renames 2022/03/23 06:51:06 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:51:06 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for renames to finish 2022/03/23 06:51:07 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:51:08 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2022/03/23 06:51:08 INFO : sub/yam: Copied (server-side copy) to: yam 2022/03/23 06:51:08 INFO : sub/yam: Deleted 2022/03/23 06:51:08 INFO : yam: Renamed from "sub/yam" 2022/03/23 06:51:08 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:51:08 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenamesStrategyLeaf (6.13s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:51:11 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:51:11 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:51:12 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2022/03/23 06:51:12 INFO : nested/sub dir/file: Copied (new) 2022/03/23 06:51:12 INFO : nested/sub dir/file: Deleted 2022/03/23 06:51:12 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/03/23 06:51:12 INFO : sub dir/hello world: Copied (new) 2022/03/23 06:51:12 INFO : sub dir/hello world: Deleted 2022/03/23 06:51:12 INFO : sub dir: Removing directory 2022/03/23 06:51:12 INFO : nested/sub dir: Removing directory 2022/03/23 06:51:12 INFO : nested: Removing directory 2022/03/23 06:51:12 DEBUG : Local file system at /tmp/rclone958659976: deleted 3 directories --- PASS: TestMoveWithDeleteEmptySrcDirs (6.51s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:51:17 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:51:17 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:51:18 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2022/03/23 06:51:18 INFO : nested/sub dir/file: Copied (new) 2022/03/23 06:51:18 INFO : nested/sub dir/file: Deleted 2022/03/23 06:51:19 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2022/03/23 06:51:19 INFO : sub dir/hello world: Copied (new) 2022/03/23 06:51:19 INFO : sub dir/hello world: Deleted --- PASS: TestMoveWithoutDeleteEmptySrcDirs (5.46s) === RUN TestMoveWithIgnoreExisting run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:51:23 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:51:23 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:51:23 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2022/03/23 06:51:23 INFO : existing: Copied (new) 2022/03/23 06:51:23 INFO : existing: Deleted 2022/03/23 06:51:24 DEBUG : existing-b: sha1 = 321f6b7e8bf7f29aab89c5e41a555b1b0baa41a9 OK 2022/03/23 06:51:24 INFO : existing-b: Copied (new) 2022/03/23 06:51:24 INFO : existing-b: Deleted 2022/03/23 06:51:24 DEBUG : existing: Destination exists, skipping 2022/03/23 06:51:24 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2022/03/23 06:51:24 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:51:24 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:51:24 INFO : There was nothing to transfer --- PASS: TestMoveWithIgnoreExisting (3.50s) === RUN TestServerSideMove run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:51:26 DEBUG : Creating backend with remote "TestB2:rclone-test-barowor8xetuces3johixum5" 2022/03/23 06:51:26 DEBUG : Config file has changed externaly - reloading 2022/03/23 06:51:28 DEBUG : empty space: Clearing upload URL because of error: Post "https://pod-000-1137-11.backblaze.com/b2api/v1/b2_upload_file/ef121d13807dbb5b7ff80e1b/c001_v0001137_t0054": EOF 2022/03/23 06:51:28 DEBUG : pacer: low level retry 1/1 (error Post "https://pod-000-1137-11.backblaze.com/b2api/v1/b2_upload_file/ef121d13807dbb5b7ff80e1b/c001_v0001137_t0054": EOF) 2022/03/23 06:51:28 DEBUG : pacer: Rate limited, increasing sleep to 20ms run.go:283: Retry Put of "empty space" to B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: 1/10 (Post "https://pod-000-1137-11.backblaze.com/b2api/v1/b2_upload_file/ef121d13807dbb5b7ff80e1b/c001_v0001137_t0054": EOF) 2022/03/23 06:51:33 DEBUG : pacer: Reducing sleep to 10ms sync_test.go:1215: Server side move (if possible) B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 -> B2 bucket rclone-test-barowor8xetuces3johixum5 2022/03/23 06:51:39 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ms) 2022/03/23 06:51:39 DEBUG : empty space: Unchanged skipping 2022/03/23 06:51:39 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2022/03/23 06:51:39 DEBUG : B2 bucket rclone-test-barowor8xetuces3johixum5: Waiting for checks to finish 2022/03/23 06:51:39 INFO : empty space: Deleted 2022/03/23 06:51:39 DEBUG : B2 bucket rclone-test-barowor8xetuces3johixum5: Waiting for transfers to finish 2022/03/23 06:51:39 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/03/23 06:51:39 INFO : potato2: Copied (server-side copy) 2022/03/23 06:51:41 INFO : potato2: Deleted 2022/03/23 06:51:41 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2022/03/23 06:51:41 INFO : potato3: Copied (server-side copy) 2022/03/23 06:51:42 INFO : potato3: Deleted 2022/03/23 06:51:42 DEBUG : Creating backend with remote "TestB2:rclone-test-foyehib3tuwelid4pufakop5" 2022/03/23 06:51:42 DEBUG : Config file has changed externaly - reloading 2022/03/23 06:51:43 DEBUG : B2 bucket rclone-test-foyehib3tuwelid4pufakop5: Waiting for checks to finish 2022/03/23 06:51:43 DEBUG : B2 bucket rclone-test-foyehib3tuwelid4pufakop5: Waiting for transfers to finish 2022/03/23 06:51:44 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2022/03/23 06:51:44 INFO : potato3: Copied (server-side copy) 2022/03/23 06:51:44 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/03/23 06:51:44 INFO : empty space: Copied (server-side copy) 2022/03/23 06:51:45 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/03/23 06:51:45 INFO : potato2: Copied (server-side copy) 2022/03/23 06:51:45 INFO : empty space: Deleted 2022/03/23 06:51:45 INFO : potato3: Deleted 2022/03/23 06:51:45 INFO : potato2: Deleted 2022/03/23 06:51:46 DEBUG : B2 bucket rclone-test-foyehib3tuwelid4pufakop5: Purge remote 2022/03/23 06:51:46 DEBUG : empty space: Deleting (id "4_z7f32ada380bdbb5b7ff80e1b_f103b56bae480cc61_d20220323_m065144_c001_v0001117_t0018_u01648018304031") 2022/03/23 06:51:46 DEBUG : potato2: Deleting (id "4_z7f32ada380bdbb5b7ff80e1b_f1151d45f2be51174_d20220323_m065144_c001_v0001105_t0029_u01648018304040") 2022/03/23 06:51:46 DEBUG : potato3: Deleting (id "4_z7f32ada380bdbb5b7ff80e1b_f1023555142dd6ff0_d20220323_m065144_c001_v0001144_t0032_u01648018304082") 2022/03/23 06:51:46 DEBUG : B2 bucket rclone-test-barowor8xetuces3johixum5: Purge remote 2022/03/23 06:51:47 DEBUG : empty space: Deleting (id "4_z9fd28dc380bdbb5b7ff80e1b_f104790dfd7e40d06_d20220323_m065145_c001_v0001008_t0014_u01648018305012") 2022/03/23 06:51:47 DEBUG : empty space: Deleting (id "4_z9fd28dc380bdbb5b7ff80e1b_f1193dabad01a2ef6_d20220323_m065137_c001_v0001101_t0040_u01648018297106") 2022/03/23 06:51:47 DEBUG : potato2: Deleting (id "4_z9fd28dc380bdbb5b7ff80e1b_f1068c71b3c014aed_d20220323_m065145_c001_v0001116_t0006_u01648018305195") 2022/03/23 06:51:47 DEBUG : potato2: Deleting (id "4_z9fd28dc380bdbb5b7ff80e1b_f104094f5c4f1eaad_d20220323_m065139_c001_v0001098_t0043_u01648018299422") 2022/03/23 06:51:47 DEBUG : potato3: Deleting (id "4_z9fd28dc380bdbb5b7ff80e1b_f1087efbfe9606465_d20220323_m065144_c001_v0001116_t0039_u01648018304628") 2022/03/23 06:51:47 DEBUG : potato3: Deleting (id "4_z9fd28dc380bdbb5b7ff80e1b_f1169ca5059f892e8_d20220323_m065139_c001_v0001037_t0021_u01648018299821") 2022/03/23 06:51:47 DEBUG : potato3: Deleting (id "4_z9fd28dc380bdbb5b7ff80e1b_f1193dabad01a2f13_d20220323_m065138_c001_v0001101_t0046_u01648018298371") --- PASS: TestServerSideMove (21.90s) === RUN TestServerSideMoveWithFilter run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:51:48 DEBUG : Creating backend with remote "TestB2:rclone-test-vusiliq2musopil2gojorox5" sync_test.go:1215: Server side move (if possible) B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 -> B2 bucket rclone-test-vusiliq2musopil2gojorox5 2022/03/23 06:51:55 DEBUG : empty space: Excluded 2022/03/23 06:51:55 DEBUG : empty space: Excluded 2022/03/23 06:51:55 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2022/03/23 06:51:55 DEBUG : B2 bucket rclone-test-vusiliq2musopil2gojorox5: Waiting for checks to finish 2022/03/23 06:51:55 DEBUG : B2 bucket rclone-test-vusiliq2musopil2gojorox5: Waiting for transfers to finish 2022/03/23 06:51:57 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2022/03/23 06:51:57 INFO : potato3: Copied (server-side copy) 2022/03/23 06:51:58 INFO : potato3: Deleted 2022/03/23 06:51:58 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/03/23 06:51:58 INFO : potato2: Copied (server-side copy) 2022/03/23 06:51:58 INFO : potato2: Deleted 2022/03/23 06:51:59 DEBUG : Creating backend with remote "TestB2:rclone-test-catogab0movacom2piyaxor6" 2022/03/23 06:52:00 DEBUG : empty space: Excluded 2022/03/23 06:52:00 DEBUG : B2 bucket rclone-test-catogab0movacom2piyaxor6: Waiting for checks to finish 2022/03/23 06:52:00 DEBUG : B2 bucket rclone-test-catogab0movacom2piyaxor6: Waiting for transfers to finish 2022/03/23 06:52:00 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/03/23 06:52:00 INFO : potato2: Copied (server-side copy) 2022/03/23 06:52:01 INFO : potato2: Deleted 2022/03/23 06:52:03 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2022/03/23 06:52:03 INFO : potato3: Copied (server-side copy) 2022/03/23 06:52:04 INFO : potato3: Deleted 2022/03/23 06:52:04 DEBUG : B2 bucket rclone-test-catogab0movacom2piyaxor6: Purge remote 2022/03/23 06:52:05 DEBUG : potato2: Deleting (id "4_z1f22edb380bdbb5b7ff80e1b_f119f4d572722cb5d_d20220323_m065200_c001_v0001102_t0035_u01648018320627") 2022/03/23 06:52:05 DEBUG : potato3: Deleting (id "4_z1f22edb380bdbb5b7ff80e1b_f10431b76c989a23f_d20220323_m065202_c001_v0001104_t0049_u01648018322658") 2022/03/23 06:52:05 DEBUG : B2 bucket rclone-test-vusiliq2musopil2gojorox5: Purge remote 2022/03/23 06:52:05 DEBUG : empty space: Deleting (id "4_z2f22cdd380bdbb5b7ff80e1b_f109fa93c04daea29_d20220323_m065153_c001_v0001144_t0054_u01648018313703") 2022/03/23 06:52:05 DEBUG : potato2: Deleting (id "4_z2f22cdd380bdbb5b7ff80e1b_f1027f7a016cc94c2_d20220323_m065200_c001_v0001115_t0043_u01648018320933") 2022/03/23 06:52:05 DEBUG : potato2: Deleting (id "4_z2f22cdd380bdbb5b7ff80e1b_f111d22002426ccc2_d20220323_m065158_c001_v0001100_t0029_u01648018315534") 2022/03/23 06:52:05 DEBUG : potato3: Deleting (id "4_z2f22cdd380bdbb5b7ff80e1b_f112c274aec0f180b_d20220323_m065203_c001_v0001102_t0036_u01648018323994") 2022/03/23 06:52:05 DEBUG : potato3: Deleting (id "4_z2f22cdd380bdbb5b7ff80e1b_f115ec06cd9c9cbee_d20220323_m065155_c001_v0001115_t0044_u01648018315649") 2022/03/23 06:52:05 DEBUG : potato3: Deleting (id "4_z2f22cdd380bdbb5b7ff80e1b_f109fa93c04daea2f_d20220323_m065154_c001_v0001144_t0049_u01648018314244") --- PASS: TestServerSideMoveWithFilter (19.38s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:52:07 DEBUG : Creating backend with remote "TestB2:rclone-test-buvowix5yokejim7gabayuk0" 2022/03/23 06:52:12 DEBUG : tomatoDir: Making directory sync_test.go:1215: Server side move (if possible) B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 -> B2 bucket rclone-test-buvowix5yokejim7gabayuk0 2022/03/23 06:52:15 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ms) 2022/03/23 06:52:15 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2022/03/23 06:52:15 DEBUG : B2 bucket rclone-test-buvowix5yokejim7gabayuk0: Waiting for checks to finish 2022/03/23 06:52:15 DEBUG : empty space: Unchanged skipping 2022/03/23 06:52:16 INFO : empty space: Deleted 2022/03/23 06:52:16 DEBUG : B2 bucket rclone-test-buvowix5yokejim7gabayuk0: Waiting for transfers to finish 2022/03/23 06:52:16 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/03/23 06:52:16 INFO : potato2: Copied (server-side copy) 2022/03/23 06:52:17 INFO : potato2: Deleted 2022/03/23 06:52:17 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2022/03/23 06:52:17 INFO : potato3: Copied (server-side copy) 2022/03/23 06:52:18 INFO : potato3: Deleted 2022/03/23 06:52:18 DEBUG : Creating backend with remote "TestB2:rclone-test-yacokar0pifazuj4viciluh4" 2022/03/23 06:52:19 DEBUG : tomatoDir: Making directory 2022/03/23 06:52:19 DEBUG : B2 bucket rclone-test-yacokar0pifazuj4viciluh4: Waiting for checks to finish 2022/03/23 06:52:19 DEBUG : B2 bucket rclone-test-yacokar0pifazuj4viciluh4: Waiting for transfers to finish 2022/03/23 06:52:20 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2022/03/23 06:52:20 INFO : potato3: Copied (server-side copy) 2022/03/23 06:52:21 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2022/03/23 06:52:21 INFO : empty space: Copied (server-side copy) 2022/03/23 06:52:22 INFO : empty space: Deleted 2022/03/23 06:52:22 INFO : potato3: Deleted 2022/03/23 06:52:24 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2022/03/23 06:52:24 INFO : potato2: Copied (server-side copy) 2022/03/23 06:52:24 INFO : potato2: Deleted 2022/03/23 06:52:24 DEBUG : B2 bucket rclone-test-yacokar0pifazuj4viciluh4: Purge remote 2022/03/23 06:52:25 DEBUG : empty space: Deleting (id "4_zbfe23d6380cdbb5b7ff80e1b_f106363a9205c8d99_d20220323_m065220_c001_v0001099_t0052_u01648018340009") 2022/03/23 06:52:25 DEBUG : potato2: Deleting (id "4_zbfe23d6380cdbb5b7ff80e1b_f10396ef92aa346c8_d20220323_m065223_c001_v0001101_t0046_u01648018343329") 2022/03/23 06:52:25 DEBUG : potato3: Deleting (id "4_zbfe23d6380cdbb5b7ff80e1b_f116166bdda1dd7f7_d20220323_m065220_c001_v0001120_t0037_u01648018340113") 2022/03/23 06:52:25 DEBUG : B2 bucket rclone-test-buvowix5yokejim7gabayuk0: Purge remote 2022/03/23 06:52:26 DEBUG : empty space: Deleting (id "4_zdf721da380cdbb5b7ff80e1b_f116f64aa79776e96_d20220323_m065221_c001_v0001150_t0025_u01648018341622") 2022/03/23 06:52:26 DEBUG : empty space: Deleting (id "4_zdf721da380cdbb5b7ff80e1b_f11861a53f142a539_d20220323_m065213_c001_v0001097_t0031_u01648018333530") 2022/03/23 06:52:26 DEBUG : potato2: Deleting (id "4_zdf721da380cdbb5b7ff80e1b_f105058dbf78a8d61_d20220323_m065224_c001_v0001105_t0055_u01648018344170") 2022/03/23 06:52:26 DEBUG : potato2: Deleting (id "4_zdf721da380cdbb5b7ff80e1b_f100d71339b42f35f_d20220323_m065215_c001_v0001105_t0006_u01648018335889") 2022/03/23 06:52:26 DEBUG : potato3: Deleting (id "4_zdf721da380cdbb5b7ff80e1b_f117eb4e46277041d_d20220323_m065220_c001_v0001099_t0000_u01648018340708") 2022/03/23 06:52:26 DEBUG : potato3: Deleting (id "4_zdf721da380cdbb5b7ff80e1b_f11676a6f172f6f6e_d20220323_m065215_c001_v0001105_t0051_u01648018335840") 2022/03/23 06:52:26 DEBUG : potato3: Deleting (id "4_zdf721da380cdbb5b7ff80e1b_f11861a53f142a53f_d20220323_m065213_c001_v0001097_t0059_u01648018333927") --- PASS: TestServerSideMoveDeleteEmptySourceDirs (19.64s) === RUN TestServerSideMoveOverlap run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:52:27 DEBUG : Creating backend with remote "TestB2:rclone-test-fovakim7cuwafen2jisigaz4/rclone-move-test" 2022/03/23 06:52:28 DEBUG : Couldn't decode error response: EOF --- PASS: TestServerSideMoveOverlap (5.17s) === RUN TestSyncOverlap run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:52:32 DEBUG : Creating backend with remote "TestB2:rclone-test-fovakim7cuwafen2jisigaz4/rclone-sync-test" 2022/03/23 06:52:32 DEBUG : Couldn't decode error response: EOF --- PASS: TestSyncOverlap (0.79s) === RUN TestSyncCompareDest run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:52:33 DEBUG : Creating backend with remote "TestB2:rclone-test-fovakim7cuwafen2jisigaz4/dst" 2022/03/23 06:52:33 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:52:33 DEBUG : Creating backend with remote "TestB2:rclone-test-fovakim7cuwafen2jisigaz4/CompareDest" 2022/03/23 06:52:34 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:52:34 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:52:34 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for checks to finish 2022/03/23 06:52:34 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for transfers to finish 2022/03/23 06:52:35 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/03/23 06:52:35 INFO : one: Copied (new) 2022/03/23 06:52:35 DEBUG : Waiting for deletions to finish 2022/03/23 06:52:36 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for checks to finish 2022/03/23 06:52:36 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:52:36 DEBUG : one: Sizes differ (src 5 vs dst 3) 2022/03/23 06:52:36 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for transfers to finish 2022/03/23 06:52:36 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2022/03/23 06:52:36 INFO : one: Copied (replaced existing) 2022/03/23 06:52:36 DEBUG : Waiting for deletions to finish 2022/03/23 06:52:40 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for checks to finish 2022/03/23 06:52:40 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/03/23 06:52:40 DEBUG : one: Destination found in --compare-dest, skipping 2022/03/23 06:52:40 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for transfers to finish 2022/03/23 06:52:40 DEBUG : Waiting for deletions to finish 2022/03/23 06:52:40 INFO : There was nothing to transfer 2022/03/23 06:52:42 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/03/23 06:52:42 DEBUG : two: Destination found in --compare-dest, skipping 2022/03/23 06:52:42 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for checks to finish 2022/03/23 06:52:42 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/03/23 06:52:42 DEBUG : one: Destination found in --compare-dest, skipping 2022/03/23 06:52:42 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for transfers to finish 2022/03/23 06:52:42 DEBUG : Waiting for deletions to finish 2022/03/23 06:52:42 INFO : There was nothing to transfer 2022/03/23 06:52:42 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/03/23 06:52:42 DEBUG : two: Destination found in --compare-dest, skipping 2022/03/23 06:52:42 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for checks to finish 2022/03/23 06:52:43 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/03/23 06:52:43 DEBUG : one: Destination found in --compare-dest, skipping 2022/03/23 06:52:43 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for transfers to finish 2022/03/23 06:52:43 DEBUG : Waiting for deletions to finish 2022/03/23 06:52:43 INFO : There was nothing to transfer 2022/03/23 06:52:43 DEBUG : two: Modification times differ by -119h59m59.877s: 2011-12-30 12:59:59 +0000 UTC, 2011-12-25 12:59:59.123 +0000 UTC 2022/03/23 06:52:43 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2022/03/23 06:52:43 DEBUG : two: Destination found in --compare-dest, skipping 2022/03/23 06:52:43 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for checks to finish 2022/03/23 06:52:43 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/03/23 06:52:43 DEBUG : one: Destination found in --compare-dest, skipping 2022/03/23 06:52:43 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for transfers to finish 2022/03/23 06:52:43 DEBUG : Waiting for deletions to finish 2022/03/23 06:52:43 INFO : There was nothing to transfer 2022/03/23 06:52:44 DEBUG : two: Sizes differ (src 5 vs dst 3) 2022/03/23 06:52:44 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for checks to finish 2022/03/23 06:52:44 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/03/23 06:52:44 DEBUG : one: Destination found in --compare-dest, skipping 2022/03/23 06:52:44 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for transfers to finish 2022/03/23 06:52:46 DEBUG : two: sha1 = a4be8877ad88f3109a6411985a1f359e10e2d930 OK 2022/03/23 06:52:46 INFO : two: Copied (new) 2022/03/23 06:52:46 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (16.26s) === RUN TestSyncMultipleCompareDest run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:52:51 DEBUG : Creating backend with remote "TestB2:rclone-test-fovakim7cuwafen2jisigaz4/dest" 2022/03/23 06:52:53 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:52:53 DEBUG : Creating backend with remote "TestB2:rclone-test-fovakim7cuwafen2jisigaz4/pre-dest1" 2022/03/23 06:52:53 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:52:53 DEBUG : Creating backend with remote "TestB2:rclone-test-fovakim7cuwafen2jisigaz4/pre-dest2" 2022/03/23 06:52:54 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:52:54 DEBUG : 1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:52:54 DEBUG : 1: Destination found in --compare-dest, skipping 2022/03/23 06:52:54 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:52:54 DEBUG : 2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:52:54 DEBUG : 2: Destination found in --compare-dest, skipping 2022/03/23 06:52:55 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:52:55 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:52:55 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dest: Waiting for checks to finish 2022/03/23 06:52:55 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dest: Waiting for transfers to finish 2022/03/23 06:52:57 DEBUG : 3: sha1 = 77de68daecd823babbb58edb1c8e14d7106e83bb OK 2022/03/23 06:52:57 INFO : 3: Copied (new) 2022/03/23 06:52:57 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (9.62s) === RUN TestSyncCopyDest run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:52:59 DEBUG : Creating backend with remote "TestB2:rclone-test-fovakim7cuwafen2jisigaz4/dst" 2022/03/23 06:53:00 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:53:00 DEBUG : Creating backend with remote "TestB2:rclone-test-fovakim7cuwafen2jisigaz4/CopyDest" 2022/03/23 06:53:00 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:53:01 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:53:01 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for checks to finish 2022/03/23 06:53:01 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for transfers to finish 2022/03/23 06:53:02 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/03/23 06:53:02 INFO : one: Copied (new) 2022/03/23 06:53:02 DEBUG : Waiting for deletions to finish 2022/03/23 06:53:03 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for checks to finish 2022/03/23 06:53:03 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:53:03 DEBUG : one: Sizes differ (src 5 vs dst 3) 2022/03/23 06:53:03 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for transfers to finish 2022/03/23 06:53:03 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2022/03/23 06:53:03 INFO : one: Copied (replaced existing) 2022/03/23 06:53:03 DEBUG : Waiting for deletions to finish 2022/03/23 06:53:06 DEBUG : Creating backend with remote "TestB2:rclone-test-fovakim7cuwafen2jisigaz4/BackupDir" 2022/03/23 06:53:07 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:53:08 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for checks to finish 2022/03/23 06:53:08 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/03/23 06:53:08 DEBUG : one: Sizes differ (src 5 vs dst 3) 2022/03/23 06:53:08 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:53:09 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/03/23 06:53:09 INFO : one: Copied (server-side copy) 2022/03/23 06:53:10 INFO : one: Deleted 2022/03/23 06:53:10 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2022/03/23 06:53:10 INFO : one: Copied (server-side copy) 2022/03/23 06:53:10 DEBUG : one: Destination found in --copy-dest, using server-side copy 2022/03/23 06:53:10 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for transfers to finish 2022/03/23 06:53:10 DEBUG : Waiting for deletions to finish 2022/03/23 06:53:10 DEBUG : CopyDest/two: Clearing upload URL because of error: Post "https://pod-000-1044-10.backblaze.com/b2api/v1/b2_upload_file/ef121d13807dbb5b7ff80e1b/c001_v0001044_t0038": EOF 2022/03/23 06:53:10 DEBUG : pacer: low level retry 1/1 (error Post "https://pod-000-1044-10.backblaze.com/b2api/v1/b2_upload_file/ef121d13807dbb5b7ff80e1b/c001_v0001044_t0038": EOF) 2022/03/23 06:53:10 DEBUG : pacer: Rate limited, increasing sleep to 20ms run.go:283: Retry Put of "CopyDest/two" to B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: 1/10 (Post "https://pod-000-1044-10.backblaze.com/b2api/v1/b2_upload_file/ef121d13807dbb5b7ff80e1b/c001_v0001044_t0038": EOF) 2022/03/23 06:53:13 DEBUG : pacer: Reducing sleep to 10ms 2022/03/23 06:53:14 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/03/23 06:53:15 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2022/03/23 06:53:15 INFO : two: Copied (server-side copy) 2022/03/23 06:53:15 DEBUG : two: Destination found in --copy-dest, using server-side copy 2022/03/23 06:53:15 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for checks to finish 2022/03/23 06:53:15 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/03/23 06:53:15 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/03/23 06:53:15 DEBUG : one: Unchanged skipping 2022/03/23 06:53:15 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for transfers to finish 2022/03/23 06:53:15 DEBUG : Waiting for deletions to finish 2022/03/23 06:53:15 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for checks to finish 2022/03/23 06:53:15 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/03/23 06:53:15 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/03/23 06:53:15 DEBUG : one: Unchanged skipping 2022/03/23 06:53:16 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/03/23 06:53:16 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/03/23 06:53:16 DEBUG : two: Unchanged skipping 2022/03/23 06:53:16 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for transfers to finish 2022/03/23 06:53:16 DEBUG : Waiting for deletions to finish 2022/03/23 06:53:16 INFO : There was nothing to transfer 2022/03/23 06:53:17 DEBUG : three: Sizes differ (src 7 vs dst 5) 2022/03/23 06:53:17 DEBUG : three: Destination not found in --copy-dest 2022/03/23 06:53:17 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for checks to finish 2022/03/23 06:53:17 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/03/23 06:53:17 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/03/23 06:53:17 DEBUG : one: Unchanged skipping 2022/03/23 06:53:17 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/03/23 06:53:17 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2022/03/23 06:53:17 DEBUG : two: Unchanged skipping 2022/03/23 06:53:17 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for transfers to finish 2022/03/23 06:53:20 DEBUG : three: sha1 = 370e613335f3cf2f19b2a2d35a86402f55c659f8 OK 2022/03/23 06:53:20 INFO : three: Copied (new) 2022/03/23 06:53:20 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCopyDest (56.70s) === RUN TestSyncBackupDir run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:54:01 DEBUG : Creating backend with remote "TestB2:rclone-test-fovakim7cuwafen2jisigaz4/dst" 2022/03/23 06:54:03 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:54:03 DEBUG : Creating backend with remote "TestB2:rclone-test-fovakim7cuwafen2jisigaz4/backup" 2022/03/23 06:54:03 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:54:04 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/03/23 06:54:04 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:54:04 DEBUG : two: Unchanged skipping 2022/03/23 06:54:04 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for checks to finish 2022/03/23 06:54:04 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:54:06 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/03/23 06:54:06 INFO : one: Copied (server-side copy) 2022/03/23 06:54:06 INFO : one: Deleted 2022/03/23 06:54:06 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for transfers to finish 2022/03/23 06:54:07 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/03/23 06:54:07 INFO : one: Copied (new) 2022/03/23 06:54:07 DEBUG : Waiting for deletions to finish 2022/03/23 06:54:07 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:54:08 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/03/23 06:54:08 INFO : three.txt: Copied (server-side copy) 2022/03/23 06:54:10 INFO : three.txt: Deleted 2022/03/23 06:54:10 INFO : three.txt: Moved into backup dir 2022/03/23 06:54:12 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/03/23 06:54:12 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for checks to finish 2022/03/23 06:54:12 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:54:12 DEBUG : two: Unchanged skipping 2022/03/23 06:54:13 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/03/23 06:54:13 INFO : one: Copied (server-side copy) 2022/03/23 06:54:13 INFO : one: Deleted 2022/03/23 06:54:13 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for transfers to finish 2022/03/23 06:54:14 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2022/03/23 06:54:14 INFO : one: Copied (new) 2022/03/23 06:54:14 DEBUG : Waiting for deletions to finish 2022/03/23 06:54:15 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/03/23 06:54:15 INFO : three.txt: Copied (server-side copy) 2022/03/23 06:54:16 INFO : three.txt: Deleted 2022/03/23 06:54:16 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (22.98s) === RUN TestSyncBackupDirWithSuffix run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:54:21 DEBUG : Creating backend with remote "TestB2:rclone-test-fovakim7cuwafen2jisigaz4/dst" 2022/03/23 06:54:23 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:54:23 DEBUG : Creating backend with remote "TestB2:rclone-test-fovakim7cuwafen2jisigaz4/backup" 2022/03/23 06:54:23 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:54:23 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/03/23 06:54:23 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:54:23 DEBUG : two: Unchanged skipping 2022/03/23 06:54:23 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for checks to finish 2022/03/23 06:54:24 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:54:26 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/03/23 06:54:26 INFO : one: Copied (server-side copy) to: one.bak 2022/03/23 06:54:27 INFO : one: Deleted 2022/03/23 06:54:27 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for transfers to finish 2022/03/23 06:54:28 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/03/23 06:54:28 INFO : one: Copied (new) 2022/03/23 06:54:28 DEBUG : Waiting for deletions to finish 2022/03/23 06:54:29 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:54:31 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/03/23 06:54:31 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/03/23 06:54:33 INFO : three.txt: Deleted 2022/03/23 06:54:33 INFO : three.txt: Moved into backup dir 2022/03/23 06:54:35 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/03/23 06:54:35 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for checks to finish 2022/03/23 06:54:35 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:54:35 DEBUG : two: Unchanged skipping 2022/03/23 06:54:36 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/03/23 06:54:36 INFO : one: Copied (server-side copy) to: one.bak 2022/03/23 06:54:36 INFO : one: Deleted 2022/03/23 06:54:36 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for transfers to finish 2022/03/23 06:54:38 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2022/03/23 06:54:38 INFO : one: Copied (new) 2022/03/23 06:54:38 DEBUG : Waiting for deletions to finish 2022/03/23 06:54:38 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/03/23 06:54:38 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/03/23 06:54:39 INFO : three.txt: Deleted 2022/03/23 06:54:39 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (24.37s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:54:46 DEBUG : Creating backend with remote "TestB2:rclone-test-fovakim7cuwafen2jisigaz4/dst" 2022/03/23 06:54:47 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:54:47 DEBUG : Creating backend with remote "TestB2:rclone-test-fovakim7cuwafen2jisigaz4/backup" 2022/03/23 06:54:47 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:54:48 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/03/23 06:54:48 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:54:48 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for checks to finish 2022/03/23 06:54:48 DEBUG : two: Unchanged skipping 2022/03/23 06:54:48 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:54:49 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/03/23 06:54:49 INFO : one: Copied (server-side copy) to: one-2019-01-01 2022/03/23 06:54:50 INFO : one: Deleted 2022/03/23 06:54:50 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for transfers to finish 2022/03/23 06:54:51 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/03/23 06:54:51 INFO : one: Copied (new) 2022/03/23 06:54:51 DEBUG : Waiting for deletions to finish 2022/03/23 06:54:51 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:54:54 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/03/23 06:54:54 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2022/03/23 06:54:55 INFO : three.txt: Deleted 2022/03/23 06:54:55 INFO : three.txt: Moved into backup dir 2022/03/23 06:54:58 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/03/23 06:54:58 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for checks to finish 2022/03/23 06:54:58 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:54:58 DEBUG : two: Unchanged skipping 2022/03/23 06:55:00 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/03/23 06:55:00 INFO : one: Copied (server-side copy) to: one-2019-01-01 2022/03/23 06:55:01 INFO : one: Deleted 2022/03/23 06:55:01 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for transfers to finish 2022/03/23 06:55:01 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2022/03/23 06:55:01 INFO : one: Copied (new) 2022/03/23 06:55:01 DEBUG : Waiting for deletions to finish 2022/03/23 06:55:02 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/03/23 06:55:02 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2022/03/23 06:55:03 INFO : three.txt: Deleted 2022/03/23 06:55:03 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (27.39s) === RUN TestSyncBackupDirSuffixOnly run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:55:14 DEBUG : Creating backend with remote "TestB2:rclone-test-fovakim7cuwafen2jisigaz4/dst" 2022/03/23 06:55:14 DEBUG : Config file has changed externaly - reloading 2022/03/23 06:55:15 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:55:16 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for checks to finish 2022/03/23 06:55:16 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/03/23 06:55:16 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:55:16 DEBUG : two: Unchanged skipping 2022/03/23 06:55:16 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:55:16 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/03/23 06:55:16 INFO : one: Copied (server-side copy) to: one.bak 2022/03/23 06:55:17 INFO : one: Deleted 2022/03/23 06:55:17 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for transfers to finish 2022/03/23 06:55:18 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/03/23 06:55:18 INFO : one: Copied (new) 2022/03/23 06:55:18 DEBUG : Waiting for deletions to finish 2022/03/23 06:55:18 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:55:19 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/03/23 06:55:19 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/03/23 06:55:19 INFO : three.txt: Deleted 2022/03/23 06:55:19 INFO : three.txt: Moved into backup dir 2022/03/23 06:55:22 DEBUG : one.bak: Excluded 2022/03/23 06:55:22 DEBUG : three.txt.bak: Excluded 2022/03/23 06:55:22 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/03/23 06:55:22 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for checks to finish 2022/03/23 06:55:22 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:55:22 DEBUG : two: Unchanged skipping 2022/03/23 06:55:23 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/03/23 06:55:23 INFO : one: Copied (server-side copy) to: one.bak 2022/03/23 06:55:27 INFO : one: Deleted 2022/03/23 06:55:27 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4 path dst: Waiting for transfers to finish 2022/03/23 06:55:28 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2022/03/23 06:55:28 INFO : one: Copied (new) 2022/03/23 06:55:28 DEBUG : Waiting for deletions to finish 2022/03/23 06:55:30 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/03/23 06:55:30 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/03/23 06:55:31 INFO : three.txt: Deleted 2022/03/23 06:55:31 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (24.79s) === RUN TestSyncSuffix run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:55:40 DEBUG : Creating backend with remote "TestB2:rclone-test-fovakim7cuwafen2jisigaz4/dst" 2022/03/23 06:55:41 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:55:41 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/03/23 06:55:41 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:55:45 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/03/23 06:55:45 INFO : one: Copied (server-side copy) to: one.bak 2022/03/23 06:55:45 INFO : one: Deleted 2022/03/23 06:55:46 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/03/23 06:55:46 INFO : one: Copied (new) 2022/03/23 06:55:46 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:55:46 DEBUG : two: Unchanged skipping 2022/03/23 06:55:47 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2022/03/23 06:55:47 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:55:47 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/03/23 06:55:47 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/03/23 06:55:48 INFO : three.txt: Deleted 2022/03/23 06:55:48 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/03/23 06:55:48 INFO : three.txt: Copied (new) 2022/03/23 06:55:49 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/03/23 06:55:49 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/03/23 06:55:49 INFO : one: Copied (server-side copy) to: one.bak 2022/03/23 06:55:50 INFO : one: Deleted 2022/03/23 06:55:50 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2022/03/23 06:55:50 INFO : one: Copied (new) 2022/03/23 06:55:50 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:55:50 DEBUG : two: Unchanged skipping 2022/03/23 06:55:50 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2022/03/23 06:55:53 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/03/23 06:55:53 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/03/23 06:55:53 INFO : three.txt: Deleted 2022/03/23 06:55:54 DEBUG : three.txt: sha1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK 2022/03/23 06:55:54 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (23.27s) === RUN TestSyncSuffixKeepExtension run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:56:03 DEBUG : Creating backend with remote "TestB2:rclone-test-fovakim7cuwafen2jisigaz4/dst" 2022/03/23 06:56:04 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:56:04 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/03/23 06:56:04 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:56:06 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2022/03/23 06:56:06 INFO : one: Copied (server-side copy) to: one-2019-01-01 2022/03/23 06:56:09 INFO : one: Deleted 2022/03/23 06:56:10 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/03/23 06:56:10 INFO : one: Copied (new) 2022/03/23 06:56:11 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:56:11 DEBUG : two: Unchanged skipping 2022/03/23 06:56:11 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2022/03/23 06:56:11 DEBUG : Couldn't decode error response: EOF 2022/03/23 06:56:12 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2022/03/23 06:56:12 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2022/03/23 06:56:12 INFO : three.txt: Deleted 2022/03/23 06:56:13 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/03/23 06:56:13 INFO : three.txt: Copied (new) 2022/03/23 06:56:14 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/03/23 06:56:15 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2022/03/23 06:56:15 INFO : one: Copied (server-side copy) to: one-2019-01-01 2022/03/23 06:56:16 INFO : one: Deleted 2022/03/23 06:56:17 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2022/03/23 06:56:17 INFO : one: Copied (new) 2022/03/23 06:56:18 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:56:18 DEBUG : two: Unchanged skipping 2022/03/23 06:56:18 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2022/03/23 06:56:19 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2022/03/23 06:56:19 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2022/03/23 06:56:20 INFO : three.txt: Deleted 2022/03/23 06:56:21 DEBUG : three.txt: sha1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK 2022/03/23 06:56:21 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (28.42s) === RUN TestSyncUTFNorm run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:56:28 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:56:28 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2022/03/23 06:56:28 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:56:29 DEBUG : Testêé: sha1 = a54d88e06612d820bc3be72877c74f257b561b19 OK 2022/03/23 06:56:29 INFO : Testêé: Copied (replaced existing) to: Testêé 2022/03/23 06:56:29 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (4.15s) === RUN TestSyncImmutable run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:56:31 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:56:31 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:56:32 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2022/03/23 06:56:32 INFO : existing: Copied (new) 2022/03/23 06:56:32 DEBUG : Waiting for deletions to finish 2022/03/23 06:56:32 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:56:32 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2022/03/23 06:56:32 ERROR : existing: Source and destination exist but do not match: immutable file modified 2022/03/23 06:56:32 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:56:32 ERROR : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: not deleting files as there were IO errors 2022/03/23 06:56:32 ERROR : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: not deleting directories as there were IO errors --- PASS: TestSyncImmutable (2.66s) === RUN TestSyncIgnoreCase run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:56:35 DEBUG : existing: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:56:35 DEBUG : existing: Unchanged skipping 2022/03/23 06:56:35 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:56:35 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:56:35 DEBUG : Waiting for deletions to finish 2022/03/23 06:56:35 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (2.47s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" sync_test.go:1989: This test only runs on local === RUN TestMaxTransfer/Soft run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" sync_test.go:1989: This test only runs on local === RUN TestMaxTransfer/Cautious run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" sync_test.go:1989: This test only runs on local --- PASS: TestMaxTransfer (1.08s) --- SKIP: TestMaxTransfer/Hard (0.37s) --- SKIP: TestMaxTransfer/Soft (0.35s) --- SKIP: TestMaxTransfer/Cautious (0.35s) === RUN TestSyncConcurrentDelete run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:57:10 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:57:10 DEBUG : both0: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:57:10 DEBUG : both0: Unchanged skipping 2022/03/23 06:57:10 DEBUG : both11: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:57:10 DEBUG : both10: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:57:10 DEBUG : both10: Unchanged skipping 2022/03/23 06:57:10 DEBUG : both13: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:57:10 DEBUG : both13: Unchanged skipping 2022/03/23 06:57:10 DEBUG : both12: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:57:10 DEBUG : both14: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:57:10 DEBUG : both12: Unchanged skipping 2022/03/23 06:57:10 DEBUG : both15: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:57:10 DEBUG : both15: Unchanged skipping 2022/03/23 06:57:10 DEBUG : both16: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:57:10 DEBUG : both16: Unchanged skipping 2022/03/23 06:57:10 DEBUG : both17: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:57:10 DEBUG : both17: Unchanged skipping 2022/03/23 06:57:10 DEBUG : both18: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:57:10 DEBUG : both18: Unchanged skipping 2022/03/23 06:57:10 DEBUG : both19: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:57:10 DEBUG : both1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:57:10 DEBUG : both1: Unchanged skipping 2022/03/23 06:57:10 DEBUG : both2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:57:10 DEBUG : both2: Unchanged skipping 2022/03/23 06:57:10 DEBUG : both3: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:57:10 DEBUG : both3: Unchanged skipping 2022/03/23 06:57:10 DEBUG : both4: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:57:10 DEBUG : both14: Unchanged skipping 2022/03/23 06:57:10 DEBUG : both5: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:57:10 DEBUG : both5: Unchanged skipping 2022/03/23 06:57:10 DEBUG : both6: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:57:10 DEBUG : both6: Unchanged skipping 2022/03/23 06:57:10 DEBUG : both7: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:57:10 DEBUG : both7: Unchanged skipping 2022/03/23 06:57:10 DEBUG : both8: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:57:10 DEBUG : both8: Unchanged skipping 2022/03/23 06:57:10 DEBUG : both9: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:57:10 DEBUG : both9: Unchanged skipping 2022/03/23 06:57:10 DEBUG : both19: Unchanged skipping 2022/03/23 06:57:10 DEBUG : both11: Unchanged skipping 2022/03/23 06:57:10 DEBUG : both4: Unchanged skipping 2022/03/23 06:57:10 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:57:10 DEBUG : Waiting for deletions to finish 2022/03/23 06:57:11 INFO : only13: Deleted 2022/03/23 06:57:12 INFO : only6: Deleted 2022/03/23 06:57:12 INFO : only19: Deleted 2022/03/23 06:57:12 INFO : only0: Deleted 2022/03/23 06:57:12 INFO : only1: Deleted 2022/03/23 06:57:12 INFO : only11: Deleted 2022/03/23 06:57:12 INFO : only14: Deleted 2022/03/23 06:57:13 INFO : only7: Deleted 2022/03/23 06:57:13 INFO : only15: Deleted 2022/03/23 06:57:14 INFO : only8: Deleted 2022/03/23 06:57:14 INFO : only17: Deleted 2022/03/23 06:57:14 INFO : only5: Deleted 2022/03/23 06:57:14 INFO : only3: Deleted 2022/03/23 06:57:15 INFO : only2: Deleted 2022/03/23 06:57:15 INFO : only10: Deleted 2022/03/23 06:57:15 INFO : only9: Deleted 2022/03/23 06:57:15 INFO : only12: Deleted 2022/03/23 06:57:15 INFO : only16: Deleted 2022/03/23 06:57:15 INFO : only18: Deleted 2022/03/23 06:57:16 INFO : only4: Deleted 2022/03/23 06:57:16 INFO : There was nothing to transfer --- PASS: TestSyncConcurrentDelete (60.00s) === RUN TestSyncConcurrentTruncate run.go:181: Remote "B2 bucket rclone-test-fovakim7cuwafen2jisigaz4", Local "Local file system at /tmp/rclone958659976", Modify Window "1ms" 2022/03/23 06:58:09 DEBUG : both10: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:58:09 DEBUG : both10: Unchanged skipping 2022/03/23 06:58:09 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for checks to finish 2022/03/23 06:58:09 DEBUG : both12: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:58:09 DEBUG : both12: Unchanged skipping 2022/03/23 06:58:09 DEBUG : both13: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:58:09 DEBUG : both13: Unchanged skipping 2022/03/23 06:58:09 DEBUG : both14: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:58:09 DEBUG : both14: Unchanged skipping 2022/03/23 06:58:09 DEBUG : both15: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:58:09 DEBUG : both15: Unchanged skipping 2022/03/23 06:58:09 DEBUG : both16: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:58:09 DEBUG : both16: Unchanged skipping 2022/03/23 06:58:09 DEBUG : both17: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:58:09 DEBUG : both17: Unchanged skipping 2022/03/23 06:58:09 DEBUG : both18: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:58:09 DEBUG : both18: Unchanged skipping 2022/03/23 06:58:09 DEBUG : both19: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:58:09 DEBUG : both19: Unchanged skipping 2022/03/23 06:58:09 DEBUG : both2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:58:09 DEBUG : both2: Unchanged skipping 2022/03/23 06:58:09 DEBUG : both3: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:58:09 DEBUG : both3: Unchanged skipping 2022/03/23 06:58:09 DEBUG : both4: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:58:09 DEBUG : both4: Unchanged skipping 2022/03/23 06:58:09 DEBUG : both5: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:58:09 DEBUG : both5: Unchanged skipping 2022/03/23 06:58:09 DEBUG : both6: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:58:09 DEBUG : both6: Unchanged skipping 2022/03/23 06:58:09 DEBUG : both7: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:58:09 DEBUG : both7: Unchanged skipping 2022/03/23 06:58:09 DEBUG : both8: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:58:09 DEBUG : both8: Unchanged skipping 2022/03/23 06:58:09 DEBUG : both9: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:58:09 DEBUG : both1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:58:09 DEBUG : both9: Unchanged skipping 2022/03/23 06:58:09 DEBUG : both1: Unchanged skipping 2022/03/23 06:58:09 DEBUG : both0: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:58:09 DEBUG : both0: Unchanged skipping 2022/03/23 06:58:09 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2022/03/23 06:58:09 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2022/03/23 06:58:09 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2022/03/23 06:58:09 DEBUG : both11: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2022/03/23 06:58:09 DEBUG : both11: Unchanged skipping 2022/03/23 06:58:09 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2022/03/23 06:58:09 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2022/03/23 06:58:09 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2022/03/23 06:58:09 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2022/03/23 06:58:09 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2022/03/23 06:58:09 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2022/03/23 06:58:09 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2022/03/23 06:58:09 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2022/03/23 06:58:09 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2022/03/23 06:58:09 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2022/03/23 06:58:09 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2022/03/23 06:58:09 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2022/03/23 06:58:09 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2022/03/23 06:58:09 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2022/03/23 06:58:09 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2022/03/23 06:58:09 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2022/03/23 06:58:09 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2022/03/23 06:58:09 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Waiting for transfers to finish 2022/03/23 06:58:10 DEBUG : only10: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/03/23 06:58:10 INFO : only10: Copied (replaced existing) 2022/03/23 06:58:11 DEBUG : only0: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/03/23 06:58:11 INFO : only0: Copied (replaced existing) 2022/03/23 06:58:12 DEBUG : only13: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/03/23 06:58:12 INFO : only13: Copied (replaced existing) 2022/03/23 06:58:12 DEBUG : only11: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/03/23 06:58:12 INFO : only11: Copied (replaced existing) 2022/03/23 06:58:12 DEBUG : only16: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/03/23 06:58:12 INFO : only16: Copied (replaced existing) 2022/03/23 06:58:13 DEBUG : only18: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/03/23 06:58:13 INFO : only18: Copied (replaced existing) 2022/03/23 06:58:13 DEBUG : only17: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/03/23 06:58:13 INFO : only17: Copied (replaced existing) 2022/03/23 06:58:13 DEBUG : only14: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/03/23 06:58:13 INFO : only14: Copied (replaced existing) 2022/03/23 06:58:14 DEBUG : only15: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/03/23 06:58:14 INFO : only15: Copied (replaced existing) 2022/03/23 06:58:14 DEBUG : only19: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/03/23 06:58:14 INFO : only19: Copied (replaced existing) 2022/03/23 06:58:14 DEBUG : only5: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/03/23 06:58:14 INFO : only5: Copied (replaced existing) 2022/03/23 06:58:14 DEBUG : only3: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/03/23 06:58:14 INFO : only3: Copied (replaced existing) 2022/03/23 06:58:15 DEBUG : only6: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/03/23 06:58:15 INFO : only6: Copied (replaced existing) 2022/03/23 06:58:15 DEBUG : only2: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/03/23 06:58:15 INFO : only2: Copied (replaced existing) 2022/03/23 06:58:15 DEBUG : only8: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/03/23 06:58:15 INFO : only8: Copied (replaced existing) 2022/03/23 06:58:15 DEBUG : only7: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/03/23 06:58:15 INFO : only7: Copied (replaced existing) 2022/03/23 06:58:15 DEBUG : only4: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/03/23 06:58:15 INFO : only4: Copied (replaced existing) 2022/03/23 06:58:16 DEBUG : only12: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/03/23 06:58:16 INFO : only12: Copied (replaced existing) 2022/03/23 06:58:16 DEBUG : only1: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/03/23 06:58:16 INFO : only1: Copied (replaced existing) 2022/03/23 06:58:16 DEBUG : only9: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2022/03/23 06:58:16 INFO : only9: Copied (replaced existing) 2022/03/23 06:58:16 DEBUG : Waiting for deletions to finish --- PASS: TestSyncConcurrentTruncate (79.36s) PASS 2022/03/23 06:58:56 DEBUG : B2 bucket rclone-test-fovakim7cuwafen2jisigaz4: Purge remote 2022/03/23 06:58:57 DEBUG : BackupDir/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f111e07ece4af1e90_d20220323_m065320_c001_v0001032_t0048_u01648018400619") 2022/03/23 06:58:57 DEBUG : BackupDir/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1010bb55dacb9d97_d20220323_m065309_c001_v0001105_t0056_u01648018389382") 2022/03/23 06:58:57 DEBUG : CompareDest/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1033b0b4cdda259b_d20220323_m065246_c001_v0001102_t0017_u01648018366582") 2022/03/23 06:58:57 DEBUG : CompareDest/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88c71_d20220323_m065238_c001_v0001044_t0041_u01648018358778") 2022/03/23 06:58:57 DEBUG : CompareDest/two: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f113ae2805cfd6961_d20220323_m065247_c001_v0001037_t0043_u01648018367581") 2022/03/23 06:58:57 DEBUG : CompareDest/two: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c45018b_d20220323_m065240_c001_v0001116_t0011_u01648018360957") 2022/03/23 06:58:57 DEBUG : CopyDest/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1087efbfe9606c4a_d20220323_m065321_c001_v0001116_t0023_u01648018401727") 2022/03/23 06:58:57 DEBUG : CopyDest/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c4503d1_d20220323_m065306_c001_v0001116_t0008_u01648018386180") 2022/03/23 06:58:57 DEBUG : CopyDest/three: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f10344c4eb8fb418a_d20220323_m065322_c001_v0001134_t0034_u01648018402445") 2022/03/23 06:58:57 DEBUG : CopyDest/three: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c450499_d20220323_m065316_c001_v0001116_t0050_u01648018396430") 2022/03/23 06:58:57 DEBUG : CopyDest/two: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f11390653b11ef423_d20220323_m065323_c001_v0001018_t0037_u01648018403193") 2022/03/23 06:58:57 DEBUG : CopyDest/two: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c45044a_d20220323_m065313_c001_v0001116_t0029_u01648018393150") 2022/03/23 06:58:58 DEBUG : EXISTING: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f105f5868eda4c2a2_d20220323_m065636_c001_v0001042_t0049_u01648018596020") 2022/03/23 06:58:58 DEBUG : EXISTING: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451513_d20220323_m065634_c001_v0001116_t0007_u01648018594048") 2022/03/23 06:58:58 DEBUG : Testêé: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1014972750f69235_d20220323_m065630_c001_v0001005_t0038_u01648018590259") 2022/03/23 06:58:58 DEBUG : Testêé: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c4514b7_d20220323_m065629_c001_v0001116_t0056_u01648018589043") 2022/03/23 06:58:58 DEBUG : Testêé: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451485_d20220323_m065627_c001_v0001116_t0027_u01648018587733") 2022/03/23 06:58:58 DEBUG : a/potato2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1174a172ea2ce558_d20220323_m064958_c001_v0001120_t0028_u01648018198327") 2022/03/23 06:58:58 DEBUG : a/potato2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb8897b_d20220323_m064957_c001_v0001044_t0048_u01648018197456") 2022/03/23 06:58:58 DEBUG : a/potato2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1182e4896f388994_d20220323_m064953_c001_v0001036_t0006_u01648018193234") 2022/03/23 06:58:58 DEBUG : a/potato2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb8895c_d20220323_m064951_c001_v0001044_t0020_u01648018191200") 2022/03/23 06:58:58 DEBUG : a/potato2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110d4802f4cdf88e_d20220323_m064756_c001_v0001036_t0022_u01648018076748") 2022/03/23 06:58:58 DEBUG : a/potato2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88757_d20220323_m064755_c001_v0001044_t0009_u01648018075208") 2022/03/23 06:58:58 DEBUG : b/potato: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f116411e2d9b5795a_d20220323_m064958_c001_v0001146_t0038_u01648018198972") 2022/03/23 06:58:58 DEBUG : b/potato: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb8896a_d20220323_m064954_c001_v0001044_t0000_u01648018194383") 2022/03/23 06:58:58 DEBUG : b/potato: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1108a7322dce8d34_d20220323_m064951_c001_v0001134_t0053_u01648018191966") 2022/03/23 06:58:58 DEBUG : b/potato: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88950_d20220323_m064949_c001_v0001044_t0039_u01648018189705") 2022/03/23 06:58:58 DEBUG : b/potato: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f111d22002426ba85_d20220323_m064755_c001_v0001100_t0057_u01648018075661") 2022/03/23 06:58:58 DEBUG : b/potato: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88748_d20220323_m064752_c001_v0001044_t0015_u01648018072741") 2022/03/23 06:58:58 DEBUG : backup/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f116a516f29288e4c_d20220323_m065416_c001_v0001099_t0006_u01648018456869") 2022/03/23 06:58:58 DEBUG : backup/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1008d42e99808c03_d20220323_m065412_c001_v0001131_t0057_u01648018452869") 2022/03/23 06:58:59 DEBUG : backup/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f118f595ee219e14a_d20220323_m065405_c001_v0001116_t0029_u01648018445276") 2022/03/23 06:58:59 DEBUG : backup/one-2019-01-01: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f108ff0977d31514d_d20220323_m065503_c001_v0001115_t0056_u01648018503824") 2022/03/23 06:58:59 DEBUG : backup/one-2019-01-01: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1118fe6140742772_d20220323_m065459_c001_v0001098_t0012_u01648018499584") 2022/03/23 06:58:59 DEBUG : backup/one-2019-01-01: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f104c7ec8f2fde5cc_d20220323_m065449_c001_v0001136_t0033_u01648018489482") 2022/03/23 06:58:59 DEBUG : backup/one.bak: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1095ef04e099eac7_d20220323_m065439_c001_v0001097_t0028_u01648018479524") 2022/03/23 06:58:59 DEBUG : backup/one.bak: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1074816bae982404_d20220323_m065436_c001_v0001097_t0002_u01648018476090") 2022/03/23 06:58:59 DEBUG : backup/one.bak: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f11952728e358da53_d20220323_m065425_c001_v0001115_t0039_u01648018465156") 2022/03/23 06:58:59 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f104dc8850806cd63_d20220323_m065504_c001_v0001102_t0027_u01648018504434") 2022/03/23 06:58:59 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1014314387f905be_d20220323_m065502_c001_v0001145_t0006_u01648018502272") 2022/03/23 06:58:59 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f105e3131232876eb_d20220323_m065451_c001_v0001104_t0044_u01648018491639") 2022/03/23 06:58:59 DEBUG : backup/three.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f111d65286baa44f0_d20220323_m065417_c001_v0001130_t0030_u01648018457217") 2022/03/23 06:58:59 DEBUG : backup/three.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f11703c84678e48fa_d20220323_m065415_c001_v0001106_t0002_u01648018455202") 2022/03/23 06:58:59 DEBUG : backup/three.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f117941b4e9508cba_d20220323_m065407_c001_v0001116_t0035_u01648018447950") 2022/03/23 06:58:59 DEBUG : backup/three.txt.bak: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f105c363532d4ba0b_d20220323_m065441_c001_v0001161_t0011_u01648018481397") 2022/03/23 06:58:59 DEBUG : backup/three.txt.bak: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1164a68cd0fe63cb_d20220323_m065438_c001_v0001101_t0033_u01648018478396") 2022/03/23 06:58:59 DEBUG : backup/three.txt.bak: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f112586c77238f884_d20220323_m065429_c001_v0001104_t0033_u01648018469176") 2022/03/23 06:59:00 DEBUG : both0: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f101cefcf66a0e70c_d20220323_m065817_c001_v0001157_t0034_u01648018697579") 2022/03/23 06:59:00 DEBUG : both0: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451aa1_d20220323_m065738_c001_v0001116_t0038_u01648018658097") 2022/03/23 06:59:00 DEBUG : both0: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f11655d2317a2de7a_d20220323_m065717_c001_v0001018_t0008_u01648018637052") 2022/03/23 06:59:00 DEBUG : both0: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451558_d20220323_m065637_c001_v0001116_t0054_u01648018597580") 2022/03/23 06:59:00 DEBUG : both1: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1151d45f2be529d2_d20220323_m065817_c001_v0001105_t0037_u01648018697871") 2022/03/23 06:59:00 DEBUG : both1: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451acb_d20220323_m065739_c001_v0001116_t0009_u01648018659870") 2022/03/23 06:59:00 DEBUG : both1: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f113903bf342d06ec_d20220323_m065717_c001_v0001165_t0058_u01648018637832") 2022/03/23 06:59:00 DEBUG : both1: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c45158c_d20220323_m065639_c001_v0001116_t0038_u01648018599242") 2022/03/23 06:59:00 DEBUG : both10: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1006493a8aab0317_d20220323_m065818_c001_v0001104_t0025_u01648018698282") 2022/03/23 06:59:00 DEBUG : both10: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451bec_d20220323_m065754_c001_v0001116_t0004_u01648018674112") 2022/03/23 06:59:00 DEBUG : both10: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f100f8b0237e73938_d20220323_m065718_c001_v0001146_t0000_u01648018638091") 2022/03/23 06:59:00 DEBUG : both10: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c4516ee_d20220323_m065654_c001_v0001116_t0046_u01648018614138") 2022/03/23 06:59:00 DEBUG : both11: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1086e0a1b963c312_d20220323_m065820_c001_v0001098_t0021_u01648018700117") 2022/03/23 06:59:00 DEBUG : both11: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451c09_d20220323_m065755_c001_v0001116_t0001_u01648018675485") 2022/03/23 06:59:00 DEBUG : both11: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1015bb4ee6b9729b_d20220323_m065718_c001_v0001115_t0053_u01648018638760") 2022/03/23 06:59:00 DEBUG : both11: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451710_d20220323_m065655_c001_v0001116_t0023_u01648018615602") 2022/03/23 06:59:00 DEBUG : both12: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f112ce49d3b9125fc_d20220323_m065821_c001_v0001154_t0024_u01648018701370") 2022/03/23 06:59:00 DEBUG : both12: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451c1b_d20220323_m065756_c001_v0001116_t0002_u01648018676674") 2022/03/23 06:59:00 DEBUG : both12: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f116cc5f65d16811d_d20220323_m065719_c001_v0001109_t0050_u01648018639580") 2022/03/23 06:59:00 DEBUG : both12: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c45172f_d20220323_m065656_c001_v0001116_t0056_u01648018616891") 2022/03/23 06:59:01 DEBUG : both13: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f102e0dbb4ebd8ab5_d20220323_m065821_c001_v0001157_t0033_u01648018701574") 2022/03/23 06:59:01 DEBUG : both13: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451c3a_d20220323_m065758_c001_v0001116_t0057_u01648018678093") 2022/03/23 06:59:01 DEBUG : both13: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110da63d8049d89d_d20220323_m065720_c001_v0001103_t0052_u01648018640194") 2022/03/23 06:59:01 DEBUG : both13: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451757_d20220323_m065658_c001_v0001116_t0057_u01648018618421") 2022/03/23 06:59:01 DEBUG : both14: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f112c4767f8766954_d20220323_m065821_c001_v0001115_t0043_u01648018701982") 2022/03/23 06:59:01 DEBUG : both14: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451c58_d20220323_m065759_c001_v0001116_t0018_u01648018679554") 2022/03/23 06:59:01 DEBUG : both14: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f105e313123288181_d20220323_m065722_c001_v0001104_t0020_u01648018642071") 2022/03/23 06:59:01 DEBUG : both14: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451787_d20220323_m065700_c001_v0001116_t0045_u01648018620085") 2022/03/23 06:59:01 DEBUG : both15: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f112df3c6bbf10167_d20220323_m065822_c001_v0001043_t0034_u01648018702863") 2022/03/23 06:59:01 DEBUG : both15: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451c8c_d20220323_m065801_c001_v0001116_t0023_u01648018681616") 2022/03/23 06:59:01 DEBUG : both15: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f108b08ee86635904_d20220323_m065722_c001_v0001109_t0013_u01648018642691") 2022/03/23 06:59:01 DEBUG : both15: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c4517ba_d20220323_m065701_c001_v0001116_t0047_u01648018621953") 2022/03/23 06:59:01 DEBUG : both16: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f115ac9fc199ed570_d20220323_m065823_c001_v0001146_t0021_u01648018703525") 2022/03/23 06:59:01 DEBUG : both16: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451ca2_d20220323_m065802_c001_v0001116_t0041_u01648018682931") 2022/03/23 06:59:01 DEBUG : both16: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f10050be3d0e3148b_d20220323_m065723_c001_v0001101_t0026_u01648018643283") 2022/03/23 06:59:01 DEBUG : both16: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c4517e2_d20220323_m065703_c001_v0001116_t0040_u01648018623967") 2022/03/23 06:59:01 DEBUG : both17: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1062019d8e6b9ca1_d20220323_m065824_c001_v0001120_t0046_u01648018704042") 2022/03/23 06:59:01 DEBUG : both17: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451cc2_d20220323_m065804_c001_v0001116_t0012_u01648018684732") 2022/03/23 06:59:01 DEBUG : both17: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f109a483a424d290d_d20220323_m065723_c001_v0001146_t0030_u01648018643707") 2022/03/23 06:59:02 DEBUG : both17: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c45180a_d20220323_m065705_c001_v0001116_t0049_u01648018625316") 2022/03/23 06:59:02 DEBUG : both18: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f105e9169bd3d1b74_d20220323_m065824_c001_v0001106_t0019_u01648018704997") 2022/03/23 06:59:02 DEBUG : both18: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451ce6_d20220323_m065806_c001_v0001116_t0016_u01648018686388") 2022/03/23 06:59:02 DEBUG : both18: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f100a1e1da10cb823_d20220323_m065725_c001_v0001098_t0020_u01648018645728") 2022/03/23 06:59:02 DEBUG : both18: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451833_d20220323_m065706_c001_v0001116_t0003_u01648018626863") 2022/03/23 06:59:02 DEBUG : both19: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f116bf5a63eff2088_d20220323_m065825_c001_v0001106_t0006_u01648018705607") 2022/03/23 06:59:02 DEBUG : both19: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451d0c_d20220323_m065807_c001_v0001116_t0009_u01648018687841") 2022/03/23 06:59:02 DEBUG : both19: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1006be00c0196289_d20220323_m065726_c001_v0001116_t0057_u01648018646327") 2022/03/23 06:59:02 DEBUG : both19: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451856_d20220323_m065708_c001_v0001116_t0027_u01648018628386") 2022/03/23 06:59:02 DEBUG : both2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f113ee69f012e3493_d20220323_m065827_c001_v0001098_t0031_u01648018707028") 2022/03/23 06:59:02 DEBUG : both2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451af5_d20220323_m065741_c001_v0001116_t0041_u01648018661679") 2022/03/23 06:59:02 DEBUG : both2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1160d107409b6ae0_d20220323_m065727_c001_v0001165_t0028_u01648018647167") 2022/03/23 06:59:02 DEBUG : both2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c4515bc_d20220323_m065641_c001_v0001116_t0010_u01648018601223") 2022/03/23 06:59:02 DEBUG : both3: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1059401508dcf6e4_d20220323_m065827_c001_v0001115_t0054_u01648018707368") 2022/03/23 06:59:02 DEBUG : both3: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451b17_d20220323_m065743_c001_v0001116_t0059_u01648018663495") 2022/03/23 06:59:02 DEBUG : both3: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1179a403c85e0da7_d20220323_m065727_c001_v0001036_t0053_u01648018647376") 2022/03/23 06:59:03 DEBUG : both3: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c4515dd_d20220323_m065642_c001_v0001116_t0030_u01648018602856") 2022/03/23 06:59:03 DEBUG : both4: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f10050be3d0e318e7_d20220323_m065828_c001_v0001101_t0021_u01648018708517") 2022/03/23 06:59:03 DEBUG : both4: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451b35_d20220323_m065745_c001_v0001116_t0053_u01648018665081") 2022/03/23 06:59:03 DEBUG : both4: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f106713bf19c70d05_d20220323_m065730_c001_v0001109_t0000_u01648018650196") 2022/03/23 06:59:03 DEBUG : both4: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451602_d20220323_m065644_c001_v0001116_t0044_u01648018604440") 2022/03/23 06:59:03 DEBUG : both5: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1131658961cd538c_d20220323_m065828_c001_v0001102_t0014_u01648018708864") 2022/03/23 06:59:03 DEBUG : both5: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451b51_d20220323_m065746_c001_v0001116_t0014_u01648018666398") 2022/03/23 06:59:03 DEBUG : both5: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1196a9d9eb83ced3_d20220323_m065730_c001_v0001098_t0031_u01648018650647") 2022/03/23 06:59:03 DEBUG : both5: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451626_d20220323_m065646_c001_v0001116_t0031_u01648018606145") 2022/03/23 06:59:03 DEBUG : both6: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1028c144c481b61f_d20220323_m065834_c001_v0001041_t0056_u01648018714531") 2022/03/23 06:59:03 DEBUG : both6: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451b6b_d20220323_m065747_c001_v0001116_t0035_u01648018667811") 2022/03/23 06:59:03 DEBUG : both6: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f11831f0ec865a4de_d20220323_m065731_c001_v0001099_t0026_u01648018651950") 2022/03/23 06:59:03 DEBUG : both6: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c45164e_d20220323_m065647_c001_v0001116_t0000_u01648018607555") 2022/03/23 06:59:03 DEBUG : both7: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f102b05ce6701f709_d20220323_m065836_c001_v0001150_t0045_u01648018715601") 2022/03/23 06:59:03 DEBUG : both7: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451b8d_d20220323_m065749_c001_v0001116_t0058_u01648018669287") 2022/03/23 06:59:03 DEBUG : both7: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1027f7a016ccbceb_d20220323_m065733_c001_v0001115_t0043_u01648018652759") 2022/03/23 06:59:03 DEBUG : both7: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451676_d20220323_m065649_c001_v0001116_t0042_u01648018609490") 2022/03/23 06:59:03 DEBUG : both8: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f107e7a5f88019b5c_d20220323_m065836_c001_v0001115_t0058_u01648018716846") 2022/03/23 06:59:03 DEBUG : both8: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451bab_d20220323_m065750_c001_v0001116_t0033_u01648018670808") 2022/03/23 06:59:03 DEBUG : both8: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1103b2ca9e747cb0_d20220323_m065734_c001_v0001116_t0054_u01648018654736") 2022/03/23 06:59:04 DEBUG : both8: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451693_d20220323_m065651_c001_v0001116_t0014_u01648018611030") 2022/03/23 06:59:04 DEBUG : both9: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f118116f3a58f0d5c_d20220323_m065837_c001_v0001136_t0016_u01648018717755") 2022/03/23 06:59:04 DEBUG : both9: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451bcc_d20220323_m065752_c001_v0001116_t0014_u01648018672447") 2022/03/23 06:59:04 DEBUG : both9: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f102a065c55274e8d_d20220323_m065735_c001_v0001102_t0034_u01648018655666") 2022/03/23 06:59:04 DEBUG : both9: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c4516c0_d20220323_m065652_c001_v0001116_t0046_u01648018612489") 2022/03/23 06:59:04 DEBUG : c/non empty space: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1015bb4ee6b93d2f_d20220323_m065000_c001_v0001115_t0054_u01648018200066") 2022/03/23 06:59:04 DEBUG : c/non empty space: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88979_d20220323_m064956_c001_v0001044_t0059_u01648018196682") 2022/03/23 06:59:04 DEBUG : c/non empty space: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f103ddab5a9e8ff10_d20220323_m064953_c001_v0001131_t0033_u01648018193736") 2022/03/23 06:59:04 DEBUG : c/non empty space: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88954_d20220323_m064950_c001_v0001044_t0057_u01648018190275") 2022/03/23 06:59:04 DEBUG : c/non empty space: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f10415eecc2e96351_d20220323_m064757_c001_v0001150_t0049_u01648018077503") 2022/03/23 06:59:04 DEBUG : c/non empty space: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88755_d20220323_m064754_c001_v0001044_t0005_u01648018074346") 2022/03/23 06:59:04 DEBUG : check sum: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f107d8bb8acb69d80_d20220323_m064737_c001_v0001146_t0026_u01648018057249") 2022/03/23 06:59:04 DEBUG : check sum: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb886d5_d20220323_m064733_c001_v0001044_t0047_u01648018053674") 2022/03/23 06:59:04 DEBUG : dest/3: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f115d96c82354628b_d20220323_m065257_c001_v0001116_t0041_u01648018377620") 2022/03/23 06:59:04 DEBUG : dest/3: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f102a065c55273ba2_d20220323_m065256_c001_v0001102_t0009_u01648018376063") 2022/03/23 06:59:04 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1158e115f898c582_d20220323_m065621_c001_v0001100_t0053_u01648018581505") 2022/03/23 06:59:04 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1170db11c1a904a3_d20220323_m065616_c001_v0001100_t0045_u01648018576226") 2022/03/23 06:59:04 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f108b08ee86635440_d20220323_m065615_c001_v0001109_t0055_u01648018575140") 2022/03/23 06:59:05 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1170db11c1a90420_d20220323_m065610_c001_v0001100_t0053_u01648018570461") 2022/03/23 06:59:05 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1115e968bf15d305_d20220323_m065606_c001_v0001102_t0003_u01648018566895") 2022/03/23 06:59:05 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451232_d20220323_m065559_c001_v0001116_t0024_u01648018559349") 2022/03/23 06:59:05 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1075ad2a39e1caf4_d20220323_m065555_c001_v0001031_t0041_u01648018555271") 2022/03/23 06:59:05 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f11565ad12d9d89f9_d20220323_m065550_c001_v0001131_t0050_u01648018550286") 2022/03/23 06:59:05 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110cfd356cbe9aef_d20220323_m065549_c001_v0001099_t0012_u01648018549986") 2022/03/23 06:59:05 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f11565ad12d9d89e3_d20220323_m065546_c001_v0001131_t0025_u01648018546412") 2022/03/23 06:59:05 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f101a54710b2513f1_d20220323_m065545_c001_v0001154_t0010_u01648018545467") 2022/03/23 06:59:05 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c45103d_d20220323_m065536_c001_v0001116_t0051_u01648018536044") 2022/03/23 06:59:05 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f100d71339b43002c_d20220323_m065531_c001_v0001105_t0027_u01648018531984") 2022/03/23 06:59:05 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f10653af0b196c266_d20220323_m065527_c001_v0001021_t0028_u01648018527952") 2022/03/23 06:59:05 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f113bace4dfa1461a_d20220323_m065524_c001_v0001093_t0041_u01648018524115") 2022/03/23 06:59:05 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f10653af0b196c236_d20220323_m065518_c001_v0001021_t0033_u01648018518529") 2022/03/23 06:59:05 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f104113bd41ef229e_d20220323_m065516_c001_v0001109_t0018_u01648018516961") 2022/03/23 06:59:05 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c450e65_d20220323_m065511_c001_v0001116_t0054_u01648018511254") 2022/03/23 06:59:05 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110841ee838f2692_d20220323_m065504_c001_v0001106_t0035_u01648018504718") 2022/03/23 06:59:05 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f105643cce588f33c_d20220323_m065501_c001_v0001130_t0024_u01648018501772") 2022/03/23 06:59:05 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1006be00c01955ba_d20220323_m065500_c001_v0001116_t0005_u01648018500112") 2022/03/23 06:59:05 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f105643cce588f300_d20220323_m065451_c001_v0001130_t0031_u01648018491140") 2022/03/23 06:59:05 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f100d2d312924b5bb_d20220323_m065449_c001_v0001040_t0056_u01648018489858") 2022/03/23 06:59:06 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c450bff_d20220323_m065443_c001_v0001116_t0005_u01648018483869") 2022/03/23 06:59:06 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f107e255712bf12c3_d20220323_m065441_c001_v0001105_t0001_u01648018481935") 2022/03/23 06:59:06 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f103de26c7ddd1e4a_d20220323_m065437_c001_v0001116_t0009_u01648018477496") 2022/03/23 06:59:06 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f106ceea707b4439d_d20220323_m065436_c001_v0001146_t0026_u01648018476477") 2022/03/23 06:59:06 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f103de26c7ddd1d78_d20220323_m065427_c001_v0001116_t0039_u01648018467940") 2022/03/23 06:59:06 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f105e9169bd3d0be3_d20220323_m065426_c001_v0001106_t0023_u01648018466092") 2022/03/23 06:59:06 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c4509b5_d20220323_m065419_c001_v0001116_t0019_u01648018459501") 2022/03/23 06:59:06 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f109a483a424d21a4_d20220323_m065417_c001_v0001146_t0019_u01648018457544") 2022/03/23 06:59:06 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f116d697f2a80c8d3_d20220323_m065414_c001_v0001144_t0018_u01648018454467") 2022/03/23 06:59:06 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f109937f7b1a35177_d20220323_m065413_c001_v0001093_t0001_u01648018453293") 2022/03/23 06:59:06 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f116d697f2a80c895_d20220323_m065407_c001_v0001144_t0048_u01648018447269") 2022/03/23 06:59:06 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f117a963a1b935150_d20220323_m065406_c001_v0001003_t0004_u01648018446150") 2022/03/23 06:59:06 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c4507bc_d20220323_m065356_c001_v0001116_t0015_u01648018436537") 2022/03/23 06:59:06 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1076c4f3e5c53755_d20220323_m065323_c001_v0001037_t0009_u01648018403710") 2022/03/23 06:59:06 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f11076e08b221f955_d20220323_m065310_c001_v0001154_t0010_u01648018390202") 2022/03/23 06:59:06 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f107d8bb8acb6a7b0_d20220323_m065309_c001_v0001146_t0012_u01648018389877") 2022/03/23 06:59:06 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88cdd_d20220323_m065304_c001_v0001044_t0046_u01648018384415") 2022/03/23 06:59:06 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f111d22002426d1a0_d20220323_m065303_c001_v0001100_t0005_u01648018383369") 2022/03/23 06:59:06 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f111d22002426d18e_d20220323_m065301_c001_v0001100_t0041_u01648018381855") 2022/03/23 06:59:06 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f10314d78f1008029_d20220323_m065248_c001_v0001103_t0025_u01648018368113") 2022/03/23 06:59:07 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c450134_d20220323_m065237_c001_v0001116_t0055_u01648018357402") 2022/03/23 06:59:07 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110aea18a6bea8c4_d20220323_m065236_c001_v0001136_t0035_u01648018356389") 2022/03/23 06:59:07 DEBUG : dst/one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110aea18a6bea8ba_d20220323_m065235_c001_v0001136_t0006_u01648018355382") 2022/03/23 06:59:07 DEBUG : dst/one-2019-01-01: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f117209013453cbfe_d20220323_m065622_c001_v0001136_t0018_u01648018582675") 2022/03/23 06:59:07 DEBUG : dst/one-2019-01-01: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1050268e75d4c6b2_d20220323_m065614_c001_v0001116_t0019_u01648018574392") 2022/03/23 06:59:07 DEBUG : dst/one-2019-01-01: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f10817861252d4873_d20220323_m065606_c001_v0001145_t0046_u01648018566002") 2022/03/23 06:59:07 DEBUG : dst/one.bak: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f100792a88517242a_d20220323_m065555_c001_v0001136_t0041_u01648018555759") 2022/03/23 06:59:07 DEBUG : dst/one.bak: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1078e84138e8f45f_d20220323_m065549_c001_v0001043_t0016_u01648018549387") 2022/03/23 06:59:07 DEBUG : dst/one.bak: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f116a516f292894c6_d20220323_m065543_c001_v0001099_t0058_u01648018542915") 2022/03/23 06:59:07 DEBUG : dst/one.bak: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1030c31778e15781_d20220323_m065533_c001_v0001000_t0009_u01648018533035") 2022/03/23 06:59:07 DEBUG : dst/one.bak: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f118f595ee219e7f9_d20220323_m065523_c001_v0001116_t0039_u01648018523019") 2022/03/23 06:59:07 DEBUG : dst/one.bak: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1128b73aee912b2b_d20220323_m065516_c001_v0001150_t0040_u01648018516463") 2022/03/23 06:59:07 DEBUG : dst/three: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1109784c9f43821d_d20220323_m065354_c001_v0001150_t0057_u01648018434858") 2022/03/23 06:59:07 DEBUG : dst/three: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f111d22002426d2a7_d20220323_m065318_c001_v0001100_t0047_u01648018398099") 2022/03/23 06:59:07 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f11543c3212b7a579_d20220323_m065623_c001_v0001008_t0017_u01648018583205") 2022/03/23 06:59:07 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f107608213a94fd99_d20220323_m065618_c001_v0001144_t0018_u01648018578613") 2022/03/23 06:59:07 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1037f459a087c8b8_d20220323_m065612_c001_v0001109_t0009_u01648018572067") 2022/03/23 06:59:08 DEBUG : dst/three.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f112ecf29f49bdb5f_d20220323_m065625_c001_v0001099_t0038_u01648018585859") 2022/03/23 06:59:08 DEBUG : dst/three.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1170db11c1a904d9_d20220323_m065620_c001_v0001100_t0045_u01648018580708") 2022/03/23 06:59:08 DEBUG : dst/three.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f113f81da04bf4e6e_d20220323_m065619_c001_v0001116_t0027_u01648018579749") 2022/03/23 06:59:08 DEBUG : dst/three.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1170db11c1a90457_d20220323_m065612_c001_v0001100_t0046_u01648018572887") 2022/03/23 06:59:08 DEBUG : dst/three.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f11031ffff0221f5a_d20220323_m065612_c001_v0001101_t0056_u01648018572588") 2022/03/23 06:59:08 DEBUG : dst/three.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451269_d20220323_m065601_c001_v0001116_t0057_u01648018561393") 2022/03/23 06:59:08 DEBUG : dst/three.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1078dced7b87023f_d20220323_m065556_c001_v0001106_t0006_u01648018556048") 2022/03/23 06:59:08 DEBUG : dst/three.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f11565ad12d9d8a0e_d20220323_m065553_c001_v0001131_t0034_u01648018553742") 2022/03/23 06:59:08 DEBUG : dst/three.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f104a02232084193a_d20220323_m065553_c001_v0001146_t0054_u01648018553315") 2022/03/23 06:59:08 DEBUG : dst/three.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f11565ad12d9d89ef_d20220323_m065548_c001_v0001131_t0019_u01648018548114") 2022/03/23 06:59:08 DEBUG : dst/three.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f10050be3d0e30e2f_d20220323_m065547_c001_v0001101_t0041_u01648018547618") 2022/03/23 06:59:08 DEBUG : dst/three.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c45108f_d20220323_m065539_c001_v0001116_t0015_u01648018539378") 2022/03/23 06:59:08 DEBUG : dst/three.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f108dc0480b03f2ae_d20220323_m065531_c001_v0001039_t0033_u01648018531046") 2022/03/23 06:59:08 DEBUG : dst/three.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c450f23_d20220323_m065520_c001_v0001116_t0012_u01648018520269") 2022/03/23 06:59:08 DEBUG : dst/three.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f104db1d3733ec152_d20220323_m065519_c001_v0001103_t0057_u01648018519264") 2022/03/23 06:59:08 DEBUG : dst/three.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c450e9f_d20220323_m065513_c001_v0001116_t0042_u01648018513346") 2022/03/23 06:59:08 DEBUG : dst/three.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1164a68cd0fe6569_d20220323_m065502_c001_v0001101_t0059_u01648018502921") 2022/03/23 06:59:08 DEBUG : dst/three.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c450d28_d20220323_m065456_c001_v0001116_t0044_u01648018496732") 2022/03/23 06:59:08 DEBUG : dst/three.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1169ca5059f8955d_d20220323_m065454_c001_v0001037_t0031_u01648018494177") 2022/03/23 06:59:09 DEBUG : dst/three.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c450c31_d20220323_m065445_c001_v0001116_t0055_u01648018485279") 2022/03/23 06:59:09 DEBUG : dst/three.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1018485c2ec71c79_d20220323_m065438_c001_v0001042_t0050_u01648018478762") 2022/03/23 06:59:09 DEBUG : dst/three.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c450b17_d20220323_m065434_c001_v0001116_t0057_u01648018474239") 2022/03/23 06:59:09 DEBUG : dst/three.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1039dac6682faabf_d20220323_m065431_c001_v0001104_t0048_u01648018471636") 2022/03/23 06:59:09 DEBUG : dst/three.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c4509db_d20220323_m065420_c001_v0001116_t0020_u01648018460928") 2022/03/23 06:59:09 DEBUG : dst/three.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f106a6fec1ff1f57d_d20220323_m065415_c001_v0001101_t0038_u01648018455947") 2022/03/23 06:59:09 DEBUG : dst/three.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c4508ec_d20220323_m065410_c001_v0001116_t0047_u01648018450936") 2022/03/23 06:59:09 DEBUG : dst/three.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1164a68cd0fe6193_d20220323_m065408_c001_v0001101_t0029_u01648018448794") 2022/03/23 06:59:09 DEBUG : dst/three.txt: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c450802_d20220323_m065400_c001_v0001116_t0054_u01648018440385") 2022/03/23 06:59:09 DEBUG : dst/three.txt.bak: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f10917e52824412b3_d20220323_m065557_c001_v0001106_t0025_u01648018557638") 2022/03/23 06:59:09 DEBUG : dst/three.txt.bak: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f115fb0e83ab21d9f_d20220323_m065551_c001_v0001117_t0021_u01648018551231") 2022/03/23 06:59:09 DEBUG : dst/three.txt.bak: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f119ed07dce1b0d4e_d20220323_m065547_c001_v0001103_t0016_u01648018547285") 2022/03/23 06:59:09 DEBUG : dst/three.txt.bak: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f100d71339b43004b_d20220323_m065534_c001_v0001105_t0036_u01648018534032") 2022/03/23 06:59:09 DEBUG : dst/three.txt.bak: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f112c4767f87655cd_d20220323_m065530_c001_v0001115_t0050_u01648018530208") 2022/03/23 06:59:09 DEBUG : dst/three.txt.bak: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f10502a8b47f8ffc4_d20220323_m065519_c001_v0001165_t0019_u01648018519039") 2022/03/23 06:59:09 DEBUG : dst/two: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f103a185ccae3fecf_d20220323_m065626_c001_v0001092_t0011_u01648018586392") 2022/03/23 06:59:09 DEBUG : dst/two: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c45124c_d20220323_m065600_c001_v0001116_t0030_u01648018560249") 2022/03/23 06:59:09 DEBUG : dst/two: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f108f24640637b3c7_d20220323_m065558_c001_v0001022_t0023_u01648018558183") 2022/03/23 06:59:09 DEBUG : dst/two: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451051_d20220323_m065537_c001_v0001116_t0012_u01648018537095") 2022/03/23 06:59:09 DEBUG : dst/two: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1186df60feb24d89_d20220323_m065535_c001_v0001102_t0032_u01648018535057") 2022/03/23 06:59:09 DEBUG : dst/two: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c450e8f_d20220323_m065512_c001_v0001116_t0008_u01648018512534") 2022/03/23 06:59:10 DEBUG : dst/two: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1146d401ec5741e9_d20220323_m065506_c001_v0001104_t0042_u01648018506992") 2022/03/23 06:59:10 DEBUG : dst/two: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c450c15_d20220323_m065444_c001_v0001116_t0034_u01648018484550") 2022/03/23 06:59:10 DEBUG : dst/two: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110ae1dab27109db_d20220323_m065442_c001_v0001037_t0040_u01648018482590") 2022/03/23 06:59:10 DEBUG : dst/two: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c4509cd_d20220323_m065420_c001_v0001116_t0054_u01648018460108") 2022/03/23 06:59:10 DEBUG : dst/two: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1071e16ecd96d167_d20220323_m065417_c001_v0001104_t0029_u01648018457910") 2022/03/23 06:59:10 DEBUG : dst/two: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c4507c4_d20220323_m065357_c001_v0001116_t0037_u01648018437198") 2022/03/23 06:59:10 DEBUG : dst/two: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f115ff1032c0d1a55_d20220323_m065355_c001_v0001103_t0050_u01648018435500") 2022/03/23 06:59:10 DEBUG : dst/two: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1023555142dd730e_d20220323_m065314_c001_v0001144_t0035_u01648018394844") 2022/03/23 06:59:10 DEBUG : dst/two: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1018ea4faee1dea5_d20220323_m065248_c001_v0001044_t0018_u01648018368526") 2022/03/23 06:59:10 DEBUG : dst/two: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110aea18a6bea8ef_d20220323_m065245_c001_v0001136_t0035_u01648018365258") 2022/03/23 06:59:10 DEBUG : empty space: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110077c03bf1713e_d20220323_m065215_c001_v0001097_t0052_u01648018335838") 2022/03/23 06:59:10 DEBUG : empty space: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88bfc_d20220323_m065210_c001_v0001044_t0050_u01648018330996") 2022/03/23 06:59:10 DEBUG : empty space: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1057713770ad8858_d20220323_m065207_c001_v0001043_t0046_u01648018327183") 2022/03/23 06:59:10 DEBUG : empty space: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c44fd1c_d20220323_m065150_c001_v0001116_t0030_u01648018310723") 2022/03/23 06:59:10 DEBUG : empty space: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f109111faa1592b20_d20220323_m065139_c001_v0001165_t0001_u01648018299539") 2022/03/23 06:59:10 DEBUG : empty space: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88b45_d20220323_m065131_c001_v0001044_t0053_u01648018291360") 2022/03/23 06:59:10 DEBUG : empty space: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1170db11c1a8ece1_d20220323_m065028_c001_v0001100_t0053_u01648018228910") 2022/03/23 06:59:10 DEBUG : empty space: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88a17_d20220323_m065024_c001_v0001044_t0044_u01648018224927") 2022/03/23 06:59:10 DEBUG : empty space: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1100318a1f0813d4_d20220323_m065022_c001_v0001098_t0039_u01648018222214") 2022/03/23 06:59:11 DEBUG : empty space: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb889fc_d20220323_m065020_c001_v0001044_t0020_u01648018220588") 2022/03/23 06:59:11 DEBUG : empty space: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f102ba1fefb339e56_d20220323_m065010_c001_v0001116_t0007_u01648018210911") 2022/03/23 06:59:11 DEBUG : empty space: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb889b7_d20220323_m065008_c001_v0001044_t0051_u01648018208533") 2022/03/23 06:59:11 DEBUG : empty space: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f113c0f81a4f00f0b_d20220323_m065003_c001_v0001106_t0047_u01648018203778") 2022/03/23 06:59:11 DEBUG : empty space: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88997_d20220323_m065002_c001_v0001044_t0052_u01648018202152") 2022/03/23 06:59:11 DEBUG : empty space: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f11433213bc9a2fee_d20220323_m064944_c001_v0001109_t0020_u01648018184607") 2022/03/23 06:59:11 DEBUG : empty space: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb8891c_d20220323_m064941_c001_v0001044_t0054_u01648018181218") 2022/03/23 06:59:11 DEBUG : empty space: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f114f33d5f3fac72a_d20220323_m064937_c001_v0001115_t0000_u01648018177744") 2022/03/23 06:59:11 DEBUG : empty space: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88904_d20220323_m064936_c001_v0001044_t0051_u01648018176786") 2022/03/23 06:59:11 DEBUG : empty space: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f118c0fe16ff129e3_d20220323_m064850_c001_v0001130_t0001_u01648018130027") 2022/03/23 06:59:11 DEBUG : empty space: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88845_d20220323_m064847_c001_v0001044_t0046_u01648018127095") 2022/03/23 06:59:11 DEBUG : empty space: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f115ff1032c0d00a1_d20220323_m064803_c001_v0001103_t0054_u01648018083340") 2022/03/23 06:59:11 DEBUG : empty space: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88773_d20220323_m064802_c001_v0001044_t0023_u01648018082137") 2022/03/23 06:59:11 DEBUG : empty space: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f11445d05ce9bfc5e_d20220323_m064801_c001_v0001130_t0000_u01648018081554") 2022/03/23 06:59:11 DEBUG : empty space: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1027f7a016cc78a0_d20220323_m064800_c001_v0001115_t0054_u01648018080117") 2022/03/23 06:59:11 DEBUG : empty space: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb8875f_d20220323_m064757_c001_v0001044_t0019_u01648018077932") 2022/03/23 06:59:11 DEBUG : enormous: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f11187aa360c2440c_d20220323_m065026_c001_v0001103_t0035_u01648018226301") 2022/03/23 06:59:11 DEBUG : enormous: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88a19_d20220323_m065025_c001_v0001044_t0046_u01648018225452") 2022/03/23 06:59:11 DEBUG : existing: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f119c36ec0f1db4e4_d20220323_m065633_c001_v0001145_t0051_u01648018593321") 2022/03/23 06:59:12 DEBUG : existing: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c4514e4_d20220323_m065631_c001_v0001116_t0004_u01648018591735") 2022/03/23 06:59:12 DEBUG : existing: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f11187aa360c247d3_d20220323_m065124_c001_v0001103_t0011_u01648018284929") 2022/03/23 06:59:12 DEBUG : existing: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1119fee28c9e74bc_d20220323_m065123_c001_v0001137_t0058_u01648018283450") 2022/03/23 06:59:12 DEBUG : existing: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1018967cf881ff0a_d20220323_m064752_c001_v0001011_t0030_u01648018072072") 2022/03/23 06:59:12 DEBUG : existing: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb8872e_d20220323_m064748_c001_v0001044_t0029_u01648018068687") 2022/03/23 06:59:12 DEBUG : existing: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f10784defd8fa8db8_d20220323_m064748_c001_v0001165_t0058_u01648018068011") 2022/03/23 06:59:12 DEBUG : existing: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88723_d20220323_m064746_c001_v0001044_t0021_u01648018065994") 2022/03/23 06:59:12 DEBUG : existing: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb8870f_d20220323_m064742_c001_v0001044_t0016_u01648018062527") 2022/03/23 06:59:12 DEBUG : existing-b: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f10514a71c2dd03be_d20220323_m065125_c001_v0001098_t0048_u01648018285810") 2022/03/23 06:59:12 DEBUG : existing-b: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88b30_d20220323_m065123_c001_v0001044_t0052_u01648018283752") 2022/03/23 06:59:12 DEBUG : five: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1036d5fd3f9eaf30_d20220323_m065043_c001_v0001165_t0019_u01648018243980") 2022/03/23 06:59:12 DEBUG : five: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88a4e_d20220323_m065035_c001_v0001044_t0049_u01648018235402") 2022/03/23 06:59:12 DEBUG : foo: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f119e6f8617f9e44c_d20220323_m064846_c001_v0001136_t0032_u01648018126607") 2022/03/23 06:59:12 DEBUG : foo: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb8883e_d20220323_m064845_c001_v0001044_t0023_u01648018125433") 2022/03/23 06:59:12 DEBUG : foo: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb8877b_d20220323_m064804_c001_v0001044_t0011_u01648018084356") 2022/03/23 06:59:12 DEBUG : four: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1172763d0edbf8b9_d20220323_m065044_c001_v0001098_t0023_u01648018244197") 2022/03/23 06:59:12 DEBUG : four: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c44f6a6_d20220323_m065036_c001_v0001116_t0030_u01648018236068") 2022/03/23 06:59:12 DEBUG : four: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88a3c_d20220323_m065030_c001_v0001044_t0044_u01648018230819") 2022/03/23 06:59:12 DEBUG : hello world2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110f748f59cf06f5_d20220323_m064703_c001_v0001000_t0015_u01648018023330") 2022/03/23 06:59:12 DEBUG : hello world2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb8862c_d20220323_m064659_c001_v0001044_t0043_u01648018019031") 2022/03/23 06:59:13 DEBUG : ignore-size: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f114f33d5f3fab7cb_d20220323_m064741_c001_v0001115_t0036_u01648018061368") 2022/03/23 06:59:13 DEBUG : ignore-size: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88701_d20220323_m064740_c001_v0001044_t0058_u01648018060182") 2022/03/23 06:59:13 DEBUG : nested/sub dir/file: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1168e6caa9095c36_d20220323_m065119_c001_v0001161_t0049_u01648018279599") 2022/03/23 06:59:13 DEBUG : nested/sub dir/file: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1119fee28c9e7494_d20220323_m065118_c001_v0001137_t0046_u01648018278292") 2022/03/23 06:59:13 DEBUG : nested/sub dir/file: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f106ceda0eecde5c3_d20220323_m065113_c001_v0001032_t0023_u01648018273090") 2022/03/23 06:59:13 DEBUG : nested/sub dir/file: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1119fee28c9e7469_d20220323_m065111_c001_v0001137_t0039_u01648018271792") 2022/03/23 06:59:13 DEBUG : one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f104d1356817d54e5_d20220323_m065045_c001_v0001041_t0056_u01648018245224") 2022/03/23 06:59:13 DEBUG : one: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88a2f_d20220323_m065029_c001_v0001044_t0034_u01648018229485") 2022/03/23 06:59:13 DEBUG : only0: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f114e94ef8f84ae92_d20220323_m065838_c001_v0001038_t0028_u01648018718413") 2022/03/23 06:59:13 DEBUG : only0: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f100eac75e552d2f5_d20220323_m065810_c001_v0001106_t0030_u01648018690955") 2022/03/23 06:59:13 DEBUG : only0: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451ab6_d20220323_m065739_c001_v0001116_t0013_u01648018659143") 2022/03/23 06:59:13 DEBUG : only0: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f103b6376e067e5d7_d20220323_m065712_c001_v0001091_t0005_u01648018632144") 2022/03/23 06:59:13 DEBUG : only0: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451576_d20220323_m065638_c001_v0001116_t0006_u01648018598450") 2022/03/23 06:59:13 DEBUG : only1: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f117e7aa7a43ead63_d20220323_m065838_c001_v0001134_t0041_u01648018718889") 2022/03/23 06:59:13 DEBUG : only1: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451dbb_d20220323_m065815_c001_v0001116_t0020_u01648018695801") 2022/03/23 06:59:13 DEBUG : only1: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451adf_d20220323_m065740_c001_v0001116_t0012_u01648018660718") 2022/03/23 06:59:13 DEBUG : only1: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f104db1d3733ec8d1_d20220323_m065712_c001_v0001103_t0029_u01648018632337") 2022/03/23 06:59:13 DEBUG : only1: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c4515a4_d20220323_m065640_c001_v0001116_t0024_u01648018600240") 2022/03/23 06:59:13 DEBUG : only10: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f10300ee4512e79fb_d20220323_m065839_c001_v0001115_t0033_u01648018719355") 2022/03/23 06:59:13 DEBUG : only10: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451d44_d20220323_m065810_c001_v0001116_t0001_u01648018690071") 2022/03/23 06:59:14 DEBUG : only10: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451bf8_d20220323_m065754_c001_v0001116_t0056_u01648018674776") 2022/03/23 06:59:14 DEBUG : only10: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1059401508dcedf5_d20220323_m065714_c001_v0001115_t0036_u01648018634468") 2022/03/23 06:59:14 DEBUG : only10: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451702_d20220323_m065654_c001_v0001116_t0040_u01648018614912") 2022/03/23 06:59:14 DEBUG : only11: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f109f616fd7a9c535_d20220323_m065840_c001_v0001116_t0009_u01648018720691") 2022/03/23 06:59:14 DEBUG : only11: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f109de00fbb974fbf_d20220323_m065810_c001_v0001042_t0045_u01648018690775") 2022/03/23 06:59:14 DEBUG : only11: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451c15_d20220323_m065756_c001_v0001116_t0026_u01648018676023") 2022/03/23 06:59:14 DEBUG : only11: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f11076e08b221fc4b_d20220323_m065712_c001_v0001154_t0010_u01648018632731") 2022/03/23 06:59:14 DEBUG : only11: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451722_d20220323_m065656_c001_v0001116_t0048_u01648018616211") 2022/03/23 06:59:14 DEBUG : only12: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f10099022582201f3_d20220323_m065841_c001_v0001117_t0056_u01648018721384") 2022/03/23 06:59:14 DEBUG : only12: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f114394631d9dd8a2_d20220323_m065815_c001_v0001011_t0026_u01648018695783") 2022/03/23 06:59:14 DEBUG : only12: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451c2a_d20220323_m065757_c001_v0001116_t0026_u01648018677281") 2022/03/23 06:59:14 DEBUG : only12: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1172763d0edc1494_d20220323_m065715_c001_v0001098_t0034_u01648018635202") 2022/03/23 06:59:14 DEBUG : only12: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c45173f_d20220323_m065657_c001_v0001116_t0014_u01648018617652") 2022/03/23 06:59:14 DEBUG : only13: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f108d2b4492462913_d20220323_m065842_c001_v0001165_t0033_u01648018722834") 2022/03/23 06:59:14 DEBUG : only13: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f114394631d9dd890_d20220323_m065811_c001_v0001011_t0023_u01648018691126") 2022/03/23 06:59:14 DEBUG : only13: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451c4e_d20220323_m065758_c001_v0001116_t0055_u01648018678802") 2022/03/23 06:59:14 DEBUG : only13: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f11725f2e45211cf8_d20220323_m065711_c001_v0001042_t0005_u01648018631527") 2022/03/23 06:59:14 DEBUG : only13: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c45176d_d20220323_m065659_c001_v0001116_t0010_u01648018619289") 2022/03/23 06:59:14 DEBUG : only14: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f106c4eb4d4831724_d20220323_m065843_c001_v0001117_t0033_u01648018723320") 2022/03/23 06:59:14 DEBUG : only14: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451d58_d20220323_m065810_c001_v0001116_t0056_u01648018690747") 2022/03/23 06:59:15 DEBUG : only14: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451c76_d20220323_m065800_c001_v0001116_t0009_u01648018680336") 2022/03/23 06:59:15 DEBUG : only14: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1018967cf88200a4_d20220323_m065712_c001_v0001011_t0044_u01648018632644") 2022/03/23 06:59:15 DEBUG : only14: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c4517a3_d20220323_m065701_c001_v0001116_t0004_u01648018621207") 2022/03/23 06:59:15 DEBUG : only15: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f109753151596a077_d20220323_m065843_c001_v0001115_t0011_u01648018723870") 2022/03/23 06:59:15 DEBUG : only15: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f100eac75e552d307_d20220323_m065811_c001_v0001106_t0047_u01648018691602") 2022/03/23 06:59:15 DEBUG : only15: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451c9c_d20220323_m065802_c001_v0001116_t0025_u01648018682356") 2022/03/23 06:59:15 DEBUG : only15: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f108dc0480b03f3e4_d20220323_m065711_c001_v0001039_t0035_u01648018631525") 2022/03/23 06:59:15 DEBUG : only15: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c4517ce_d20220323_m065703_c001_v0001116_t0053_u01648018623191") 2022/03/23 06:59:15 DEBUG : only16: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f11258e040677ff18_d20220323_m065844_c001_v0001103_t0032_u01648018724521") 2022/03/23 06:59:15 DEBUG : only16: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f114394631d9dd892_d20220323_m065812_c001_v0001011_t0002_u01648018692089") 2022/03/23 06:59:15 DEBUG : only16: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451cab_d20220323_m065804_c001_v0001116_t0013_u01648018684001") 2022/03/23 06:59:15 DEBUG : only16: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f104094f5c4f2012a_d20220323_m065715_c001_v0001098_t0025_u01648018635432") 2022/03/23 06:59:15 DEBUG : only16: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c4517f2_d20220323_m065704_c001_v0001116_t0041_u01648018624514") 2022/03/23 06:59:15 DEBUG : only17: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1070ee31ab1e69bb_d20220323_m065845_c001_v0001100_t0003_u01648018725055") 2022/03/23 06:59:15 DEBUG : only17: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f109de00fbb974fc5_d20220323_m065812_c001_v0001042_t0025_u01648018692789") 2022/03/23 06:59:15 DEBUG : only17: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451cd8_d20220323_m065805_c001_v0001116_t0038_u01648018685699") 2022/03/23 06:59:15 DEBUG : only17: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1006be00c019614d_d20220323_m065713_c001_v0001116_t0001_u01648018633746") 2022/03/23 06:59:15 DEBUG : only17: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451822_d20220323_m065706_c001_v0001116_t0001_u01648018626285") 2022/03/23 06:59:15 DEBUG : only18: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f102f798665f97398_d20220323_m065845_c001_v0001109_t0041_u01648018725423") 2022/03/23 06:59:15 DEBUG : only18: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f114394631d9dd896_d20220323_m065813_c001_v0001011_t0011_u01648018693049") 2022/03/23 06:59:16 DEBUG : only18: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451cf8_d20220323_m065807_c001_v0001116_t0021_u01648018687157") 2022/03/23 06:59:16 DEBUG : only18: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f108a75f9644338da_d20220323_m065715_c001_v0001103_t0022_u01648018635486") 2022/03/23 06:59:16 DEBUG : only18: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451846_d20220323_m065707_c001_v0001116_t0031_u01648018627700") 2022/03/23 06:59:16 DEBUG : only19: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1027a24d4a3894d3_d20220323_m065847_c001_v0001019_t0004_u01648018727842") 2022/03/23 06:59:16 DEBUG : only19: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f114394631d9dd898_d20220323_m065813_c001_v0001011_t0042_u01648018693435") 2022/03/23 06:59:16 DEBUG : only19: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451d1a_d20220323_m065808_c001_v0001116_t0013_u01648018688489") 2022/03/23 06:59:16 DEBUG : only19: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f109f06d74ec16b37_d20220323_m065711_c001_v0001098_t0056_u01648018631539") 2022/03/23 06:59:16 DEBUG : only19: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451873_d20220323_m065709_c001_v0001116_t0010_u01648018629444") 2022/03/23 06:59:16 DEBUG : only2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f113ee69f012e3633_d20220323_m065848_c001_v0001098_t0031_u01648018728243") 2022/03/23 06:59:16 DEBUG : only2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f109de00fbb974fcb_d20220323_m065813_c001_v0001042_t0035_u01648018693951") 2022/03/23 06:59:16 DEBUG : only2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451b0b_d20220323_m065742_c001_v0001116_t0042_u01648018662620") 2022/03/23 06:59:16 DEBUG : only2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1107badbf43ee3c9_d20220323_m065714_c001_v0001006_t0023_u01648018634575") 2022/03/23 06:59:16 DEBUG : only2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c4515d0_d20220323_m065641_c001_v0001116_t0014_u01648018601872") 2022/03/23 06:59:16 DEBUG : only3: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f100e203e21c888b3_d20220323_m065851_c001_v0001161_t0038_u01648018731199") 2022/03/23 06:59:16 DEBUG : only3: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451d8c_d20220323_m065813_c001_v0001116_t0050_u01648018693963") 2022/03/23 06:59:16 DEBUG : only3: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451b27_d20220323_m065744_c001_v0001116_t0009_u01648018664310") 2022/03/23 06:59:16 DEBUG : only3: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f118c88b1aad3fe42_d20220323_m065714_c001_v0001115_t0051_u01648018634112") 2022/03/23 06:59:16 DEBUG : only3: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c4515f2_d20220323_m065643_c001_v0001116_t0015_u01648018603683") 2022/03/23 06:59:16 DEBUG : only4: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1129b7a9fbb13046_d20220323_m065851_c001_v0001098_t0037_u01648018731713") 2022/03/23 06:59:16 DEBUG : only4: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f100eac75e552d33f_d20220323_m065814_c001_v0001106_t0057_u01648018694095") 2022/03/23 06:59:16 DEBUG : only4: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451b43_d20220323_m065745_c001_v0001116_t0016_u01648018665746") 2022/03/23 06:59:17 DEBUG : only4: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f10610cf39427092b_d20220323_m065714_c001_v0001106_t0022_u01648018634593") 2022/03/23 06:59:17 DEBUG : only4: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451618_d20220323_m065645_c001_v0001116_t0040_u01648018605281") 2022/03/23 06:59:17 DEBUG : only5: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f11060bc7a1fb9377_d20220323_m065852_c001_v0001104_t0014_u01648018732715") 2022/03/23 06:59:17 DEBUG : only5: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f114394631d9dd89a_d20220323_m065814_c001_v0001011_t0032_u01648018694411") 2022/03/23 06:59:17 DEBUG : only5: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451b5b_d20220323_m065747_c001_v0001116_t0010_u01648018667057") 2022/03/23 06:59:17 DEBUG : only5: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1060fdae685aaa50_d20220323_m065713_c001_v0001100_t0015_u01648018633010") 2022/03/23 06:59:17 DEBUG : only5: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c45162e_d20220323_m065646_c001_v0001116_t0006_u01648018606768") 2022/03/23 06:59:17 DEBUG : only6: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110da63d8049ded4_d20220323_m065853_c001_v0001103_t0038_u01648018733378") 2022/03/23 06:59:17 DEBUG : only6: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f114394631d9dd89c_d20220323_m065814_c001_v0001011_t0036_u01648018694853") 2022/03/23 06:59:17 DEBUG : only6: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451b7f_d20220323_m065748_c001_v0001116_t0057_u01648018668541") 2022/03/23 06:59:17 DEBUG : only6: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1170db11c1a907eb_d20220323_m065710_c001_v0001100_t0041_u01648018630998") 2022/03/23 06:59:17 DEBUG : only6: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c45165e_d20220323_m065648_c001_v0001116_t0039_u01648018608367") 2022/03/23 06:59:17 DEBUG : only7: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1103b2ca9e7484c3_d20220323_m065854_c001_v0001116_t0037_u01648018734203") 2022/03/23 06:59:17 DEBUG : only7: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451d9e_d20220323_m065814_c001_v0001116_t0056_u01648018694991") 2022/03/23 06:59:17 DEBUG : only7: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451b9b_d20220323_m065750_c001_v0001116_t0048_u01648018670054") 2022/03/23 06:59:17 DEBUG : only7: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1037ec3f7d6ea334_d20220323_m065711_c001_v0001098_t0002_u01648018631977") 2022/03/23 06:59:17 DEBUG : only7: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451680_d20220323_m065650_c001_v0001116_t0011_u01648018610156") 2022/03/23 06:59:17 DEBUG : only8: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f114770295d75998b_d20220323_m065854_c001_v0001120_t0048_u01648018734985") 2022/03/23 06:59:17 DEBUG : only8: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f114394631d9dd89e_d20220323_m065815_c001_v0001011_t0035_u01648018695232") 2022/03/23 06:59:18 DEBUG : only8: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451bbe_d20220323_m065751_c001_v0001116_t0019_u01648018671709") 2022/03/23 06:59:18 DEBUG : only8: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f108a75f96443389a_d20220323_m065713_c001_v0001103_t0040_u01648018633089") 2022/03/23 06:59:18 DEBUG : only8: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c4516af_d20220323_m065651_c001_v0001116_t0028_u01648018611745") 2022/03/23 06:59:18 DEBUG : only9: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f107a688bedb248dd_d20220323_m065855_c001_v0001042_t0051_u01648018735943") 2022/03/23 06:59:18 DEBUG : only9: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f109de00fbb974fd1_d20220323_m065815_c001_v0001042_t0025_u01648018695728") 2022/03/23 06:59:18 DEBUG : only9: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c451bdc_d20220323_m065753_c001_v0001116_t0048_u01648018673325") 2022/03/23 06:59:18 DEBUG : only9: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f106df65862b792b2_d20220323_m065714_c001_v0001157_t0023_u01648018634749") 2022/03/23 06:59:18 DEBUG : only9: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c4516de_d20220323_m065653_c001_v0001116_t0039_u01648018613247") 2022/03/23 06:59:18 DEBUG : potato: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1154aa84e97fb1a8_d20220323_m065109_c001_v0001109_t0027_u01648018269173") 2022/03/23 06:59:18 DEBUG : potato: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c44f928_d20220323_m065105_c001_v0001116_t0041_u01648018265660") 2022/03/23 06:59:18 DEBUG : potato: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f118e5350a9ee60f8_d20220323_m065101_c001_v0001106_t0049_u01648018261001") 2022/03/23 06:59:18 DEBUG : potato: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88ab2_d20220323_m065056_c001_v0001044_t0038_u01648018256768") 2022/03/23 06:59:18 DEBUG : potato: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f101469e195a84b14_d20220323_m065053_c001_v0001128_t0015_u01648018253076") 2022/03/23 06:59:18 DEBUG : potato: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1119fee28c9e73ce_d20220323_m065049_c001_v0001137_t0021_u01648018249804") 2022/03/23 06:59:18 DEBUG : potato: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1029427440fec24a_d20220323_m065014_c001_v0001103_t0029_u01648018214641") 2022/03/23 06:59:18 DEBUG : potato: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb889c5_d20220323_m065012_c001_v0001044_t0021_u01648018212258") 2022/03/23 06:59:18 DEBUG : potato: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f109c862dbf306573_d20220323_m065009_c001_v0001131_t0001_u01648018209314") 2022/03/23 06:59:18 DEBUG : potato: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb889b3_d20220323_m065008_c001_v0001044_t0034_u01648018208026") 2022/03/23 06:59:18 DEBUG : potato: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f10440df22fe4c6ed_d20220323_m065002_c001_v0001091_t0028_u01648018202817") 2022/03/23 06:59:19 DEBUG : potato: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88993_d20220323_m065001_c001_v0001044_t0043_u01648018201572") 2022/03/23 06:59:19 DEBUG : potato: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f101828ec9b819f35_d20220323_m064942_c001_v0001106_t0013_u01648018182466") 2022/03/23 06:59:19 DEBUG : potato: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb8891a_d20220323_m064940_c001_v0001044_t0047_u01648018180717") 2022/03/23 06:59:19 DEBUG : potato: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1190c4a87ce137e6_d20220323_m064938_c001_v0001104_t0008_u01648018178705") 2022/03/23 06:59:19 DEBUG : potato: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb888fe_d20220323_m064936_c001_v0001044_t0027_u01648018176050") 2022/03/23 06:59:19 DEBUG : potato: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f114e4e96db306c35_d20220323_m064934_c001_v0001101_t0018_u01648018174840") 2022/03/23 06:59:19 DEBUG : potato: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb888ee_d20220323_m064932_c001_v0001044_t0005_u01648018172581") 2022/03/23 06:59:19 DEBUG : potato: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb888ea_d20220323_m064931_c001_v0001044_t0034_u01648018171844") 2022/03/23 06:59:19 DEBUG : potato: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f119c36ec0f1daa64_d20220323_m064930_c001_v0001145_t0059_u01648018170941") 2022/03/23 06:59:19 DEBUG : potato: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb888de_d20220323_m064930_c001_v0001044_t0034_u01648018170229") 2022/03/23 06:59:19 DEBUG : potato: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88855_d20220323_m064851_c001_v0001044_t0013_u01648018131328") 2022/03/23 06:59:19 DEBUG : potato: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f11126af92b349dab_d20220323_m064850_c001_v0001038_t0004_u01648018130583") 2022/03/23 06:59:19 DEBUG : potato: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88851_d20220323_m064848_c001_v0001044_t0024_u01648018128327") 2022/03/23 06:59:19 DEBUG : potato2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f106810a3b9b2c52d_d20220323_m065230_c001_v0001115_t0027_u01648018350316") 2022/03/23 06:59:19 DEBUG : potato2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88c4d_d20220323_m065229_c001_v0001044_t0040_u01648018349376") 2022/03/23 06:59:19 DEBUG : potato2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f108ff0977d313d99_d20220323_m065216_c001_v0001115_t0002_u01648018336812") 2022/03/23 06:59:19 DEBUG : potato2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c44feb6_d20220323_m065209_c001_v0001116_t0036_u01648018329045") 2022/03/23 06:59:19 DEBUG : potato2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1181c684e847cc84_d20220323_m065158_c001_v0001165_t0023_u01648018318665") 2022/03/23 06:59:19 DEBUG : potato2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88b9f_d20220323_m065149_c001_v0001044_t0056_u01648018309753") 2022/03/23 06:59:19 DEBUG : potato2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f101c41d62ab31137_d20220323_m065140_c001_v0001037_t0035_u01648018300000") 2022/03/23 06:59:19 DEBUG : potato2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c44fb28_d20220323_m065127_c001_v0001116_t0003_u01648018287757") 2022/03/23 06:59:20 DEBUG : potato2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f111d65286baa3f92_d20220323_m065026_c001_v0001130_t0011_u01648018226824") 2022/03/23 06:59:20 DEBUG : potato2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88a0f_d20220323_m065023_c001_v0001044_t0019_u01648018223339") 2022/03/23 06:59:20 DEBUG : potato2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f104c3161788d3c44_d20220323_m065022_c001_v0001157_t0033_u01648018222735") 2022/03/23 06:59:20 DEBUG : potato2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb889e6_d20220323_m065016_c001_v0001044_t0057_u01648018216887") 2022/03/23 06:59:20 DEBUG : potato2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f119d4183ace43fa0_d20220323_m065016_c001_v0001157_t0018_u01648018216283") 2022/03/23 06:59:20 DEBUG : potato2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb889d0_d20220323_m065013_c001_v0001044_t0032_u01648018213454") 2022/03/23 06:59:20 DEBUG : potato2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f106ceea707b43a87_d20220323_m065011_c001_v0001146_t0033_u01648018211613") 2022/03/23 06:59:20 DEBUG : potato2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb889bd_d20220323_m065009_c001_v0001044_t0020_u01648018209949") 2022/03/23 06:59:20 DEBUG : potato2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1127d1b77a72f068_d20220323_m065004_c001_v0001106_t0032_u01648018204322") 2022/03/23 06:59:20 DEBUG : potato2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88999_d20220323_m065002_c001_v0001044_t0043_u01648018202819") 2022/03/23 06:59:20 DEBUG : potato2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f111ca6a669b0fb06_d20220323_m064945_c001_v0001104_t0025_u01648018185830") 2022/03/23 06:59:20 DEBUG : potato2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb8891e_d20220323_m064941_c001_v0001044_t0041_u01648018181897") 2022/03/23 06:59:20 DEBUG : potato2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f100de378b5d20f10_d20220323_m064709_c001_v0001130_t0056_u01648018029852") 2022/03/23 06:59:20 DEBUG : potato2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88650_d20220323_m064708_c001_v0001044_t0033_u01648018028859") 2022/03/23 06:59:20 DEBUG : potato2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f10821c316eb87b80_d20220323_m064707_c001_v0001137_t0054_u01648018027695") 2022/03/23 06:59:20 DEBUG : potato2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb8864c_d20220323_m064705_c001_v0001044_t0012_u01648018025182") 2022/03/23 06:59:20 DEBUG : potato3: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1136dec17e7f33b8_d20220323_m065217_c001_v0001099_t0021_u01648018337622") 2022/03/23 06:59:20 DEBUG : potato3: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c44fede_d20220323_m065211_c001_v0001116_t0018_u01648018331462") 2022/03/23 06:59:20 DEBUG : potato3: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1137177438dc6ba8_d20220323_m065157_c001_v0001113_t0004_u01648018317221") 2022/03/23 06:59:20 DEBUG : potato3: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88ba7_d20220323_m065151_c001_v0001044_t0036_u01648018311607") 2022/03/23 06:59:21 DEBUG : potato3: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1100318a1f08187b_d20220323_m065141_c001_v0001098_t0049_u01648018301914") 2022/03/23 06:59:21 DEBUG : potato3: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c44fbbc_d20220323_m065134_c001_v0001116_t0047_u01648018294501") 2022/03/23 06:59:21 DEBUG : pre-dest1/1: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f10333b2b539eed6c_d20220323_m065258_c001_v0001137_t0039_u01648018378512") 2022/03/23 06:59:21 DEBUG : pre-dest1/1: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88c9a_d20220323_m065250_c001_v0001044_t0015_u01648018370212") 2022/03/23 06:59:21 DEBUG : pre-dest2/2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f11660502f45fa016_d20220323_m065258_c001_v0001102_t0048_u01648018378786") 2022/03/23 06:59:21 DEBUG : pre-dest2/2: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c45027f_d20220323_m065251_c001_v0001116_t0044_u01648018371231") 2022/03/23 06:59:21 DEBUG : sizeonly: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1010bb55dacb8935_d20220323_m064739_c001_v0001105_t0012_u01648018059201") 2022/03/23 06:59:21 DEBUG : sizeonly: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb886f3_d20220323_m064737_c001_v0001044_t0029_u01648018057917") 2022/03/23 06:59:21 DEBUG : sub dir/hello world: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f118acb0de361d0b3_d20220323_m065120_c001_v0001032_t0017_u01648018280589") 2022/03/23 06:59:21 DEBUG : sub dir/hello world: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c44fa61_d20220323_m065118_c001_v0001116_t0032_u01648018278276") 2022/03/23 06:59:21 DEBUG : sub dir/hello world: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f10856772fcd0cd09_d20220323_m065116_c001_v0001136_t0003_u01648018276680") 2022/03/23 06:59:21 DEBUG : sub dir/hello world: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88af6_d20220323_m065111_c001_v0001044_t0001_u01648018271769") 2022/03/23 06:59:21 DEBUG : sub dir/hello world: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f11060bc7a1fb6314_d20220323_m064732_c001_v0001104_t0031_u01648018052397") 2022/03/23 06:59:21 DEBUG : sub dir/hello world: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb886c7_d20220323_m064729_c001_v0001044_t0033_u01648018049511") 2022/03/23 06:59:21 DEBUG : sub dir/hello world: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f114c6988a4114b1e_d20220323_m064728_c001_v0001157_t0014_u01648018048945") 2022/03/23 06:59:21 DEBUG : sub dir/hello world: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb886bd_d20220323_m064727_c001_v0001044_t0040_u01648018047583") 2022/03/23 06:59:21 DEBUG : sub dir/hello world: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1088b22099ba7ffd_d20220323_m064726_c001_v0001011_t0032_u01648018046972") 2022/03/23 06:59:21 DEBUG : sub dir/hello world: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb886a1_d20220323_m064722_c001_v0001044_t0014_u01648018042090") 2022/03/23 06:59:21 DEBUG : sub dir/hello world: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f119f8db7595465da_d20220323_m064720_c001_v0001146_t0031_u01648018040669") 2022/03/23 06:59:22 DEBUG : sub dir/hello world: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88681_d20220323_m064719_c001_v0001044_t0019_u01648018039157") 2022/03/23 06:59:22 DEBUG : sub dir/hello world: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f11502812f13cf292_d20220323_m064718_c001_v0001099_t0053_u01648018038270") 2022/03/23 06:59:22 DEBUG : sub dir/hello world: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88679_d20220323_m064717_c001_v0001044_t0016_u01648018037494") 2022/03/23 06:59:22 DEBUG : sub dir/hello world: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f105609abc6067064_d20220323_m064716_c001_v0001101_t0037_u01648018036572") 2022/03/23 06:59:22 DEBUG : sub dir/hello world: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb8865c_d20220323_m064712_c001_v0001044_t0038_u01648018030712") 2022/03/23 06:59:22 DEBUG : sub dir/hello world: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1031afd1830fbda7_d20220323_m064656_c001_v0001144_t0054_u01648018016277") 2022/03/23 06:59:22 DEBUG : sub dir/hello world: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb8861e_d20220323_m064655_c001_v0001044_t0054_u01648018015399") 2022/03/23 06:59:22 DEBUG : sub dir/hello world: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f116b7373df3c7156_d20220323_m064653_c001_v0001036_t0013_u01648018013406") 2022/03/23 06:59:22 DEBUG : sub dir/hello world: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88616_d20220323_m064652_c001_v0001044_t0034_u01648018012696") 2022/03/23 06:59:22 DEBUG : sub dir/hello world: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1144c8bf08e02fc2_d20220323_m064652_c001_v0001100_t0031_u01648018012101") 2022/03/23 06:59:22 DEBUG : sub dir/hello world: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb885fe_d20220323_m064648_c001_v0001044_t0053_u01648018008278") 2022/03/23 06:59:22 DEBUG : sub dir/hello world: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f114acd976d674457_d20220323_m064646_c001_v0001102_t0021_u01648018006553") 2022/03/23 06:59:22 DEBUG : sub dir/hello world: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb885ee_d20220323_m064644_c001_v0001044_t0024_u01648018004371") 2022/03/23 06:59:22 DEBUG : sub/yam: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f11031ffff0220a05_d20220323_m065108_c001_v0001101_t0021_u01648018268381") 2022/03/23 06:59:22 DEBUG : sub/yam: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1119fee28c9e7440_d20220323_m065105_c001_v0001137_t0039_u01648018265648") 2022/03/23 06:59:22 DEBUG : three: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f107539cd5bbd1337_d20220323_m065045_c001_v0001038_t0048_u01648018245844") 2022/03/23 06:59:22 DEBUG : three: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88a69_d20220323_m065042_c001_v0001044_t0036_u01648018242216") 2022/03/23 06:59:22 DEBUG : three: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88a34_d20220323_m065030_c001_v0001044_t0024_u01648018230227") 2022/03/23 06:59:22 DEBUG : two: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1022f9f338458d54_d20220323_m065046_c001_v0001117_t0029_u01648018246415") 2022/03/23 06:59:22 DEBUG : two: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1119fee28c9e7385_d20220323_m065038_c001_v0001137_t0039_u01648018236245") 2022/03/23 06:59:23 DEBUG : two: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110187968cb88a31_d20220323_m065029_c001_v0001044_t0023_u01648018229906") 2022/03/23 06:59:23 DEBUG : yam: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f100de378b5d215cb_d20220323_m065110_c001_v0001130_t0031_u01648018270618") 2022/03/23 06:59:23 DEBUG : yam: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f110077c03bf16f1e_d20220323_m065107_c001_v0001097_t0020_u01648018267668") 2022/03/23 06:59:23 DEBUG : yam: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f102ae9266c3fe8a1_d20220323_m065059_c001_v0001043_t0029_u01648018259785") 2022/03/23 06:59:23 DEBUG : yam: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1119fee28c9e7403_d20220323_m065056_c001_v0001137_t0044_u01648018256749") 2022/03/23 06:59:23 DEBUG : yam: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f116cc9c6a9cfc40b_d20220323_m065051_c001_v0001098_t0009_u01648018251930") 2022/03/23 06:59:23 DEBUG : yam: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1147c3308c44f7e0_d20220323_m065049_c001_v0001116_t0045_u01648018249772") 2022/03/23 06:59:23 DEBUG : yaml: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f11861a53f142a34e_d20220323_m065102_c001_v0001097_t0048_u01648018262906") 2022/03/23 06:59:23 DEBUG : yaml: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f108f6650c61168da_d20220323_m065058_c001_v0001037_t0031_u01648018258979") 2022/03/23 06:59:23 DEBUG : yaml: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f11106f70aa56a86d_d20220323_m065053_c001_v0001099_t0042_u01648018253448") 2022/03/23 06:59:23 DEBUG : yaml: Deleting (id "4_zef121d13807dbb5b7ff80e1b_f1189783c67190109_d20220323_m065051_c001_v0001019_t0035_u01648018251526") "./sync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Finished OK in 12m43.453647118s (try 1/5)