"./sync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Starting (try 1/5) 2024/04/11 03:27:26 DEBUG : Creating backend with remote "TestB2:rclone-test-qojixih7jumoviv5kihajar2" 2024/04/11 03:27:26 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/04/11 03:27:26 DEBUG : Creating backend with remote "/tmp/rclone3411233408" === 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:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:27:27 NOTICE: sub dir: Skipped make directory as --dry-run is set 2024/04/11 03:27:27 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/11 03:27:27 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) 2024/04/11 03:27:27 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:27:27 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestCopyWithDryRun (2.09s) === RUN TestCopy run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:27:28 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/04/11 03:27:28 DEBUG : sub dir: Making directory 2024/04/11 03:27:28 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/11 03:27:28 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:27:28 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:27:29 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/11 03:27:29 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:27:30 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopy (2.18s) === RUN TestCopyMetadata run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" sync_test.go:97: Skipping as metadata not supported --- SKIP: TestCopyMetadata (0.36s) === RUN TestCopyMissingDirectory run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:27:31 DEBUG : Creating backend with remote "/non-existing" 2024/04/11 03:27:31 ERROR : Local file system at /non-existing: error reading source root directory: directory not found 2024/04/11 03:27:31 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:27:31 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestCopyMissingDirectory (0.90s) === RUN TestCopyNoTraverse run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:27:32 DEBUG : sub dir: Making directory 2024/04/11 03:27:32 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/11 03:27:32 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:27:32 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:27:33 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/11 03:27:33 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestCopyNoTraverse (2.13s) === RUN TestCopyCheckFirst run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:27:34 INFO : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Running all checks before starting transfers 2024/04/11 03:27:34 DEBUG : sub dir: Making directory 2024/04/11 03:27:34 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/11 03:27:34 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:27:34 INFO : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Checks finished, now starting transfers 2024/04/11 03:27:34 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:27:34 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/11 03:27:34 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestCopyCheckFirst (1.61s) === RUN TestSyncNoTraverse run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:27:35 ERROR : Ignoring --no-traverse with sync 2024/04/11 03:27:36 DEBUG : sub dir: Making directory 2024/04/11 03:27:36 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/11 03:27:36 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:27:36 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:27:36 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/11 03:27:36 INFO : sub dir/hello world: Copied (new) 2024/04/11 03:27:36 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestSyncNoTraverse (1.66s) === RUN TestCopyWithDepth run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:27:37 DEBUG : hello world2: Need to transfer - File not found at Destination 2024/04/11 03:27:37 DEBUG : sub dir: Making directory 2024/04/11 03:27:37 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:27:37 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:27:38 DEBUG : hello world2: sha1 = c0bf117f9c93d02c894fe8ffd6e5cecf3545c209 OK 2024/04/11 03:27:38 INFO : hello world2: Copied (new) run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestCopyWithDepth (2.11s) === RUN TestCopyWithFilesFrom run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:27:39 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/11 03:27:39 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:27:39 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:27:40 DEBUG : potato2: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/11 03:27:40 INFO : potato2: Copied (new) run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestCopyWithFilesFrom (1.76s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:27:42 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/11 03:27:42 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:27:42 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:27:42 DEBUG : potato2: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/11 03:27:42 INFO : potato2: Copied (new) run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestCopyWithFilesFromAndNoTraverse (1.98s) === RUN TestCopyEmptyDirectories run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:27:43 DEBUG : sub dir2: Making directory with metadata 2024/04/11 03:27:43 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2024/04/11 03:27:43 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/04/11 03:27:43 DEBUG : sub dir: Making directory 2024/04/11 03:27:43 DEBUG : sub dir2: Making directory 2024/04/11 03:27:43 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/11 03:27:43 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:27:43 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:27:44 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/11 03:27:44 INFO : sub dir/hello world: Copied (new) 2024/04/11 03:27:44 DEBUG : sub dir2: Making directory 2024/04/11 03:27:44 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: copied 1 directories run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" fstest.go:244: Filtering empty directory "sub dir2" 2024/04/11 03:27:44 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopyEmptyDirectories (1.65s) === RUN TestMoveEmptyDirectories run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:27:45 DEBUG : sub dir2: Making directory with metadata 2024/04/11 03:27:45 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2024/04/11 03:27:45 DEBUG : sub dir: Making directory 2024/04/11 03:27:45 DEBUG : sub dir2: Making directory 2024/04/11 03:27:45 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/11 03:27:45 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:27:45 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:27:45 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/11 03:27:45 INFO : sub dir/hello world: Copied (new) 2024/04/11 03:27:45 INFO : sub dir/hello world: Deleted 2024/04/11 03:27:45 DEBUG : sub dir: Making directory 2024/04/11 03:27:45 DEBUG : sub dir2: Making directory 2024/04/11 03:27:45 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: copied 2 directories run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" fstest.go:244: Filtering empty directory "sub dir2" 2024/04/11 03:27:45 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata 2024/04/11 03:27:45 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestMoveEmptyDirectories (1.69s) === RUN TestSyncNoUpdateDirModtime run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" sync_test.go:351: Skipping test as backend does not support DirSetModTime --- SKIP: TestSyncNoUpdateDirModtime (0.36s) === RUN TestSyncEmptyDirectories run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:27:47 DEBUG : sub dir2: Making directory with metadata 2024/04/11 03:27:47 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2024/04/11 03:27:47 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/04/11 03:27:47 DEBUG : sub dir: Making directory 2024/04/11 03:27:47 DEBUG : sub dir2: Making directory 2024/04/11 03:27:47 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/11 03:27:47 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:27:47 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:27:47 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/11 03:27:47 INFO : sub dir/hello world: Copied (new) 2024/04/11 03:27:47 DEBUG : sub dir2: Making directory 2024/04/11 03:27:47 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: copied 1 directories 2024/04/11 03:27:47 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" fstest.go:244: Filtering empty directory "sub dir2" 2024/04/11 03:27:47 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestSyncEmptyDirectories (1.60s) === RUN TestSyncSetDelayedModTimes run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" sync_test.go:427: Backend doesn't have DirModTimeUpdatesOnWrite set --- SKIP: TestSyncSetDelayedModTimes (0.37s) === RUN TestServerSideCopy run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:27:49 DEBUG : Creating backend with remote "TestB2:rclone-test-sohabih6wudoveq3gijotiy3" sync_test.go:487: Server side copy (if possible) B2 bucket rclone-test-qojixih7jumoviv5kihajar2 -> B2 bucket rclone-test-sohabih6wudoveq3gijotiy3 2024/04/11 03:27:50 DEBUG : sub dir: Making directory 2024/04/11 03:27:51 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/11 03:27:51 DEBUG : B2 bucket rclone-test-sohabih6wudoveq3gijotiy3: Waiting for checks to finish 2024/04/11 03:27:51 DEBUG : B2 bucket rclone-test-sohabih6wudoveq3gijotiy3: Waiting for transfers to finish 2024/04/11 03:27:51 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/11 03:27:51 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:27:51 DEBUG : B2 bucket rclone-test-sohabih6wudoveq3gijotiy3: Purge remote 2024/04/11 03:27:51 INFO : B2 bucket rclone-test-sohabih6wudoveq3gijotiy3: cleaning bucket "rclone-test-sohabih6wudoveq3gijotiy3" of all files 2024/04/11 03:27:52 DEBUG : sub dir/hello world: Deleting (id "4_z4f928d93302dcbbb8fe80e1b_f11235f4a4f3c3770_d20240411_m032751_c001_v0001103_t0046_u01712806071379") --- PASS: TestServerSideCopy (4.61s) === RUN TestCopyAfterDelete run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:27:54 ERROR : : error listing: directory not found 2024/04/11 03:27:54 DEBUG : Local file system at /tmp/rclone3411233408: Making directory 2024/04/11 03:27:54 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:27:54 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestCopyAfterDelete (1.90s) === RUN TestCopyRedownload run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:27:56 DEBUG : sub dir: Making directory 2024/04/11 03:27:56 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/11 03:27:56 DEBUG : Local file system at /tmp/rclone3411233408: Waiting for checks to finish 2024/04/11 03:27:56 DEBUG : Local file system at /tmp/rclone3411233408: Waiting for transfers to finish 2024/04/11 03:27:57 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/11 03:27:57 DEBUG : sub dir/hello world.pisevoc0.partial: renamed to: sub dir/hello world 2024/04/11 03:27:57 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestCopyRedownload (2.40s) === RUN TestSyncBasedOnCheckSum run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:27:58 DEBUG : check sum: Need to transfer - File not found at Destination 2024/04/11 03:27:58 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:27:58 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:27:58 DEBUG : check sum: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/04/11 03:27:58 INFO : check sum: Copied (new) 2024/04/11 03:27:58 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:27:58 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:27:58 DEBUG : check sum: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/04/11 03:27:58 DEBUG : check sum: Size and sha1 of src and dst objects identical 2024/04/11 03:27:58 DEBUG : check sum: Unchanged skipping 2024/04/11 03:27:58 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:27:58 DEBUG : Waiting for deletions to finish 2024/04/11 03:27:58 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestSyncBasedOnCheckSum (2.27s) === RUN TestSyncSizeOnly run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:28:00 DEBUG : sizeonly: Need to transfer - File not found at Destination 2024/04/11 03:28:00 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:28:00 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:28:00 DEBUG : sizeonly: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2024/04/11 03:28:00 INFO : sizeonly: Copied (new) 2024/04/11 03:28:00 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:28:01 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:28:01 DEBUG : sizeonly: Sizes identical 2024/04/11 03:28:01 DEBUG : sizeonly: Unchanged skipping 2024/04/11 03:28:01 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:28:01 DEBUG : Waiting for deletions to finish 2024/04/11 03:28:01 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestSyncSizeOnly (2.22s) === RUN TestSyncIgnoreSize run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:28:02 DEBUG : ignore-size: Need to transfer - File not found at Destination 2024/04/11 03:28:02 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:28:02 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:28:03 DEBUG : ignore-size: sha1 = 4a756ca07e9487f482465a99e8286abc86ba4dc7 OK 2024/04/11 03:28:03 INFO : ignore-size: Copied (new) 2024/04/11 03:28:03 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:28:03 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:28:03 DEBUG : ignore-size: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:28:03 DEBUG : ignore-size: Unchanged skipping 2024/04/11 03:28:03 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:28:03 DEBUG : Waiting for deletions to finish 2024/04/11 03:28:03 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestSyncIgnoreSize (2.33s) === RUN TestSyncIgnoreTimes run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:28:05 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:28:05 DEBUG : existing: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:28:05 DEBUG : existing: Unchanged skipping 2024/04/11 03:28:05 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:28:05 DEBUG : Waiting for deletions to finish 2024/04/11 03:28:05 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:28:05 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2024/04/11 03:28:05 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:28:05 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:28:06 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2024/04/11 03:28:06 INFO : existing: Copied (replaced existing) 2024/04/11 03:28:06 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestSyncIgnoreTimes (2.80s) === RUN TestSyncIgnoreExisting run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:28:07 DEBUG : existing: Need to transfer - File not found at Destination 2024/04/11 03:28:07 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:28:07 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:28:08 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2024/04/11 03:28:08 INFO : existing: Copied (new) 2024/04/11 03:28:08 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:28:08 DEBUG : existing: Destination exists, skipping 2024/04/11 03:28:08 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:28:08 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:28:08 DEBUG : Waiting for deletions to finish 2024/04/11 03:28:08 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestSyncIgnoreExisting (2.30s) === RUN TestSyncIgnoreErrors run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:28:10 DEBUG : d: Making directory fstest.go:244: Filtering empty directory "d" 2024/04/11 03:28:10 DEBUG : a: Making directory 2024/04/11 03:28:10 DEBUG : a/potato2: Need to transfer - File not found at Destination 2024/04/11 03:28:11 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/11 03:28:11 DEBUG : c/non empty space: Unchanged skipping 2024/04/11 03:28:11 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/11 03:28:11 INFO : a/potato2: Copied (new) 2024/04/11 03:28:11 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:28:11 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:28:11 DEBUG : Waiting for deletions to finish 2024/04/11 03:28:11 INFO : b/potato: Deleted run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestSyncIgnoreErrors (2.89s) === RUN TestSyncAfterChangingModtimeOnly run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:28:13 DEBUG : empty space: Modification times differ by -95456h54m52.624456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499 +0000 UTC 2024/04/11 03:28:13 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:28:13 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/04/11 03:28:13 NOTICE: empty space: Skipped update modification time as --dry-run is set (size 1) 2024/04/11 03:28:13 DEBUG : empty space: Unchanged skipping 2024/04/11 03:28:13 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:28:13 DEBUG : Waiting for deletions to finish 2024/04/11 03:28:13 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:28:13 DEBUG : empty space: Modification times differ by -95456h54m52.624456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499 +0000 UTC 2024/04/11 03:28:13 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:28:13 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/04/11 03:28:15 INFO : empty space: Updated modification time in destination 2024/04/11 03:28:15 DEBUG : empty space: Unchanged skipping 2024/04/11 03:28:15 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:28:15 DEBUG : Waiting for deletions to finish 2024/04/11 03:28:15 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestSyncAfterChangingModtimeOnly (3.89s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:28:17 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:28:17 DEBUG : empty space: Modification times differ by -95456h54m52.624456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499 +0000 UTC 2024/04/11 03:28:17 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/04/11 03:28:17 DEBUG : empty space: Unchanged skipping 2024/04/11 03:28:17 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:28:17 DEBUG : Waiting for deletions to finish 2024/04/11 03:28:17 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (1.83s) === RUN TestSyncDoesntUpdateModtime run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:28:19 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:28:19 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 2024/04/11 03:28:19 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 (Local file system at /tmp/rclone3411233408) 2024/04/11 03:28:19 DEBUG : foo: sha1 = 62cdb7020ff920e5aa642c3d4066950dd1f01f4d (B2 bucket rclone-test-qojixih7jumoviv5kihajar2) 2024/04/11 03:28:19 DEBUG : foo: sha1 differ 2024/04/11 03:28:19 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:28:19 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 OK 2024/04/11 03:28:19 INFO : foo: Copied (replaced existing) 2024/04/11 03:28:19 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestSyncDoesntUpdateModtime (1.85s) === RUN TestSyncAfterAddingAFile run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:28:21 DEBUG : potato: Need to transfer - File not found at Destination 2024/04/11 03:28:21 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/11 03:28:21 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:28:21 DEBUG : empty space: Unchanged skipping 2024/04/11 03:28:21 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:28:21 DEBUG : potato: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/11 03:28:21 INFO : potato: Copied (new) 2024/04/11 03:28:21 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestSyncAfterAddingAFile (2.39s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:28:23 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:28:23 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2024/04/11 03:28:23 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:28:23 DEBUG : potato: sha1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f OK 2024/04/11 03:28:23 INFO : potato: Copied (replaced existing) 2024/04/11 03:28:23 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestSyncAfterChangingFilesSizeOnly (2.01s) === RUN TestSyncAfterChangingContentsOnly run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:28:25 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 2024/04/11 03:28:25 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:28:25 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f (Local file system at /tmp/rclone3411233408) 2024/04/11 03:28:25 DEBUG : potato: sha1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f (B2 bucket rclone-test-qojixih7jumoviv5kihajar2) 2024/04/11 03:28:25 DEBUG : potato: sha1 differ 2024/04/11 03:28:25 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:28:25 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f OK 2024/04/11 03:28:25 INFO : potato: Copied (replaced existing) 2024/04/11 03:28:25 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestSyncAfterChangingContentsOnly (2.17s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:28:27 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/11 03:28:27 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2024/04/11 03:28:27 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:28:27 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/11 03:28:27 DEBUG : empty space: Unchanged skipping 2024/04/11 03:28:27 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:28:27 DEBUG : Waiting for deletions to finish 2024/04/11 03:28:27 NOTICE: potato: Skipped delete as --dry-run is set (size 21) run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (2.20s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:28:30 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/11 03:28:30 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/11 03:28:30 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:28:30 DEBUG : empty space: Unchanged skipping 2024/04/11 03:28:30 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:28:30 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/11 03:28:30 INFO : potato2: Copied (new) 2024/04/11 03:28:30 DEBUG : Waiting for deletions to finish 2024/04/11 03:28:30 INFO : potato: Deleted run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (2.98s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:28:33 DEBUG : d: Making directory 2024/04/11 03:28:33 DEBUG : d/e: Making directory fstest.go:244: Filtering empty directory "d" fstest.go:244: Filtering empty directory "d/e" 2024/04/11 03:28:33 DEBUG : a: Making directory 2024/04/11 03:28:33 DEBUG : a/potato2: Need to transfer - File not found at Destination 2024/04/11 03:28:33 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/11 03:28:33 DEBUG : c/non empty space: Unchanged skipping 2024/04/11 03:28:33 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/11 03:28:33 INFO : a/potato2: Copied (new) 2024/04/11 03:28:33 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:28:33 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:28:33 DEBUG : Waiting for deletions to finish 2024/04/11 03:28:33 INFO : b/potato: Deleted run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (3.12s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:28:35 DEBUG : d: Making directory fstest.go:244: Filtering empty directory "d" 2024/04/11 03:28:36 DEBUG : a: Making directory 2024/04/11 03:28:36 DEBUG : a/potato2: Need to transfer - File not found at Destination 2024/04/11 03:28:36 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/11 03:28:36 DEBUG : c/non empty space: Unchanged skipping 2024/04/11 03:28:36 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:28:36 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:28:36 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/11 03:28:36 INFO : a/potato2: Copied (new) 2024/04/11 03:28:36 ERROR : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: not deleting files as there were IO errors 2024/04/11 03:28:36 ERROR : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: not deleting directories as there were IO errors run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" fstest.go:244: Filtering empty directory "d" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (2.87s) === RUN TestSyncDeleteAfter --- PASS: TestSyncDeleteAfter (0.00s) === RUN TestSyncDeleteDuring run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:28:38 DEBUG : Waiting for deletions to finish 2024/04/11 03:28:39 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/11 03:28:39 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:28:39 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/11 03:28:39 DEBUG : empty space: Unchanged skipping 2024/04/11 03:28:39 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:28:39 INFO : potato: Deleted 2024/04/11 03:28:39 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/11 03:28:39 INFO : potato2: Copied (new) run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestSyncDeleteDuring (2.51s) === RUN TestSyncDeleteBefore run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:28:41 DEBUG : Waiting for deletions to finish 2024/04/11 03:28:41 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:28:41 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:28:41 INFO : potato: Deleted 2024/04/11 03:28:42 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/11 03:28:42 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/11 03:28:42 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:28:42 DEBUG : empty space: Unchanged skipping 2024/04/11 03:28:42 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:28:42 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/11 03:28:42 INFO : potato2: Copied (new) run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestSyncDeleteBefore (2.99s) === RUN TestCopyDeleteBefore run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:28:44 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/11 03:28:44 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:28:44 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:28:44 DEBUG : potato2: sha1 = 810274f0df19dab60a894a562b7a8ff04c072623 OK 2024/04/11 03:28:44 INFO : potato2: Copied (new) run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestCopyDeleteBefore (2.30s) === RUN TestSyncWithExclude run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:28:46 DEBUG : enormous: Excluded (Size Filter) 2024/04/11 03:28:46 DEBUG : enormous: Excluded 2024/04/11 03:28:46 DEBUG : potato2: Excluded (Size Filter) 2024/04/11 03:28:46 DEBUG : potato2: Excluded 2024/04/11 03:28:46 DEBUG : potato2: Excluded (Size Filter) 2024/04/11 03:28:46 DEBUG : potato2: Excluded 2024/04/11 03:28:46 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/11 03:28:46 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:28:46 DEBUG : empty space: Unchanged skipping 2024/04/11 03:28:46 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:28:46 DEBUG : Waiting for deletions to finish 2024/04/11 03:28:46 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:28:47 DEBUG : enormous: Excluded (Size Filter) 2024/04/11 03:28:47 DEBUG : enormous: Excluded 2024/04/11 03:28:47 DEBUG : potato2: Excluded (Size Filter) 2024/04/11 03:28:47 DEBUG : potato2: Excluded 2024/04/11 03:28:47 DEBUG : potato2: Excluded (Size Filter) 2024/04/11 03:28:47 DEBUG : potato2: Excluded 2024/04/11 03:28:47 DEBUG : empty space: Size and modification time the same (differ by 456.789µs, within tolerance 1ms) 2024/04/11 03:28:47 DEBUG : empty space: Unchanged skipping 2024/04/11 03:28:47 DEBUG : Local file system at /tmp/rclone3411233408: Waiting for checks to finish 2024/04/11 03:28:47 DEBUG : Local file system at /tmp/rclone3411233408: Waiting for transfers to finish 2024/04/11 03:28:47 DEBUG : Waiting for deletions to finish 2024/04/11 03:28:47 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestSyncWithExclude (2.71s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:28:49 DEBUG : enormous: Excluded (Size Filter) 2024/04/11 03:28:49 DEBUG : enormous: Excluded 2024/04/11 03:28:49 DEBUG : potato2: Excluded (Size Filter) 2024/04/11 03:28:49 DEBUG : potato2: Excluded 2024/04/11 03:28:49 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/11 03:28:49 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:28:49 DEBUG : empty space: Unchanged skipping 2024/04/11 03:28:49 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:28:49 DEBUG : Waiting for deletions to finish 2024/04/11 03:28:50 INFO : enormous: Deleted 2024/04/11 03:28:50 INFO : potato2: Deleted 2024/04/11 03:28:50 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:28:50 DEBUG : empty space: Size and modification time the same (differ by 456.789µs, within tolerance 1ms) 2024/04/11 03:28:50 DEBUG : empty space: Unchanged skipping 2024/04/11 03:28:50 DEBUG : Local file system at /tmp/rclone3411233408: Waiting for checks to finish 2024/04/11 03:28:50 DEBUG : Local file system at /tmp/rclone3411233408: Waiting for transfers to finish 2024/04/11 03:28:50 DEBUG : Waiting for deletions to finish 2024/04/11 03:28:50 INFO : potato2: Deleted 2024/04/11 03:28:50 INFO : enormous: Deleted 2024/04/11 03:28:50 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestSyncWithExcludeAndDeleteExcluded (3.27s) === RUN TestSyncWithUpdateOlder run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:28:53 DEBUG : five: Need to transfer - File not found at Destination 2024/04/11 03:28:53 DEBUG : three: Sizes identical 2024/04/11 03:28:53 DEBUG : four: Sizes differ (src 4 vs dst 8) 2024/04/11 03:28:53 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2024/04/11 03:28:53 DEBUG : one: Destination is newer than source, skipping 2024/04/11 03:28:53 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:28:53 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b (Local file system at /tmp/rclone3411233408) 2024/04/11 03:28:53 DEBUG : two: sha1 = b10e0da85e90399abfec36c7376b20aa4596461b (B2 bucket rclone-test-qojixih7jumoviv5kihajar2) 2024/04/11 03:28:53 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2024/04/11 03:28:53 DEBUG : two: sha1 differ 2024/04/11 03:28:53 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:28:53 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2024/04/11 03:28:53 INFO : five: Copied (new) 2024/04/11 03:28:54 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2024/04/11 03:28:54 INFO : two: Copied (replaced existing) 2024/04/11 03:28:54 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2024/04/11 03:28:54 INFO : four: Copied (replaced existing) 2024/04/11 03:28:54 DEBUG : Waiting for deletions to finish 2024/04/11 03:28:54 DEBUG : one: Destination is newer than source, skipping 2024/04/11 03:28:54 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:28:54 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2024/04/11 03:28:54 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2024/04/11 03:28:54 DEBUG : four: Size and sha1 of src and dst objects identical 2024/04/11 03:28:54 DEBUG : two: Size and sha1 of src and dst objects identical 2024/04/11 03:28:54 DEBUG : four: Destination mod time is within 1s of source and files identical, skipping 2024/04/11 03:28:54 DEBUG : two: Destination mod time is within 1s of source and files identical, skipping 2024/04/11 03:28:54 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb (Local file system at /tmp/rclone3411233408) 2024/04/11 03:28:54 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2024/04/11 03:28:54 DEBUG : five: Size and sha1 of src and dst objects identical 2024/04/11 03:28:54 DEBUG : five: Destination mod time is within 1s of source and files identical, skipping 2024/04/11 03:28:54 DEBUG : three: sha1 = 03731cad13f4cf7b59703c77529381cdec1632e5 (B2 bucket rclone-test-qojixih7jumoviv5kihajar2) 2024/04/11 03:28:54 DEBUG : three: sha1 differ 2024/04/11 03:28:54 DEBUG : three: Destination mod time is within 1s of source but files differ, transferring 2024/04/11 03:28:54 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:28:54 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2024/04/11 03:28:54 INFO : three: Copied (replaced existing) 2024/04/11 03:28:54 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithUpdateOlder (4.51s) === RUN TestSyncWithMaxDuration === RUN TestSyncWithMaxDuration/Hard sync_test.go:1261: Skipping test on non local remote === RUN TestSyncWithMaxDuration/Soft sync_test.go:1261: Skipping test on non local remote --- PASS: TestSyncWithMaxDuration (0.00s) --- SKIP: TestSyncWithMaxDuration/Hard (0.00s) --- SKIP: TestSyncWithMaxDuration/Soft (0.00s) === RUN TestSyncWithTrackRenames run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" sync_test.go:1327: Can track renames: true 2024/04/11 03:28:56 INFO : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Making map for --track-renames 2024/04/11 03:28:56 INFO : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Finished making map for --track-renames 2024/04/11 03:28:56 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:28:56 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for renames to finish 2024/04/11 03:28:56 DEBUG : potato: Need to transfer - No matching file found at Destination 2024/04/11 03:28:56 DEBUG : yam: Need to transfer - No matching file found at Destination 2024/04/11 03:28:56 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:28:57 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2024/04/11 03:28:57 INFO : potato: Copied (new) 2024/04/11 03:28:57 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/04/11 03:28:57 INFO : yam: Copied (new) 2024/04/11 03:28:57 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:28:57 INFO : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Making map for --track-renames 2024/04/11 03:28:57 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:28:57 INFO : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Finished making map for --track-renames 2024/04/11 03:28:57 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:28:57 DEBUG : potato: Unchanged skipping 2024/04/11 03:28:57 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for renames to finish 2024/04/11 03:28:58 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/04/11 03:28:58 INFO : yam: Copied (server-side copy) to: yaml 2024/04/11 03:28:58 INFO : yam: Deleted 2024/04/11 03:28:58 INFO : yaml: Renamed from "yam" 2024/04/11 03:28:58 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:28:58 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestSyncWithTrackRenames (3.99s) === RUN TestParseRenamesStrategyModtime --- PASS: TestParseRenamesStrategyModtime (0.00s) === RUN TestRenamesStrategyModtime --- PASS: TestRenamesStrategyModtime (0.00s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" sync_test.go:1399: Can track renames: true 2024/04/11 03:29:00 INFO : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Making map for --track-renames 2024/04/11 03:29:00 INFO : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Finished making map for --track-renames 2024/04/11 03:29:00 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:29:00 DEBUG : potato: Need to transfer - No matching file found at Destination 2024/04/11 03:29:00 DEBUG : yam: Need to transfer - No matching file found at Destination 2024/04/11 03:29:00 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for renames to finish 2024/04/11 03:29:00 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:29:00 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/04/11 03:29:00 INFO : yam: Copied (new) 2024/04/11 03:29:01 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2024/04/11 03:29:01 INFO : potato: Copied (new) 2024/04/11 03:29:01 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:29:01 INFO : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Making map for --track-renames 2024/04/11 03:29:01 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:29:01 INFO : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Finished making map for --track-renames 2024/04/11 03:29:01 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:29:01 DEBUG : potato: Unchanged skipping 2024/04/11 03:29:01 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for renames to finish 2024/04/11 03:29:03 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/04/11 03:29:03 INFO : yam: Copied (server-side copy) to: yaml 2024/04/11 03:29:03 INFO : yam: Deleted 2024/04/11 03:29:03 INFO : yaml: Renamed from "yam" 2024/04/11 03:29:03 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:29:03 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestSyncWithTrackRenamesStrategyModtime (5.29s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" sync_test.go:1438: Can track renames: true 2024/04/11 03:29:05 DEBUG : sub: Making directory 2024/04/11 03:29:05 INFO : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Making map for --track-renames 2024/04/11 03:29:05 INFO : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Finished making map for --track-renames 2024/04/11 03:29:05 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:29:05 DEBUG : potato: Need to transfer - No matching file found at Destination 2024/04/11 03:29:05 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2024/04/11 03:29:05 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for renames to finish 2024/04/11 03:29:05 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:29:05 DEBUG : sub/yam: Clearing upload URL because of error: Post "https://pod-000-1181-07.backblaze.com/b2api/v1/b2_upload_file/af022dd3302dcbbb8fe80e1b/c001_v0001181_t0041": EOF 2024/04/11 03:29:05 DEBUG : pacer: low level retry 1/1 (error Post "https://pod-000-1181-07.backblaze.com/b2api/v1/b2_upload_file/af022dd3302dcbbb8fe80e1b/c001_v0001181_t0041": EOF) 2024/04/11 03:29:05 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2024/04/11 03:29:05 DEBUG : sub/yam: Received error: Post "https://pod-000-1181-07.backblaze.com/b2api/v1/b2_upload_file/af022dd3302dcbbb8fe80e1b/c001_v0001181_t0041": EOF - low level retry 0/10 2024/04/11 03:29:06 DEBUG : pacer: Reducing sleep to 10ms 2024/04/11 03:29:06 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/04/11 03:29:06 INFO : sub/yam: Copied (new) 2024/04/11 03:29:06 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2024/04/11 03:29:06 INFO : potato: Copied (new) 2024/04/11 03:29:06 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:29:07 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:29:07 DEBUG : potato: Unchanged skipping 2024/04/11 03:29:07 INFO : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Making map for --track-renames 2024/04/11 03:29:07 INFO : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Finished making map for --track-renames 2024/04/11 03:29:07 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:29:07 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for renames to finish 2024/04/11 03:29:08 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/04/11 03:29:08 INFO : sub/yam: Copied (server-side copy) to: yam 2024/04/11 03:29:08 INFO : sub/yam: Deleted 2024/04/11 03:29:08 INFO : yam: Renamed from "sub/yam" 2024/04/11 03:29:08 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:29:08 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestSyncWithTrackRenamesStrategyLeaf (4.34s) === RUN TestServerSideMoveLocal run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:29:10 DEBUG : Creating backend with remote "/tmp/rclone3411233408/dir1" 2024/04/11 03:29:10 DEBUG : Creating backend with remote "/tmp/rclone3411233408/dir2" 2024/04/11 03:29:10 DEBUG : Local file system at /tmp/rclone3411233408/dir2: Using server-side directory move 2024/04/11 03:29:10 INFO : Local file system at /tmp/rclone3411233408/dir2: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2024/04/11 03:29:10 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/11 03:29:10 DEBUG : Local file system at /tmp/rclone3411233408/dir2: Waiting for checks to finish 2024/04/11 03:29:10 DEBUG : Local file system at /tmp/rclone3411233408/dir2: Waiting for transfers to finish 2024/04/11 03:29:10 INFO : file1.txt: Moved (server-side) --- PASS: TestServerSideMoveLocal (0.37s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:29:10 DEBUG : nested: Making directory 2024/04/11 03:29:10 DEBUG : sub dir: Making directory 2024/04/11 03:29:10 DEBUG : nested/sub dir: Making directory 2024/04/11 03:29:10 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/11 03:29:10 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2024/04/11 03:29:10 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:29:10 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:29:11 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2024/04/11 03:29:11 INFO : nested/sub dir/file: Copied (new) 2024/04/11 03:29:11 INFO : nested/sub dir/file: Deleted 2024/04/11 03:29:11 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/11 03:29:11 INFO : sub dir/hello world: Copied (new) 2024/04/11 03:29:11 INFO : sub dir/hello world: Deleted 2024/04/11 03:29:11 INFO : sub dir: Removing directory 2024/04/11 03:29:11 INFO : nested/sub dir: Removing directory 2024/04/11 03:29:11 INFO : nested: Removing directory 2024/04/11 03:29:11 DEBUG : Local file system at /tmp/rclone3411233408: deleted 3 directories run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestMoveWithDeleteEmptySrcDirs (2.10s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:29:12 DEBUG : nested: Making directory 2024/04/11 03:29:12 DEBUG : sub dir: Making directory 2024/04/11 03:29:12 DEBUG : nested/sub dir: Making directory 2024/04/11 03:29:12 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/11 03:29:12 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2024/04/11 03:29:12 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:29:12 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:29:13 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/11 03:29:13 INFO : sub dir/hello world: Copied (new) 2024/04/11 03:29:13 INFO : sub dir/hello world: Deleted 2024/04/11 03:29:13 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2024/04/11 03:29:13 INFO : nested/sub dir/file: Copied (new) 2024/04/11 03:29:13 INFO : nested/sub dir/file: Deleted run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestMoveWithoutDeleteEmptySrcDirs (2.05s) === RUN TestMoveWithIgnoreExisting run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:29:14 DEBUG : existing: Need to transfer - File not found at Destination 2024/04/11 03:29:14 DEBUG : existing-b: Need to transfer - File not found at Destination 2024/04/11 03:29:14 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:29:14 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:29:15 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2024/04/11 03:29:15 INFO : existing: Copied (new) 2024/04/11 03:29:15 INFO : existing: Deleted 2024/04/11 03:29:15 DEBUG : existing-b: sha1 = 321f6b7e8bf7f29aab89c5e41a555b1b0baa41a9 OK 2024/04/11 03:29:15 INFO : existing-b: Copied (new) 2024/04/11 03:29:15 INFO : existing-b: Deleted 2024/04/11 03:29:15 DEBUG : existing: Destination exists, skipping 2024/04/11 03:29:15 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2024/04/11 03:29:15 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:29:15 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:29:15 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestMoveWithIgnoreExisting (2.58s) === RUN TestServerSideMove run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:29:17 DEBUG : Creating backend with remote "TestB2:rclone-test-qojulaf3sepojax8xedutal1" sync_test.go:1494: Server side move (if possible) B2 bucket rclone-test-qojixih7jumoviv5kihajar2 -> B2 bucket rclone-test-qojulaf3sepojax8xedutal1 2024/04/11 03:29:22 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/11 03:29:22 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ms) 2024/04/11 03:29:22 DEBUG : empty space: Unchanged skipping 2024/04/11 03:29:22 DEBUG : B2 bucket rclone-test-qojulaf3sepojax8xedutal1: Waiting for checks to finish 2024/04/11 03:29:22 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2024/04/11 03:29:22 INFO : empty space: Deleted 2024/04/11 03:29:22 DEBUG : B2 bucket rclone-test-qojulaf3sepojax8xedutal1: Waiting for transfers to finish 2024/04/11 03:29:22 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/11 03:29:22 INFO : potato2: Copied (server-side copy) 2024/04/11 03:29:22 INFO : potato2: Deleted 2024/04/11 03:29:22 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2024/04/11 03:29:22 INFO : potato3: Copied (server-side copy) 2024/04/11 03:29:22 INFO : potato3: Deleted 2024/04/11 03:29:23 DEBUG : Creating backend with remote "TestB2:rclone-test-gimizes9zorakuy7zepakog5" 2024/04/11 03:29:24 DEBUG : empty space: Need to transfer - File not found at Destination 2024/04/11 03:29:24 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/11 03:29:24 DEBUG : potato3: Need to transfer - File not found at Destination 2024/04/11 03:29:24 DEBUG : B2 bucket rclone-test-gimizes9zorakuy7zepakog5: Waiting for checks to finish 2024/04/11 03:29:24 DEBUG : B2 bucket rclone-test-gimizes9zorakuy7zepakog5: Waiting for transfers to finish 2024/04/11 03:29:24 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/04/11 03:29:24 INFO : empty space: Copied (server-side copy) 2024/04/11 03:29:25 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2024/04/11 03:29:25 INFO : potato3: Copied (server-side copy) 2024/04/11 03:29:25 INFO : empty space: Deleted 2024/04/11 03:29:25 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/11 03:29:25 INFO : potato2: Copied (server-side copy) 2024/04/11 03:29:25 INFO : potato3: Deleted 2024/04/11 03:29:25 INFO : potato2: Deleted 2024/04/11 03:29:25 DEBUG : B2 bucket rclone-test-gimizes9zorakuy7zepakog5: Purge remote 2024/04/11 03:29:25 INFO : B2 bucket rclone-test-gimizes9zorakuy7zepakog5: cleaning bucket "rclone-test-gimizes9zorakuy7zepakog5" of all files 2024/04/11 03:29:25 DEBUG : empty space: Deleting (id "4_z2f42fd73303dcbbb8fe80e1b_f111803b32494bfed_d20240411_m032924_c001_v0001180_t0028_u01712806164825") 2024/04/11 03:29:25 DEBUG : potato2: Deleting (id "4_z2f42fd73303dcbbb8fe80e1b_f108298c7b5fe474c_d20240411_m032924_c001_v0001157_t0017_u01712806164874") 2024/04/11 03:29:25 DEBUG : potato3: Deleting (id "4_z2f42fd73303dcbbb8fe80e1b_f103b14fd33758a5b_d20240411_m032924_c001_v0001179_t0032_u01712806164883") 2024/04/11 03:29:26 DEBUG : B2 bucket rclone-test-qojulaf3sepojax8xedutal1: Purge remote 2024/04/11 03:29:26 INFO : B2 bucket rclone-test-qojulaf3sepojax8xedutal1: cleaning bucket "rclone-test-qojulaf3sepojax8xedutal1" of all files 2024/04/11 03:29:26 DEBUG : empty space: Deleting (id "4_z4ff2ed43303dcbbb8fe80e1b_f4007893bcb4b069b_d20240411_m032925_c001_v7007000_t0000_u01712806165031") 2024/04/11 03:29:26 DEBUG : empty space: Deleting (id "4_z4ff2ed43303dcbbb8fe80e1b_f11211b010ac2c073_d20240411_m032920_c001_v0001131_t0050_u01712806160743") 2024/04/11 03:29:26 DEBUG : potato2: Deleting (id "4_z4ff2ed43303dcbbb8fe80e1b_f40281caa55f4981c_d20240411_m032925_c001_v7007000_t0000_u01712806165218") 2024/04/11 03:29:26 DEBUG : potato2: Deleting (id "4_z4ff2ed43303dcbbb8fe80e1b_f103b0ffbfcbb5c62_d20240411_m032922_c001_v0001180_t0046_u01712806162306") 2024/04/11 03:29:26 DEBUG : potato3: Deleting (id "4_z4ff2ed43303dcbbb8fe80e1b_f40739ad12d2134e2_d20240411_m032925_c001_v7007000_t0000_u01712806165087") 2024/04/11 03:29:26 DEBUG : potato3: Deleting (id "4_z4ff2ed43303dcbbb8fe80e1b_f11980228ba97b65d_d20240411_m032922_c001_v0001181_t0045_u01712806162486") 2024/04/11 03:29:26 DEBUG : potato3: Deleting (id "4_z4ff2ed43303dcbbb8fe80e1b_f11211b010ac2c075_d20240411_m032921_c001_v0001131_t0014_u01712806161111") --- PASS: TestServerSideMove (11.17s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:29:28 DEBUG : Creating backend with remote "TestB2:rclone-test-tadogis3moviled1tatiqar0" sync_test.go:1494: Server side move (if possible) B2 bucket rclone-test-qojixih7jumoviv5kihajar2 -> B2 bucket rclone-test-tadogis3moviled1tatiqar0 2024/04/11 03:29:32 DEBUG : empty space: Excluded (Size Filter) 2024/04/11 03:29:32 DEBUG : empty space: Excluded 2024/04/11 03:29:32 DEBUG : empty space: Excluded (Size Filter) 2024/04/11 03:29:32 DEBUG : empty space: Excluded 2024/04/11 03:29:32 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/11 03:29:32 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2024/04/11 03:29:32 DEBUG : B2 bucket rclone-test-tadogis3moviled1tatiqar0: Waiting for checks to finish 2024/04/11 03:29:32 DEBUG : B2 bucket rclone-test-tadogis3moviled1tatiqar0: Waiting for transfers to finish 2024/04/11 03:29:33 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2024/04/11 03:29:33 INFO : potato3: Copied (server-side copy) 2024/04/11 03:29:33 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/11 03:29:33 INFO : potato2: Copied (server-side copy) 2024/04/11 03:29:33 INFO : potato3: Deleted 2024/04/11 03:29:33 INFO : potato2: Deleted 2024/04/11 03:29:34 DEBUG : Creating backend with remote "TestB2:rclone-test-vayelib5zocinax7puqific3" 2024/04/11 03:29:34 DEBUG : empty space: Excluded (Size Filter) 2024/04/11 03:29:34 DEBUG : empty space: Excluded 2024/04/11 03:29:34 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/11 03:29:34 DEBUG : potato3: Need to transfer - File not found at Destination 2024/04/11 03:29:34 DEBUG : B2 bucket rclone-test-vayelib5zocinax7puqific3: Waiting for checks to finish 2024/04/11 03:29:34 DEBUG : B2 bucket rclone-test-vayelib5zocinax7puqific3: Waiting for transfers to finish 2024/04/11 03:29:35 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/11 03:29:35 INFO : potato2: Copied (server-side copy) 2024/04/11 03:29:36 INFO : potato2: Deleted 2024/04/11 03:29:36 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2024/04/11 03:29:36 INFO : potato3: Copied (server-side copy) 2024/04/11 03:29:36 INFO : potato3: Deleted 2024/04/11 03:29:36 DEBUG : B2 bucket rclone-test-vayelib5zocinax7puqific3: Purge remote 2024/04/11 03:29:36 INFO : B2 bucket rclone-test-vayelib5zocinax7puqific3: cleaning bucket "rclone-test-vayelib5zocinax7puqific3" of all files 2024/04/11 03:29:37 DEBUG : potato2: Deleting (id "4_z4fd22d13304dcbbb8fe80e1b_f1067981a175f00df_d20240411_m032935_c001_v0001179_t0000_u01712806175607") 2024/04/11 03:29:37 DEBUG : potato3: Deleting (id "4_z4fd22d13304dcbbb8fe80e1b_f107f0b9723334c8e_d20240411_m032935_c001_v0001044_t0039_u01712806175605") 2024/04/11 03:29:37 DEBUG : B2 bucket rclone-test-tadogis3moviled1tatiqar0: Purge remote 2024/04/11 03:29:37 INFO : B2 bucket rclone-test-tadogis3moviled1tatiqar0: cleaning bucket "rclone-test-tadogis3moviled1tatiqar0" of all files 2024/04/11 03:29:37 DEBUG : empty space: Deleting (id "4_z8fa21d03304dcbbb8fe80e1b_f105d97954ecc4108_d20240411_m032931_c001_v0001179_t0056_u01712806171988") 2024/04/11 03:29:37 DEBUG : potato2: Deleting (id "4_z8fa21d03304dcbbb8fe80e1b_f40739ad12d213544_d20240411_m032936_c001_v7007000_t0000_u01712806176000") 2024/04/11 03:29:37 DEBUG : potato2: Deleting (id "4_z8fa21d03304dcbbb8fe80e1b_f1068fb320ea35875_d20240411_m032933_c001_v0001023_t0000_u01712806173087") 2024/04/11 03:29:37 DEBUG : potato3: Deleting (id "4_z8fa21d03304dcbbb8fe80e1b_f402ff81f17091a69_d20240411_m032936_c001_v7007000_t0000_u01712806176376") 2024/04/11 03:29:37 DEBUG : potato3: Deleting (id "4_z8fa21d03304dcbbb8fe80e1b_f1130187d2f5806b7_d20240411_m032933_c001_v0001116_t0025_u01712806173103") 2024/04/11 03:29:37 DEBUG : potato3: Deleting (id "4_z8fa21d03304dcbbb8fe80e1b_f105d97954ecc411a_d20240411_m032932_c001_v0001179_t0057_u01712806172226") --- PASS: TestServerSideMoveWithFilter (11.46s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:29:39 DEBUG : Creating backend with remote "TestB2:rclone-test-cisovej8qugewem0dorusot4" 2024/04/11 03:29:42 DEBUG : tomatoDir: Making directory sync_test.go:1494: Server side move (if possible) B2 bucket rclone-test-qojixih7jumoviv5kihajar2 -> B2 bucket rclone-test-cisovej8qugewem0dorusot4 2024/04/11 03:29:45 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/11 03:29:45 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ms) 2024/04/11 03:29:45 DEBUG : empty space: Unchanged skipping 2024/04/11 03:29:45 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2024/04/11 03:29:45 DEBUG : B2 bucket rclone-test-cisovej8qugewem0dorusot4: Waiting for checks to finish 2024/04/11 03:29:45 INFO : empty space: Deleted 2024/04/11 03:29:45 DEBUG : B2 bucket rclone-test-cisovej8qugewem0dorusot4: Waiting for transfers to finish 2024/04/11 03:29:45 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2024/04/11 03:29:45 INFO : potato3: Copied (server-side copy) 2024/04/11 03:29:45 INFO : potato3: Deleted 2024/04/11 03:29:46 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/11 03:29:46 INFO : potato2: Copied (server-side copy) 2024/04/11 03:29:46 INFO : potato2: Deleted 2024/04/11 03:29:46 DEBUG : Creating backend with remote "TestB2:rclone-test-banuyuy7hatalih1bomedij9" 2024/04/11 03:29:47 DEBUG : tomatoDir: Making directory 2024/04/11 03:29:47 DEBUG : empty space: Need to transfer - File not found at Destination 2024/04/11 03:29:47 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/11 03:29:47 DEBUG : potato3: Need to transfer - File not found at Destination 2024/04/11 03:29:47 DEBUG : B2 bucket rclone-test-banuyuy7hatalih1bomedij9: Waiting for checks to finish 2024/04/11 03:29:47 DEBUG : B2 bucket rclone-test-banuyuy7hatalih1bomedij9: Waiting for transfers to finish 2024/04/11 03:29:48 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/11 03:29:48 INFO : potato2: Copied (server-side copy) 2024/04/11 03:29:48 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/04/11 03:29:48 INFO : empty space: Copied (server-side copy) 2024/04/11 03:29:48 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2024/04/11 03:29:48 INFO : potato3: Copied (server-side copy) 2024/04/11 03:29:48 INFO : potato2: Deleted 2024/04/11 03:29:48 INFO : empty space: Deleted 2024/04/11 03:29:48 INFO : potato3: Deleted 2024/04/11 03:29:49 DEBUG : B2 bucket rclone-test-banuyuy7hatalih1bomedij9: Purge remote 2024/04/11 03:29:49 INFO : B2 bucket rclone-test-banuyuy7hatalih1bomedij9: cleaning bucket "rclone-test-banuyuy7hatalih1bomedij9" of all files 2024/04/11 03:29:49 DEBUG : empty space: Deleting (id "4_zdf225d23304dcbbb8fe80e1b_f113e496bbeb21564_d20240411_m032948_c001_v0001100_t0033_u01712806188270") 2024/04/11 03:29:49 DEBUG : potato2: Deleting (id "4_zdf225d23304dcbbb8fe80e1b_f117093c4d7e535d6_d20240411_m032948_c001_v0001179_t0020_u01712806188286") 2024/04/11 03:29:49 DEBUG : potato3: Deleting (id "4_zdf225d23304dcbbb8fe80e1b_f109fbb67d403ba06_d20240411_m032948_c001_v0001136_t0058_u01712806188279") 2024/04/11 03:29:50 DEBUG : B2 bucket rclone-test-cisovej8qugewem0dorusot4: Purge remote 2024/04/11 03:29:50 INFO : B2 bucket rclone-test-cisovej8qugewem0dorusot4: cleaning bucket "rclone-test-cisovej8qugewem0dorusot4" of all files 2024/04/11 03:29:50 DEBUG : empty space: Deleting (id "4_zfff23dd3304dcbbb8fe80e1b_f40878ed6710f9234_d20240411_m032948_c001_v7007000_t0000_u01712806188653") 2024/04/11 03:29:50 DEBUG : empty space: Deleting (id "4_zfff23dd3304dcbbb8fe80e1b_f101b7635b670ad4d_d20240411_m032943_c001_v0001030_t0008_u01712806183555") 2024/04/11 03:29:50 DEBUG : potato2: Deleting (id "4_zfff23dd3304dcbbb8fe80e1b_f404178af593e4419_d20240411_m032948_c001_v7007000_t0000_u01712806188509") 2024/04/11 03:29:50 DEBUG : potato2: Deleting (id "4_zfff23dd3304dcbbb8fe80e1b_f1079f298e844c6e1_d20240411_m032945_c001_v0001161_t0051_u01712806185464") 2024/04/11 03:29:50 DEBUG : potato3: Deleting (id "4_zfff23dd3304dcbbb8fe80e1b_f40739ad12d213585_d20240411_m032948_c001_v7007000_t0000_u01712806188666") 2024/04/11 03:29:50 DEBUG : potato3: Deleting (id "4_zfff23dd3304dcbbb8fe80e1b_f115f888c14b7b057_d20240411_m032945_c001_v0001178_t0018_u01712806185436") 2024/04/11 03:29:50 DEBUG : potato3: Deleting (id "4_zfff23dd3304dcbbb8fe80e1b_f101b7635b670ad4f_d20240411_m032944_c001_v0001030_t0034_u01712806184111") --- PASS: TestServerSideMoveDeleteEmptySourceDirs (12.11s) === RUN TestServerSideMoveOverlap run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:29:51 DEBUG : Creating backend with remote "TestB2:rclone-test-qojixih7jumoviv5kihajar2/rclone-move-test" --- PASS: TestServerSideMoveOverlap (2.42s) === RUN TestSyncOverlap run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:29:54 DEBUG : Creating backend with remote "TestB2:rclone-test-qojixih7jumoviv5kihajar2/rclone-sync-test" run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestSyncOverlap (2.75s) === RUN TestSyncOverlapWithFilter run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:29:57 DEBUG : Creating backend with remote "TestB2:rclone-test-qojixih7jumoviv5kihajar2/rclone-sync-test" 2024/04/11 03:29:57 DEBUG : Creating backend with remote "TestB2:rclone-test-qojixih7jumoviv5kihajar2/rclone-sync-test-include/layer2" 2024/04/11 03:29:58 DEBUG : Creating backend with remote "TestB2:rclone-test-qojixih7jumoviv5kihajar2/rclone-sync-test-ignore-file" 2024/04/11 03:30:00 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/04/11 03:30:00 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path rclone-sync-test: Waiting for checks to finish 2024/04/11 03:30:00 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path rclone-sync-test: Waiting for transfers to finish 2024/04/11 03:30:00 DEBUG : Waiting for deletions to finish 2024/04/11 03:30:00 INFO : There was nothing to transfer 2024/04/11 03:30:01 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/04/11 03:30:01 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:30:01 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:30:01 DEBUG : Waiting for deletions to finish 2024/04/11 03:30:01 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:30:02 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/04/11 03:30:02 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path rclone-sync-test-include/layer2: Waiting for checks to finish 2024/04/11 03:30:02 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path rclone-sync-test-include/layer2: Waiting for transfers to finish 2024/04/11 03:30:02 DEBUG : Waiting for deletions to finish 2024/04/11 03:30:02 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:30:02 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/04/11 03:30:02 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:30:02 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:30:02 DEBUG : Waiting for deletions to finish 2024/04/11 03:30:02 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:30:03 DEBUG : : Excluded 2024/04/11 03:30:03 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/04/11 03:30:03 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path rclone-sync-test-ignore-file: Waiting for checks to finish 2024/04/11 03:30:03 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path rclone-sync-test-ignore-file: Waiting for transfers to finish 2024/04/11 03:30:03 DEBUG : Waiting for deletions to finish 2024/04/11 03:30:03 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestSyncOverlapWithFilter (12.96s) === RUN TestSyncCompareDest run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:30:10 DEBUG : Creating backend with remote "TestB2:rclone-test-qojixih7jumoviv5kihajar2/dst" 2024/04/11 03:30:11 DEBUG : Creating backend with remote "TestB2:rclone-test-qojixih7jumoviv5kihajar2/CompareDest" 2024/04/11 03:30:12 DEBUG : one: Need to transfer - File not found at Destination 2024/04/11 03:30:12 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for checks to finish 2024/04/11 03:30:12 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for transfers to finish 2024/04/11 03:30:13 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/04/11 03:30:13 INFO : one: Copied (new) 2024/04/11 03:30:13 DEBUG : Waiting for deletions to finish 2024/04/11 03:30:14 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/04/11 03:30:14 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for checks to finish 2024/04/11 03:30:14 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for transfers to finish 2024/04/11 03:30:15 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2024/04/11 03:30:15 INFO : one: Copied (replaced existing) 2024/04/11 03:30:15 DEBUG : Waiting for deletions to finish 2024/04/11 03:30:18 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/04/11 03:30:18 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for checks to finish 2024/04/11 03:30:18 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/11 03:30:18 DEBUG : one: Destination found in --compare-dest, skipping 2024/04/11 03:30:18 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for transfers to finish 2024/04/11 03:30:18 DEBUG : Waiting for deletions to finish 2024/04/11 03:30:18 INFO : There was nothing to transfer 2024/04/11 03:30:19 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/11 03:30:19 DEBUG : two: Destination found in --compare-dest, skipping 2024/04/11 03:30:19 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/04/11 03:30:19 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for checks to finish 2024/04/11 03:30:19 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/11 03:30:19 DEBUG : one: Destination found in --compare-dest, skipping 2024/04/11 03:30:19 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for transfers to finish 2024/04/11 03:30:19 DEBUG : Waiting for deletions to finish 2024/04/11 03:30:19 INFO : There was nothing to transfer 2024/04/11 03:30:20 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/11 03:30:20 DEBUG : two: Destination found in --compare-dest, skipping 2024/04/11 03:30:20 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/04/11 03:30:20 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for checks to finish 2024/04/11 03:30:20 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/11 03:30:20 DEBUG : one: Destination found in --compare-dest, skipping 2024/04/11 03:30:20 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for transfers to finish 2024/04/11 03:30:20 DEBUG : Waiting for deletions to finish 2024/04/11 03:30:20 INFO : There was nothing to transfer 2024/04/11 03:30:21 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 2024/04/11 03:30:21 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2024/04/11 03:30:21 DEBUG : two: Destination found in --compare-dest, skipping 2024/04/11 03:30:21 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for checks to finish 2024/04/11 03:30:21 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/04/11 03:30:21 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/11 03:30:21 DEBUG : one: Destination found in --compare-dest, skipping 2024/04/11 03:30:21 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for transfers to finish 2024/04/11 03:30:21 DEBUG : Waiting for deletions to finish 2024/04/11 03:30:21 INFO : There was nothing to transfer 2024/04/11 03:30:22 DEBUG : two: Sizes differ (src 5 vs dst 3) 2024/04/11 03:30:22 DEBUG : two: Need to transfer - File not found at Destination 2024/04/11 03:30:22 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/04/11 03:30:22 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for checks to finish 2024/04/11 03:30:22 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/11 03:30:22 DEBUG : one: Destination found in --compare-dest, skipping 2024/04/11 03:30:22 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for transfers to finish 2024/04/11 03:30:22 DEBUG : two: sha1 = a4be8877ad88f3109a6411985a1f359e10e2d930 OK 2024/04/11 03:30:22 INFO : two: Copied (new) 2024/04/11 03:30:22 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (14.16s) === RUN TestSyncMultipleCompareDest run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:30:26 DEBUG : Creating backend with remote "TestB2:rclone-test-qojixih7jumoviv5kihajar2/dest" 2024/04/11 03:30:26 DEBUG : Creating backend with remote "TestB2:rclone-test-qojixih7jumoviv5kihajar2/pre-dest1" 2024/04/11 03:30:27 DEBUG : Creating backend with remote "TestB2:rclone-test-qojixih7jumoviv5kihajar2/pre-dest2" 2024/04/11 03:30:28 DEBUG : 1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:30:28 DEBUG : 1: Destination found in --compare-dest, skipping 2024/04/11 03:30:28 DEBUG : 2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:30:28 DEBUG : 2: Destination found in --compare-dest, skipping 2024/04/11 03:30:28 DEBUG : 3: Need to transfer - File not found at Destination 2024/04/11 03:30:28 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dest: Waiting for checks to finish 2024/04/11 03:30:28 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dest: Waiting for transfers to finish 2024/04/11 03:30:29 DEBUG : 3: sha1 = 77de68daecd823babbb58edb1c8e14d7106e83bb OK 2024/04/11 03:30:29 INFO : 3: Copied (new) 2024/04/11 03:30:29 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (6.82s) === RUN TestSyncCopyDest run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:30:31 DEBUG : Creating backend with remote "TestB2:rclone-test-qojixih7jumoviv5kihajar2/dst" 2024/04/11 03:30:31 DEBUG : Creating backend with remote "TestB2:rclone-test-qojixih7jumoviv5kihajar2/CopyDest" 2024/04/11 03:30:32 DEBUG : one: Need to transfer - File not found at Destination 2024/04/11 03:30:32 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for checks to finish 2024/04/11 03:30:32 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for transfers to finish 2024/04/11 03:30:33 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/04/11 03:30:33 INFO : one: Copied (new) 2024/04/11 03:30:33 DEBUG : Waiting for deletions to finish 2024/04/11 03:30:33 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for checks to finish 2024/04/11 03:30:33 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/04/11 03:30:34 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for transfers to finish 2024/04/11 03:30:34 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2024/04/11 03:30:34 INFO : one: Copied (replaced existing) 2024/04/11 03:30:34 DEBUG : Waiting for deletions to finish 2024/04/11 03:30:36 DEBUG : Creating backend with remote "TestB2:rclone-test-qojixih7jumoviv5kihajar2/BackupDir" 2024/04/11 03:30:37 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/04/11 03:30:37 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for checks to finish 2024/04/11 03:30:38 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/11 03:30:38 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/04/11 03:30:39 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/04/11 03:30:39 INFO : one: Copied (server-side copy) 2024/04/11 03:30:39 INFO : one: Deleted 2024/04/11 03:30:39 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2024/04/11 03:30:39 INFO : one: Copied (server-side copy) 2024/04/11 03:30:39 DEBUG : one: Destination found in --copy-dest, using server-side copy 2024/04/11 03:30:39 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for transfers to finish 2024/04/11 03:30:39 DEBUG : Waiting for deletions to finish 2024/04/11 03:30:40 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/11 03:30:41 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2024/04/11 03:30:41 INFO : two: Copied (server-side copy) 2024/04/11 03:30:41 DEBUG : two: Destination found in --copy-dest, using server-side copy 2024/04/11 03:30:41 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/11 03:30:41 DEBUG : one: Unchanged skipping 2024/04/11 03:30:41 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for checks to finish 2024/04/11 03:30:41 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for transfers to finish 2024/04/11 03:30:41 DEBUG : Waiting for deletions to finish 2024/04/11 03:30:41 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/11 03:30:41 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/11 03:30:41 DEBUG : one: Unchanged skipping 2024/04/11 03:30:41 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for checks to finish 2024/04/11 03:30:41 DEBUG : two: Unchanged skipping 2024/04/11 03:30:41 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for transfers to finish 2024/04/11 03:30:41 DEBUG : Waiting for deletions to finish 2024/04/11 03:30:41 INFO : There was nothing to transfer 2024/04/11 03:30:43 DEBUG : three: Sizes differ (src 7 vs dst 5) 2024/04/11 03:30:43 DEBUG : three: Destination not found in --copy-dest 2024/04/11 03:30:43 DEBUG : three: Need to transfer - File not found at Destination 2024/04/11 03:30:43 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/11 03:30:43 DEBUG : one: Unchanged skipping 2024/04/11 03:30:43 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/11 03:30:43 DEBUG : two: Unchanged skipping 2024/04/11 03:30:43 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for checks to finish 2024/04/11 03:30:43 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for transfers to finish 2024/04/11 03:30:44 DEBUG : three: sha1 = 370e613335f3cf2f19b2a2d35a86402f55c659f8 OK 2024/04/11 03:30:44 INFO : three: Copied (new) 2024/04/11 03:30:44 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCopyDest (15.88s) === RUN TestSyncBackupDir run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:30:48 DEBUG : Creating backend with remote "TestB2:rclone-test-qojixih7jumoviv5kihajar2/dst" 2024/04/11 03:30:49 DEBUG : Creating backend with remote "TestB2:rclone-test-qojixih7jumoviv5kihajar2/backup" 2024/04/11 03:30:50 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/04/11 03:30:50 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:30:50 DEBUG : two: Unchanged skipping 2024/04/11 03:30:50 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for checks to finish 2024/04/11 03:30:51 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/04/11 03:30:51 INFO : one: Copied (server-side copy) 2024/04/11 03:30:51 INFO : one: Deleted 2024/04/11 03:30:51 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for transfers to finish 2024/04/11 03:30:52 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/11 03:30:52 INFO : one: Copied (new) 2024/04/11 03:30:52 DEBUG : Waiting for deletions to finish 2024/04/11 03:30:52 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2024/04/11 03:30:52 INFO : three.txt: Copied (server-side copy) 2024/04/11 03:30:53 INFO : three.txt: Deleted 2024/04/11 03:30:53 INFO : three.txt: Moved into backup dir 2024/04/11 03:30:54 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/04/11 03:30:54 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:30:54 DEBUG : two: Unchanged skipping 2024/04/11 03:30:54 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for checks to finish 2024/04/11 03:30:55 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/11 03:30:55 INFO : one: Copied (server-side copy) 2024/04/11 03:30:55 INFO : one: Deleted 2024/04/11 03:30:55 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for transfers to finish 2024/04/11 03:30:55 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2024/04/11 03:30:55 INFO : one: Copied (new) 2024/04/11 03:30:55 DEBUG : Waiting for deletions to finish 2024/04/11 03:30:56 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/04/11 03:30:56 INFO : three.txt: Copied (server-side copy) 2024/04/11 03:30:56 INFO : three.txt: Deleted 2024/04/11 03:30:56 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (11.15s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:31:01 DEBUG : Creating backend with remote "TestB2:rclone-test-qojixih7jumoviv5kihajar2/dst" 2024/04/11 03:31:02 DEBUG : Creating backend with remote "TestB2:rclone-test-qojixih7jumoviv5kihajar2/backup" 2024/04/11 03:31:03 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/04/11 03:31:03 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:31:03 DEBUG : two: Unchanged skipping 2024/04/11 03:31:03 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for checks to finish 2024/04/11 03:31:03 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/04/11 03:31:03 INFO : one: Copied (server-side copy) to: one.bak 2024/04/11 03:31:04 INFO : one: Deleted 2024/04/11 03:31:04 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for transfers to finish 2024/04/11 03:31:04 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/11 03:31:04 INFO : one: Copied (new) 2024/04/11 03:31:04 DEBUG : Waiting for deletions to finish 2024/04/11 03:31:05 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2024/04/11 03:31:05 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/04/11 03:31:05 INFO : three.txt: Deleted 2024/04/11 03:31:05 INFO : three.txt: Moved into backup dir 2024/04/11 03:31:07 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/04/11 03:31:07 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:31:07 DEBUG : two: Unchanged skipping 2024/04/11 03:31:07 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for checks to finish 2024/04/11 03:31:07 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/11 03:31:07 INFO : one: Copied (server-side copy) to: one.bak 2024/04/11 03:31:08 INFO : one: Deleted 2024/04/11 03:31:08 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for transfers to finish 2024/04/11 03:31:08 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2024/04/11 03:31:08 INFO : one: Copied (new) 2024/04/11 03:31:08 DEBUG : Waiting for deletions to finish 2024/04/11 03:31:08 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/04/11 03:31:08 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/04/11 03:31:09 INFO : three.txt: Deleted 2024/04/11 03:31:09 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (12.37s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:31:12 DEBUG : Creating backend with remote "TestB2:rclone-test-qojixih7jumoviv5kihajar2/dst" 2024/04/11 03:31:12 DEBUG : Creating backend with remote "TestB2:rclone-test-qojixih7jumoviv5kihajar2/backup" 2024/04/11 03:31:13 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/04/11 03:31:13 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for checks to finish 2024/04/11 03:31:13 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:31:13 DEBUG : two: Unchanged skipping 2024/04/11 03:31:14 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/04/11 03:31:14 INFO : one: Copied (server-side copy) to: one-2019-01-01 2024/04/11 03:31:14 INFO : one: Deleted 2024/04/11 03:31:14 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for transfers to finish 2024/04/11 03:31:15 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/11 03:31:15 INFO : one: Copied (new) 2024/04/11 03:31:15 DEBUG : Waiting for deletions to finish 2024/04/11 03:31:16 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2024/04/11 03:31:16 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2024/04/11 03:31:16 INFO : three.txt: Deleted 2024/04/11 03:31:16 INFO : three.txt: Moved into backup dir 2024/04/11 03:31:17 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/04/11 03:31:17 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:31:17 DEBUG : two: Unchanged skipping 2024/04/11 03:31:17 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for checks to finish 2024/04/11 03:31:18 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/11 03:31:18 INFO : one: Copied (server-side copy) to: one-2019-01-01 2024/04/11 03:31:19 INFO : one: Deleted 2024/04/11 03:31:19 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for transfers to finish 2024/04/11 03:31:20 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2024/04/11 03:31:20 INFO : one: Copied (new) 2024/04/11 03:31:20 DEBUG : Waiting for deletions to finish 2024/04/11 03:31:21 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/04/11 03:31:21 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2024/04/11 03:31:21 INFO : three.txt: Deleted 2024/04/11 03:31:21 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (12.78s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:31:24 DEBUG : Creating backend with remote "TestB2:rclone-test-qojixih7jumoviv5kihajar2/dst" 2024/04/11 03:31:26 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/04/11 03:31:26 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:31:26 DEBUG : two: Unchanged skipping 2024/04/11 03:31:26 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for checks to finish 2024/04/11 03:31:26 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/04/11 03:31:26 INFO : one: Copied (server-side copy) to: one.bak 2024/04/11 03:31:27 INFO : one: Deleted 2024/04/11 03:31:27 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for transfers to finish 2024/04/11 03:31:27 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/11 03:31:27 INFO : one: Copied (new) 2024/04/11 03:31:27 DEBUG : Waiting for deletions to finish 2024/04/11 03:31:28 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2024/04/11 03:31:28 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/04/11 03:31:28 INFO : three.txt: Deleted 2024/04/11 03:31:28 INFO : three.txt: Moved into backup dir 2024/04/11 03:31:29 DEBUG : one.bak: Excluded (Path Filter) 2024/04/11 03:31:29 DEBUG : one.bak: Excluded 2024/04/11 03:31:29 DEBUG : three.txt.bak: Excluded (Path Filter) 2024/04/11 03:31:29 DEBUG : three.txt.bak: Excluded 2024/04/11 03:31:29 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/04/11 03:31:29 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:31:29 DEBUG : two: Unchanged skipping 2024/04/11 03:31:29 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for checks to finish 2024/04/11 03:31:30 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/11 03:31:30 INFO : one: Copied (server-side copy) to: one.bak 2024/04/11 03:31:30 INFO : one: Deleted 2024/04/11 03:31:30 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2 path dst: Waiting for transfers to finish 2024/04/11 03:31:30 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2024/04/11 03:31:30 INFO : one: Copied (new) 2024/04/11 03:31:30 DEBUG : Waiting for deletions to finish 2024/04/11 03:31:30 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/04/11 03:31:30 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/04/11 03:31:31 INFO : three.txt: Deleted 2024/04/11 03:31:31 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (9.31s) === RUN TestSyncSuffix run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:31:34 DEBUG : Creating backend with remote "TestB2:rclone-test-qojixih7jumoviv5kihajar2/dst" 2024/04/11 03:31:35 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/04/11 03:31:36 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/04/11 03:31:36 INFO : one: Copied (server-side copy) to: one.bak 2024/04/11 03:31:36 INFO : one: Deleted 2024/04/11 03:31:37 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/11 03:31:37 INFO : one: Copied (new) 2024/04/11 03:31:37 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:31:37 DEBUG : two: Unchanged skipping 2024/04/11 03:31:37 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2024/04/11 03:31:38 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2024/04/11 03:31:38 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/04/11 03:31:38 INFO : three.txt: Deleted 2024/04/11 03:31:39 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/04/11 03:31:39 INFO : three.txt: Copied (new) 2024/04/11 03:31:39 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/04/11 03:31:40 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/11 03:31:40 INFO : one: Copied (server-side copy) to: one.bak 2024/04/11 03:31:40 INFO : one: Deleted 2024/04/11 03:31:40 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2024/04/11 03:31:40 INFO : one: Copied (new) 2024/04/11 03:31:41 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:31:41 DEBUG : two: Unchanged skipping 2024/04/11 03:31:41 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2024/04/11 03:31:41 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/04/11 03:31:41 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/04/11 03:31:42 INFO : three.txt: Deleted 2024/04/11 03:31:42 DEBUG : three.txt: sha1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK 2024/04/11 03:31:42 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (11.73s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:31:46 DEBUG : Creating backend with remote "TestB2:rclone-test-qojixih7jumoviv5kihajar2/dst" 2024/04/11 03:31:47 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/04/11 03:31:48 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/04/11 03:31:48 INFO : one: Copied (server-side copy) to: one-2019-01-01 2024/04/11 03:31:48 INFO : one: Deleted 2024/04/11 03:31:49 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/11 03:31:49 INFO : one: Copied (new) 2024/04/11 03:31:49 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:31:49 DEBUG : two: Unchanged skipping 2024/04/11 03:31:50 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2024/04/11 03:31:50 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2024/04/11 03:31:50 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2024/04/11 03:31:50 INFO : three.txt: Deleted 2024/04/11 03:31:51 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/04/11 03:31:51 INFO : three.txt: Copied (new) 2024/04/11 03:31:51 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/04/11 03:31:52 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/11 03:31:52 INFO : one: Copied (server-side copy) to: one-2019-01-01 2024/04/11 03:31:52 INFO : one: Deleted 2024/04/11 03:31:53 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2024/04/11 03:31:53 INFO : one: Copied (new) 2024/04/11 03:31:53 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:31:53 DEBUG : two: Unchanged skipping 2024/04/11 03:31:53 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2024/04/11 03:31:54 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/04/11 03:31:54 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2024/04/11 03:31:54 INFO : three.txt: Deleted 2024/04/11 03:31:54 DEBUG : three.txt: sha1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK 2024/04/11 03:31:54 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (12.01s) === RUN TestSyncUTFNorm run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:31:57 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2024/04/11 03:31:57 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:31:57 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:31:58 DEBUG : Testêé: sha1 = a54d88e06612d820bc3be72877c74f257b561b19 OK 2024/04/11 03:31:58 INFO : Testêé: Copied (replaced existing) to: Testêé 2024/04/11 03:31:58 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (3.02s) === RUN TestSyncImmutable run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:31:59 DEBUG : existing: Need to transfer - File not found at Destination 2024/04/11 03:31:59 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:31:59 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:31:59 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2024/04/11 03:31:59 INFO : existing: Copied (new) 2024/04/11 03:31:59 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:32:00 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2024/04/11 03:32:00 ERROR : existing: Source and destination exist but do not match: immutable file modified 2024/04/11 03:32:00 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:32:00 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:32:00 ERROR : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: not deleting files as there were IO errors 2024/04/11 03:32:00 ERROR : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: not deleting directories as there were IO errors run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestSyncImmutable (2.84s) === RUN TestSyncIgnoreCase run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:32:02 DEBUG : existing: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:02 DEBUG : existing: Unchanged skipping 2024/04/11 03:32:02 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:32:02 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:32:02 DEBUG : Waiting for deletions to finish 2024/04/11 03:32:02 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (1.57s) === RUN TestFixCase run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" sync_test.go:2420: Skipping test as local or remote are case-sensitive --- SKIP: TestFixCase (0.81s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" sync_test.go:2459: This test only runs on local === RUN TestMaxTransfer/Soft run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" sync_test.go:2459: This test only runs on local === RUN TestMaxTransfer/Cautious run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" sync_test.go:2459: This test only runs on local --- PASS: TestMaxTransfer (1.17s) --- SKIP: TestMaxTransfer/Hard (0.39s) --- SKIP: TestMaxTransfer/Soft (0.39s) --- SKIP: TestMaxTransfer/Cautious (0.39s) === RUN TestSyncConcurrentDelete run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:32:22 DEBUG : both0: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:22 DEBUG : both0: Unchanged skipping 2024/04/11 03:32:22 DEBUG : both1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:22 DEBUG : both1: Unchanged skipping 2024/04/11 03:32:22 DEBUG : both10: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:22 DEBUG : both10: Unchanged skipping 2024/04/11 03:32:22 DEBUG : both11: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:22 DEBUG : both11: Unchanged skipping 2024/04/11 03:32:22 DEBUG : both12: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:22 DEBUG : both12: Unchanged skipping 2024/04/11 03:32:22 DEBUG : both13: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:22 DEBUG : both13: Unchanged skipping 2024/04/11 03:32:22 DEBUG : both14: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:22 DEBUG : both14: Unchanged skipping 2024/04/11 03:32:22 DEBUG : both15: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:22 DEBUG : both15: Unchanged skipping 2024/04/11 03:32:22 DEBUG : both16: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:22 DEBUG : both16: Unchanged skipping 2024/04/11 03:32:22 DEBUG : both17: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:22 DEBUG : both17: Unchanged skipping 2024/04/11 03:32:22 DEBUG : both18: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:22 DEBUG : both18: Unchanged skipping 2024/04/11 03:32:22 DEBUG : both19: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:22 DEBUG : both19: Unchanged skipping 2024/04/11 03:32:22 DEBUG : both2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:22 DEBUG : both2: Unchanged skipping 2024/04/11 03:32:22 DEBUG : both3: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:22 DEBUG : both3: Unchanged skipping 2024/04/11 03:32:22 DEBUG : both4: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:22 DEBUG : both4: Unchanged skipping 2024/04/11 03:32:22 DEBUG : both5: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:22 DEBUG : both5: Unchanged skipping 2024/04/11 03:32:22 DEBUG : both6: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:22 DEBUG : both6: Unchanged skipping 2024/04/11 03:32:22 DEBUG : both7: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:22 DEBUG : both7: Unchanged skipping 2024/04/11 03:32:22 DEBUG : both8: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:22 DEBUG : both8: Unchanged skipping 2024/04/11 03:32:22 DEBUG : both9: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:22 DEBUG : both9: Unchanged skipping 2024/04/11 03:32:22 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:32:22 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:32:22 DEBUG : Waiting for deletions to finish 2024/04/11 03:32:22 INFO : only15: Deleted 2024/04/11 03:32:22 INFO : only18: Deleted 2024/04/11 03:32:22 INFO : only2: Deleted 2024/04/11 03:32:22 INFO : only1: Deleted 2024/04/11 03:32:22 INFO : only12: Deleted 2024/04/11 03:32:22 INFO : only8: Deleted 2024/04/11 03:32:22 INFO : only17: Deleted 2024/04/11 03:32:22 INFO : only7: Deleted 2024/04/11 03:32:22 INFO : only5: Deleted 2024/04/11 03:32:22 INFO : only10: Deleted 2024/04/11 03:32:23 INFO : only13: Deleted 2024/04/11 03:32:23 INFO : only16: Deleted 2024/04/11 03:32:23 INFO : only19: Deleted 2024/04/11 03:32:23 INFO : only6: Deleted 2024/04/11 03:32:23 INFO : only9: Deleted 2024/04/11 03:32:23 INFO : only0: Deleted 2024/04/11 03:32:23 INFO : only11: Deleted 2024/04/11 03:32:23 INFO : only4: Deleted 2024/04/11 03:32:23 INFO : only14: Deleted 2024/04/11 03:32:23 INFO : only3: Deleted 2024/04/11 03:32:23 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestSyncConcurrentDelete (22.52s) === RUN TestSyncConcurrentTruncate run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:32:43 DEBUG : both0: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:43 DEBUG : both1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:43 DEBUG : both10: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:43 DEBUG : both11: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:43 DEBUG : both0: Unchanged skipping 2024/04/11 03:32:43 DEBUG : both12: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:43 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for checks to finish 2024/04/11 03:32:43 DEBUG : both12: Unchanged skipping 2024/04/11 03:32:43 DEBUG : both13: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:43 DEBUG : both13: Unchanged skipping 2024/04/11 03:32:43 DEBUG : both14: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:43 DEBUG : both14: Unchanged skipping 2024/04/11 03:32:43 DEBUG : both15: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:43 DEBUG : both15: Unchanged skipping 2024/04/11 03:32:43 DEBUG : both16: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:43 DEBUG : both1: Unchanged skipping 2024/04/11 03:32:43 DEBUG : both17: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:43 DEBUG : both17: Unchanged skipping 2024/04/11 03:32:43 DEBUG : both18: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:43 DEBUG : both18: Unchanged skipping 2024/04/11 03:32:43 DEBUG : both19: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:43 DEBUG : both19: Unchanged skipping 2024/04/11 03:32:43 DEBUG : both2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:43 DEBUG : both2: Unchanged skipping 2024/04/11 03:32:43 DEBUG : both3: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:43 DEBUG : both3: Unchanged skipping 2024/04/11 03:32:43 DEBUG : both4: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:43 DEBUG : both4: Unchanged skipping 2024/04/11 03:32:43 DEBUG : both5: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:43 DEBUG : both5: Unchanged skipping 2024/04/11 03:32:43 DEBUG : both6: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:43 DEBUG : both6: Unchanged skipping 2024/04/11 03:32:43 DEBUG : both7: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:43 DEBUG : both7: Unchanged skipping 2024/04/11 03:32:43 DEBUG : both8: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:43 DEBUG : both8: Unchanged skipping 2024/04/11 03:32:43 DEBUG : both9: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/11 03:32:43 DEBUG : both9: Unchanged skipping 2024/04/11 03:32:43 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2024/04/11 03:32:43 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2024/04/11 03:32:43 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2024/04/11 03:32:43 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2024/04/11 03:32:43 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2024/04/11 03:32:43 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2024/04/11 03:32:43 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2024/04/11 03:32:43 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2024/04/11 03:32:43 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2024/04/11 03:32:43 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2024/04/11 03:32:43 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2024/04/11 03:32:43 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2024/04/11 03:32:43 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2024/04/11 03:32:43 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2024/04/11 03:32:43 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2024/04/11 03:32:43 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2024/04/11 03:32:43 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2024/04/11 03:32:43 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2024/04/11 03:32:43 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2024/04/11 03:32:43 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2024/04/11 03:32:43 DEBUG : both10: Unchanged skipping 2024/04/11 03:32:43 DEBUG : both11: Unchanged skipping 2024/04/11 03:32:43 DEBUG : both16: Unchanged skipping 2024/04/11 03:32:43 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Waiting for transfers to finish 2024/04/11 03:32:43 DEBUG : only0: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/11 03:32:43 INFO : only0: Copied (replaced existing) 2024/04/11 03:32:43 DEBUG : only1: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/11 03:32:43 INFO : only1: Copied (replaced existing) 2024/04/11 03:32:43 DEBUG : only12: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/11 03:32:43 INFO : only12: Copied (replaced existing) 2024/04/11 03:32:43 DEBUG : only13: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/11 03:32:43 INFO : only13: Copied (replaced existing) 2024/04/11 03:32:43 DEBUG : only10: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/11 03:32:43 INFO : only10: Copied (replaced existing) 2024/04/11 03:32:43 DEBUG : only14: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/11 03:32:43 INFO : only14: Copied (replaced existing) 2024/04/11 03:32:43 DEBUG : only15: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/11 03:32:43 INFO : only15: Copied (replaced existing) 2024/04/11 03:32:44 DEBUG : only16: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/11 03:32:44 INFO : only16: Copied (replaced existing) 2024/04/11 03:32:44 DEBUG : only17: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/11 03:32:44 INFO : only17: Copied (replaced existing) 2024/04/11 03:32:44 DEBUG : only18: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/11 03:32:44 INFO : only18: Copied (replaced existing) 2024/04/11 03:32:44 DEBUG : only11: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/11 03:32:44 INFO : only11: Copied (replaced existing) 2024/04/11 03:32:44 DEBUG : only19: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/11 03:32:44 INFO : only19: Copied (replaced existing) 2024/04/11 03:32:44 DEBUG : only2: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/11 03:32:44 INFO : only2: Copied (replaced existing) 2024/04/11 03:32:44 DEBUG : only3: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/11 03:32:44 INFO : only3: Copied (replaced existing) 2024/04/11 03:32:44 DEBUG : only4: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/11 03:32:44 INFO : only4: Copied (replaced existing) 2024/04/11 03:32:44 DEBUG : only5: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/11 03:32:44 INFO : only5: Copied (replaced existing) 2024/04/11 03:32:44 DEBUG : only6: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/11 03:32:44 INFO : only6: Copied (replaced existing) 2024/04/11 03:32:44 DEBUG : only8: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/11 03:32:44 INFO : only8: Copied (replaced existing) 2024/04/11 03:32:44 DEBUG : only7: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/11 03:32:44 INFO : only7: Copied (replaced existing) 2024/04/11 03:32:44 DEBUG : only9: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/11 03:32:44 INFO : only9: Copied (replaced existing) 2024/04/11 03:32:44 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestSyncConcurrentTruncate (25.48s) === RUN TestNothingToTransfer run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" 2024/04/11 03:32:53 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/04/11 03:32:53 DEBUG : sub dir: Making directory 2024/04/11 03:32:53 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-qojixih7jumoviv5kihajar2", Local "Local file system at /tmp/rclone3411233408", Modify Window "1ms" --- PASS: TestNothingToTransfer (4.57s) PASS 2024/04/11 03:32:58 DEBUG : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: Purge remote 2024/04/11 03:32:58 INFO : B2 bucket rclone-test-qojixih7jumoviv5kihajar2: cleaning bucket "rclone-test-qojixih7jumoviv5kihajar2" of all files 2024/04/11 03:32:59 DEBUG : BackupDir/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870514_d20240411_m033045_c001_v7007000_t0000_u01712806245079") 2024/04/11 03:32:59 DEBUG : BackupDir/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f109aa67c34dcb09e_d20240411_m033038_c001_v0001157_t0010_u01712806238751") 2024/04/11 03:32:59 DEBUG : CompareDest/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f40566323c6991a2d_d20240411_m033023_c001_v7007000_t0000_u01712806223385") 2024/04/11 03:32:59 DEBUG : CompareDest/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97be2a_d20240411_m033017_c001_v0001181_t0005_u01712806217505") 2024/04/11 03:32:59 DEBUG : CompareDest/two: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f40566323c6991a30_d20240411_m033023_c001_v7007000_t0000_u01712806223567") 2024/04/11 03:32:59 DEBUG : CompareDest/two: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfb90_d20240411_m033018_c001_v0001157_t0010_u01712806218579") 2024/04/11 03:32:59 DEBUG : CopyDest/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870515_d20240411_m033045_c001_v7007000_t0000_u01712806245261") 2024/04/11 03:32:59 DEBUG : CopyDest/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfc12_d20240411_m033035_c001_v0001157_t0014_u01712806235995") 2024/04/11 03:32:59 DEBUG : CopyDest/three: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870516_d20240411_m033045_c001_v7007000_t0000_u01712806245447") 2024/04/11 03:32:59 DEBUG : CopyDest/three: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfc46_d20240411_m033042_c001_v0001157_t0029_u01712806242386") 2024/04/11 03:32:59 DEBUG : CopyDest/two: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870518_d20240411_m033045_c001_v7007000_t0000_u01712806245641") 2024/04/11 03:32:59 DEBUG : CopyDest/two: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97c125_d20240411_m033039_c001_v0001181_t0054_u01712806239941") 2024/04/11 03:32:59 DEBUG : EXISTING: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a8707b5_d20240411_m033203_c001_v7007000_t0000_u01712806323407") 2024/04/11 03:32:59 DEBUG : EXISTING: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfe8d_d20240411_m033202_c001_v0001157_t0036_u01712806322211") 2024/04/11 03:32:59 DEBUG : Testêé: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a8707aa_d20240411_m033158_c001_v7007000_t0000_u01712806318994") 2024/04/11 03:32:59 DEBUG : Testêé: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfe79_d20240411_m033158_c001_v0001157_t0024_u01712806318029") 2024/04/11 03:32:59 DEBUG : Testêé: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97ccc3_d20240411_m033156_c001_v0001181_t0002_u01712806316754") 2024/04/11 03:32:59 DEBUG : a/potato2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd4a0f_d20240411_m032837_c001_v7007000_t0000_u01712806117139") 2024/04/11 03:32:59 DEBUG : a/potato2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97b033_d20240411_m032836_c001_v0001181_t0036_u01712806116435") 2024/04/11 03:32:59 DEBUG : a/potato2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f411b8519caef39d9_d20240411_m032834_c001_v7007000_t0000_u01712806114442") 2024/04/11 03:32:59 DEBUG : a/potato2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97afc5_d20240411_m032833_c001_v0001181_t0014_u01712806113539") 2024/04/11 03:33:00 DEBUG : a/potato2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f4075e69e2954bd6d_d20240411_m032811_c001_v7007000_t0000_u01712806091968") 2024/04/11 03:33:00 DEBUG : a/potato2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97ac85_d20240411_m032811_c001_v0001181_t0036_u01712806091087") 2024/04/11 03:33:00 DEBUG : b/potato: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd4a13_d20240411_m032837_c001_v7007000_t0000_u01712806117333") 2024/04/11 03:33:00 DEBUG : b/potato: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97b00d_d20240411_m032835_c001_v0001181_t0027_u01712806115388") 2024/04/11 03:33:00 DEBUG : b/potato: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f411b8519caef39d8_d20240411_m032833_c001_v7007000_t0000_u01712806113888") 2024/04/11 03:33:00 DEBUG : b/potato: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97afa7_d20240411_m032832_c001_v0001181_t0043_u01712806112271") 2024/04/11 03:33:00 DEBUG : b/potato: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f4075e69e2954bd6c_d20240411_m032811_c001_v7007000_t0000_u01712806091419") 2024/04/11 03:33:00 DEBUG : b/potato: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97ac5a_d20240411_m032810_c001_v0001181_t0005_u01712806090068") 2024/04/11 03:33:00 DEBUG : backup/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a8705f9_d20240411_m033057_c001_v7007000_t0000_u01712806257212") 2024/04/11 03:33:00 DEBUG : backup/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f107b9af33aa52441_d20240411_m033054_c001_v0001157_t0057_u01712806254801") 2024/04/11 03:33:00 DEBUG : backup/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f101d6fbb48196b9e_d20240411_m033051_c001_v0001098_t0017_u01712806251088") 2024/04/11 03:33:00 DEBUG : backup/one-2019-01-01: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870697_d20240411_m033122_c001_v7007000_t0000_u01712806282171") 2024/04/11 03:33:00 DEBUG : backup/one-2019-01-01: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110e9bb049171c33_d20240411_m033118_c001_v0001172_t0015_u01712806278711") 2024/04/11 03:33:00 DEBUG : backup/one-2019-01-01: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f1113d17e48bb2ed5_d20240411_m033114_c001_v0001181_t0024_u01712806274390") 2024/04/11 03:33:00 DEBUG : backup/one.bak: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a87065a_d20240411_m033109_c001_v7007000_t0000_u01712806269549") 2024/04/11 03:33:00 DEBUG : backup/one.bak: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f105d97954ecc5548_d20240411_m033107_c001_v0001179_t0000_u01712806267695") 2024/04/11 03:33:00 DEBUG : backup/one.bak: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f115fd1cfe689e296_d20240411_m033103_c001_v0001179_t0002_u01712806263742") 2024/04/11 03:33:00 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870698_d20240411_m033122_c001_v7007000_t0000_u01712806282356") 2024/04/11 03:33:00 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f1003bc5eea45c3d0_d20240411_m033121_c001_v0001179_t0055_u01712806281018") 2024/04/11 03:33:00 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f113de8b0526a0450_d20240411_m033116_c001_v0001103_t0003_u01712806276090") 2024/04/11 03:33:01 DEBUG : backup/three.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a8705fc_d20240411_m033057_c001_v7007000_t0000_u01712806257410") 2024/04/11 03:33:01 DEBUG : backup/three.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f10510020c526611c_d20240411_m033056_c001_v0001100_t0010_u01712806256293") 2024/04/11 03:33:01 DEBUG : backup/three.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f118909a039d7063d_d20240411_m033052_c001_v0001179_t0047_u01712806252813") 2024/04/11 03:33:01 DEBUG : backup/three.txt.bak: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a87065b_d20240411_m033109_c001_v7007000_t0000_u01712806269741") 2024/04/11 03:33:01 DEBUG : backup/three.txt.bak: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f10731da59cfa420c_d20240411_m033108_c001_v0001172_t0015_u01712806268604") 2024/04/11 03:33:01 DEBUG : backup/three.txt.bak: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11173de2d9f2558c_d20240411_m033105_c001_v0001179_t0020_u01712806265176") 2024/04/11 03:33:01 DEBUG : both0: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870926_d20240411_m033245_c001_v7007000_t0000_u01712806365322") 2024/04/11 03:33:01 DEBUG : both0: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97d153_d20240411_m033228_c001_v0001181_t0052_u01712806348652") 2024/04/11 03:33:01 DEBUG : both0: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f417075306c2ccd6a_d20240411_m033224_c001_v7007000_t0000_u01712806344010") 2024/04/11 03:33:01 DEBUG : both0: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97cdfc_d20240411_m033206_c001_v0001181_t0027_u01712806326154") 2024/04/11 03:33:01 DEBUG : both1: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a87092a_d20240411_m033245_c001_v7007000_t0000_u01712806365515") 2024/04/11 03:33:01 DEBUG : both1: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97d175_d20240411_m033229_c001_v0001181_t0042_u01712806349619") 2024/04/11 03:33:01 DEBUG : both1: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f417075306c2ccd6e_d20240411_m033224_c001_v7007000_t0000_u01712806344206") 2024/04/11 03:33:01 DEBUG : both1: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97ce20_d20240411_m033206_c001_v0001181_t0035_u01712806326842") 2024/04/11 03:33:01 DEBUG : both10: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a87092f_d20240411_m033245_c001_v7007000_t0000_u01712806365718") 2024/04/11 03:33:01 DEBUG : both10: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97d24c_d20240411_m033235_c001_v0001181_t0053_u01712806355798") 2024/04/11 03:33:02 DEBUG : both10: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f417075306c2ccd71_d20240411_m033224_c001_v7007000_t0000_u01712806344395") 2024/04/11 03:33:02 DEBUG : both10: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97cf14_d20240411_m033213_c001_v0001181_t0011_u01712806333248") 2024/04/11 03:33:02 DEBUG : both11: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870934_d20240411_m033245_c001_v7007000_t0000_u01712806365949") 2024/04/11 03:33:02 DEBUG : both11: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97d277_d20240411_m033236_c001_v0001181_t0010_u01712806356641") 2024/04/11 03:33:02 DEBUG : both11: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f417075306c2ccd74_d20240411_m033224_c001_v7007000_t0000_u01712806344582") 2024/04/11 03:33:02 DEBUG : both11: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97cf32_d20240411_m033213_c001_v0001181_t0002_u01712806333878") 2024/04/11 03:33:02 DEBUG : both12: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870938_d20240411_m033246_c001_v7007000_t0000_u01712806366149") 2024/04/11 03:33:02 DEBUG : both12: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97d28f_d20240411_m033237_c001_v0001181_t0016_u01712806357241") 2024/04/11 03:33:02 DEBUG : both12: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f417075306c2ccd78_d20240411_m033224_c001_v7007000_t0000_u01712806344763") 2024/04/11 03:33:02 DEBUG : both12: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97cf6c_d20240411_m033215_c001_v0001181_t0055_u01712806335228") 2024/04/11 03:33:02 DEBUG : both13: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a87093d_d20240411_m033246_c001_v7007000_t0000_u01712806366339") 2024/04/11 03:33:02 DEBUG : both13: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97d2a6_d20240411_m033237_c001_v0001181_t0014_u01712806357850") 2024/04/11 03:33:02 DEBUG : both13: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f417075306c2ccd7b_d20240411_m033224_c001_v7007000_t0000_u01712806344943") 2024/04/11 03:33:02 DEBUG : both13: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97cfa2_d20240411_m033216_c001_v0001181_t0029_u01712806336497") 2024/04/11 03:33:02 DEBUG : both14: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870940_d20240411_m033246_c001_v7007000_t0000_u01712806366523") 2024/04/11 03:33:02 DEBUG : both14: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97d2ca_d20240411_m033238_c001_v0001181_t0008_u01712806358617") 2024/04/11 03:33:02 DEBUG : both14: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f417075306c2ccd7e_d20240411_m033225_c001_v7007000_t0000_u01712806345125") 2024/04/11 03:33:02 DEBUG : both14: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97cfba_d20240411_m033217_c001_v0001181_t0003_u01712806337217") 2024/04/11 03:33:02 DEBUG : both15: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870945_d20240411_m033246_c001_v7007000_t0000_u01712806366725") 2024/04/11 03:33:03 DEBUG : both15: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97d2e2_d20240411_m033239_c001_v0001181_t0043_u01712806359230") 2024/04/11 03:33:03 DEBUG : both15: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f417075306c2ccd82_d20240411_m033225_c001_v7007000_t0000_u01712806345306") 2024/04/11 03:33:03 DEBUG : both15: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97cfd6_d20240411_m033217_c001_v0001181_t0041_u01712806337872") 2024/04/11 03:33:03 DEBUG : both16: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870949_d20240411_m033246_c001_v7007000_t0000_u01712806366982") 2024/04/11 03:33:03 DEBUG : both16: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97d2fd_d20240411_m033239_c001_v0001181_t0024_u01712806359934") 2024/04/11 03:33:03 DEBUG : both16: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f417075306c2ccd86_d20240411_m033225_c001_v7007000_t0000_u01712806345487") 2024/04/11 03:33:03 DEBUG : both16: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97cffc_d20240411_m033218_c001_v0001181_t0013_u01712806338691") 2024/04/11 03:33:03 DEBUG : both17: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a87094c_d20240411_m033247_c001_v7007000_t0000_u01712806367176") 2024/04/11 03:33:03 DEBUG : both17: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97d312_d20240411_m033240_c001_v0001181_t0000_u01712806360558") 2024/04/11 03:33:03 DEBUG : both17: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f417075306c2ccd89_d20240411_m033225_c001_v7007000_t0000_u01712806345668") 2024/04/11 03:33:03 DEBUG : both17: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97d01c_d20240411_m033219_c001_v0001181_t0058_u01712806339369") 2024/04/11 03:33:03 DEBUG : both18: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870951_d20240411_m033247_c001_v7007000_t0000_u01712806367363") 2024/04/11 03:33:03 DEBUG : both18: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97d326_d20240411_m033241_c001_v0001181_t0015_u01712806361192") 2024/04/11 03:33:03 DEBUG : both18: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f417075306c2ccd8d_d20240411_m033225_c001_v7007000_t0000_u01712806345848") 2024/04/11 03:33:03 DEBUG : both18: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97d03a_d20240411_m033219_c001_v0001181_t0045_u01712806339922") 2024/04/11 03:33:03 DEBUG : both19: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870954_d20240411_m033247_c001_v7007000_t0000_u01712806367548") 2024/04/11 03:33:03 DEBUG : both19: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97d352_d20240411_m033242_c001_v0001181_t0047_u01712806362121") 2024/04/11 03:33:03 DEBUG : both19: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f417075306c2ccd91_d20240411_m033226_c001_v7007000_t0000_u01712806346028") 2024/04/11 03:33:03 DEBUG : both19: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97d04d_d20240411_m033220_c001_v0001181_t0052_u01712806340580") 2024/04/11 03:33:03 DEBUG : both2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a87095a_d20240411_m033247_c001_v7007000_t0000_u01712806367735") 2024/04/11 03:33:04 DEBUG : both2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97d185_d20240411_m033230_c001_v0001181_t0044_u01712806350230") 2024/04/11 03:33:04 DEBUG : both2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f417075306c2ccd94_d20240411_m033226_c001_v7007000_t0000_u01712806346210") 2024/04/11 03:33:04 DEBUG : both2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97ce3e_d20240411_m033207_c001_v0001181_t0034_u01712806327589") 2024/04/11 03:33:04 DEBUG : both3: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a87095b_d20240411_m033247_c001_v7007000_t0000_u01712806367919") 2024/04/11 03:33:04 DEBUG : both3: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97d1a1_d20240411_m033230_c001_v0001181_t0056_u01712806350892") 2024/04/11 03:33:04 DEBUG : both3: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f417075306c2ccd99_d20240411_m033226_c001_v7007000_t0000_u01712806346401") 2024/04/11 03:33:04 DEBUG : both3: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97ce5e_d20240411_m033208_c001_v0001181_t0031_u01712806328302") 2024/04/11 03:33:04 DEBUG : both4: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a87095d_d20240411_m033248_c001_v7007000_t0000_u01712806368105") 2024/04/11 03:33:04 DEBUG : both4: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97d1b7_d20240411_m033231_c001_v0001181_t0005_u01712806351566") 2024/04/11 03:33:04 DEBUG : both4: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f417075306c2ccd9c_d20240411_m033226_c001_v7007000_t0000_u01712806346583") 2024/04/11 03:33:04 DEBUG : both4: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97ce70_d20240411_m033208_c001_v0001181_t0024_u01712806328902") 2024/04/11 03:33:04 DEBUG : both5: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a87095f_d20240411_m033248_c001_v7007000_t0000_u01712806368287") 2024/04/11 03:33:04 DEBUG : both5: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97d1c9_d20240411_m033232_c001_v0001181_t0023_u01712806352312") 2024/04/11 03:33:04 DEBUG : both5: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f417075306c2ccda1_d20240411_m033226_c001_v7007000_t0000_u01712806346764") 2024/04/11 03:33:04 DEBUG : both5: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97ce82_d20240411_m033209_c001_v0001181_t0000_u01712806329473") 2024/04/11 03:33:04 DEBUG : both6: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870960_d20240411_m033248_c001_v7007000_t0000_u01712806368501") 2024/04/11 03:33:04 DEBUG : both6: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97d1d3_d20240411_m033232_c001_v0001181_t0053_u01712806352902") 2024/04/11 03:33:04 DEBUG : both6: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f417075306c2ccda4_d20240411_m033226_c001_v7007000_t0000_u01712806346946") 2024/04/11 03:33:05 DEBUG : both6: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97ce9a_d20240411_m033210_c001_v0001181_t0043_u01712806330212") 2024/04/11 03:33:05 DEBUG : both7: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870962_d20240411_m033248_c001_v7007000_t0000_u01712806368706") 2024/04/11 03:33:05 DEBUG : both7: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97d1f3_d20240411_m033233_c001_v0001181_t0038_u01712806353883") 2024/04/11 03:33:05 DEBUG : both7: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f417075306c2ccda7_d20240411_m033227_c001_v7007000_t0000_u01712806347127") 2024/04/11 03:33:05 DEBUG : both7: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97ceba_d20240411_m033211_c001_v0001181_t0015_u01712806331177") 2024/04/11 03:33:05 DEBUG : both8: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870963_d20240411_m033248_c001_v7007000_t0000_u01712806368892") 2024/04/11 03:33:05 DEBUG : both8: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97d20f_d20240411_m033234_c001_v0001181_t0025_u01712806354658") 2024/04/11 03:33:05 DEBUG : both8: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f417075306c2ccdab_d20240411_m033227_c001_v7007000_t0000_u01712806347331") 2024/04/11 03:33:05 DEBUG : both8: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97cedc_d20240411_m033211_c001_v0001181_t0047_u01712806331973") 2024/04/11 03:33:05 DEBUG : both9: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870965_d20240411_m033249_c001_v7007000_t0000_u01712806369097") 2024/04/11 03:33:05 DEBUG : both9: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97d228_d20240411_m033235_c001_v0001181_t0010_u01712806355218") 2024/04/11 03:33:05 DEBUG : both9: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f417075306c2ccdae_d20240411_m033227_c001_v7007000_t0000_u01712806347518") 2024/04/11 03:33:05 DEBUG : both9: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97cefc_d20240411_m033212_c001_v0001181_t0036_u01712806332599") 2024/04/11 03:33:05 DEBUG : c/non empty space: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd4a18_d20240411_m032837_c001_v7007000_t0000_u01712806117534") 2024/04/11 03:33:05 DEBUG : c/non empty space: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97b013_d20240411_m032835_c001_v0001181_t0002_u01712806115613") 2024/04/11 03:33:05 DEBUG : c/non empty space: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f411b8519caef39da_d20240411_m032834_c001_v7007000_t0000_u01712806114626") 2024/04/11 03:33:05 DEBUG : c/non empty space: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97afb5_d20240411_m032832_c001_v0001181_t0032_u01712806112907") 2024/04/11 03:33:05 DEBUG : c/non empty space: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f4075e69e2954bd6e_d20240411_m032812_c001_v7007000_t0000_u01712806092226") 2024/04/11 03:33:05 DEBUG : c/non empty space: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97ac65_d20240411_m032810_c001_v0001181_t0003_u01712806090319") 2024/04/11 03:33:06 DEBUG : check sum: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f4075e69e2954bd62_d20240411_m032759_c001_v7007000_t0000_u01712806079301") 2024/04/11 03:33:06 DEBUG : check sum: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97aa85_d20240411_m032758_c001_v0001181_t0039_u01712806078321") 2024/04/11 03:33:06 DEBUG : dest/3: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f40566323c6991a49_d20240411_m033030_c001_v7007000_t0000_u01712806230350") 2024/04/11 03:33:06 DEBUG : dest/3: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b001701576627_d20240411_m033029_c001_v0001180_t0041_u01712806229609") 2024/04/11 03:33:06 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a87079e_d20240411_m033155_c001_v7007000_t0000_u01712806315225") 2024/04/11 03:33:06 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f101fd9ac729f5f2f_d20240411_m033152_c001_v0001153_t0012_u01712806312901") 2024/04/11 03:33:06 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a87077e_d20240411_m033152_c001_v7007000_t0000_u01712806312717") 2024/04/11 03:33:06 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f101fd9ac729f5f21_d20240411_m033149_c001_v0001153_t0019_u01712806309442") 2024/04/11 03:33:06 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870746_d20240411_m033148_c001_v7007000_t0000_u01712806308465") 2024/04/11 03:33:06 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfe15_d20240411_m033144_c001_v0001157_t0041_u01712806304726") 2024/04/11 03:33:06 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870723_d20240411_m033143_c001_v7007000_t0000_u01712806303164") 2024/04/11 03:33:06 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f101203622b0781a4_d20240411_m033140_c001_v0001128_t0023_u01712806300651") 2024/04/11 03:33:06 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a87071e_d20240411_m033140_c001_v7007000_t0000_u01712806300464") 2024/04/11 03:33:06 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f101203622b07819a_d20240411_m033137_c001_v0001128_t0049_u01712806297249") 2024/04/11 03:33:06 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870716_d20240411_m033136_c001_v7007000_t0000_u01712806296479") 2024/04/11 03:33:06 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97c92e_d20240411_m033132_c001_v0001181_t0010_u01712806292992") 2024/04/11 03:33:06 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a8706f0_d20240411_m033131_c001_v7007000_t0000_u01712806291647") 2024/04/11 03:33:06 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f101b0017015767e0_d20240411_m033130_c001_v0001180_t0006_u01712806290329") 2024/04/11 03:33:07 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a8706da_d20240411_m033130_c001_v7007000_t0000_u01712806290144") 2024/04/11 03:33:07 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f101b0017015767c2_d20240411_m033127_c001_v0001180_t0016_u01712806287768") 2024/04/11 03:33:07 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a8706ae_d20240411_m033127_c001_v7007000_t0000_u01712806287006") 2024/04/11 03:33:07 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97c7c4_d20240411_m033123_c001_v0001181_t0007_u01712806283683") 2024/04/11 03:33:07 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870699_d20240411_m033122_c001_v7007000_t0000_u01712806282555") 2024/04/11 03:33:07 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f117ea5e390f15448_d20240411_m033119_c001_v0001103_t0047_u01712806279253") 2024/04/11 03:33:07 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870691_d20240411_m033119_c001_v7007000_t0000_u01712806279068") 2024/04/11 03:33:07 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f117ea5e390f15440_d20240411_m033115_c001_v0001103_t0045_u01712806275413") 2024/04/11 03:33:07 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a87068a_d20240411_m033114_c001_v7007000_t0000_u01712806274654") 2024/04/11 03:33:07 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97c5cc_d20240411_m033110_c001_v0001181_t0020_u01712806270902") 2024/04/11 03:33:07 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a87065e_d20240411_m033109_c001_v7007000_t0000_u01712806269934") 2024/04/11 03:33:07 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f10729b583a326c46_d20240411_m033108_c001_v0001179_t0009_u01712806268111") 2024/04/11 03:33:07 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870641_d20240411_m033107_c001_v7007000_t0000_u01712806267923") 2024/04/11 03:33:07 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f10729b583a326bd4_d20240411_m033104_c001_v0001179_t0046_u01712806264712") 2024/04/11 03:33:08 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a87060c_d20240411_m033103_c001_v7007000_t0000_u01712806263949") 2024/04/11 03:33:08 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97c3e8_d20240411_m033058_c001_v0001181_t0027_u01712806258535") 2024/04/11 03:33:08 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a8705fd_d20240411_m033057_c001_v7007000_t0000_u01712806257602") 2024/04/11 03:33:08 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f10021874a4516610_d20240411_m033055_c001_v0001161_t0055_u01712806255664") 2024/04/11 03:33:08 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a8705e2_d20240411_m033055_c001_v7007000_t0000_u01712806255472") 2024/04/11 03:33:08 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f10021874a45165fa_d20240411_m033052_c001_v0001161_t0023_u01712806252263") 2024/04/11 03:33:08 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870585_d20240411_m033051_c001_v7007000_t0000_u01712806251508") 2024/04/11 03:33:08 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97c245_d20240411_m033047_c001_v0001181_t0041_u01712806247384") 2024/04/11 03:33:08 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870519_d20240411_m033045_c001_v7007000_t0000_u01712806245849") 2024/04/11 03:33:08 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f105d97954ecc4f2f_d20240411_m033039_c001_v0001179_t0002_u01712806239550") 2024/04/11 03:33:08 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870506_d20240411_m033039_c001_v7007000_t0000_u01712806239277") 2024/04/11 03:33:08 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97c078_d20240411_m033035_c001_v0001181_t0048_u01712806235375") 2024/04/11 03:33:08 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f10310f59825e9712_d20240411_m033034_c001_v0001181_t0024_u01712806234130") 2024/04/11 03:33:08 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f10310f59825e96f4_d20240411_m033033_c001_v0001181_t0058_u01712806233054") 2024/04/11 03:33:08 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f40566323c6991a34_d20240411_m033023_c001_v7007000_t0000_u01712806223752") 2024/04/11 03:33:08 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfb6e_d20240411_m033016_c001_v0001157_t0016_u01712806216532") 2024/04/11 03:33:08 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f101d41fd7e897a3f_d20240411_m033014_c001_v0001103_t0056_u01712806214761") 2024/04/11 03:33:08 DEBUG : dst/one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f101d41fd7e897a39_d20240411_m033012_c001_v0001103_t0033_u01712806212847") 2024/04/11 03:33:08 DEBUG : dst/one-2019-01-01: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a8707a1_d20240411_m033155_c001_v7007000_t0000_u01712806315411") 2024/04/11 03:33:08 DEBUG : dst/one-2019-01-01: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f1087cdc969c42b2c_d20240411_m033152_c001_v0001040_t0048_u01712806312104") 2024/04/11 03:33:09 DEBUG : dst/one-2019-01-01: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f1188fc36e073cb31_d20240411_m033148_c001_v0001181_t0008_u01712806308215") 2024/04/11 03:33:09 DEBUG : dst/one.bak: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870724_d20240411_m033143_c001_v7007000_t0000_u01712806303354") 2024/04/11 03:33:09 DEBUG : dst/one.bak: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f102f7ab4ede31483_d20240411_m033139_c001_v0001026_t0026_u01712806299935") 2024/04/11 03:33:09 DEBUG : dst/one.bak: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f107a50bc4b150b75_d20240411_m033136_c001_v0001165_t0016_u01712806296267") 2024/04/11 03:33:09 DEBUG : dst/one.bak: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a8706f3_d20240411_m033131_c001_v7007000_t0000_u01712806291851") 2024/04/11 03:33:09 DEBUG : dst/one.bak: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f104c994fc54786a7_d20240411_m033129_c001_v0001179_t0024_u01712806289839") 2024/04/11 03:33:09 DEBUG : dst/one.bak: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f116138a57bb28c5d_d20240411_m033126_c001_v0001161_t0037_u01712806286491") 2024/04/11 03:33:09 DEBUG : dst/three: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a87051d_d20240411_m033046_c001_v7007000_t0000_u01712806246454") 2024/04/11 03:33:09 DEBUG : dst/three: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f10310f59825e9896_d20240411_m033044_c001_v0001181_t0020_u01712806244436") 2024/04/11 03:33:09 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a8707a4_d20240411_m033155_c001_v7007000_t0000_u01712806315595") 2024/04/11 03:33:09 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f113d8b0d18265b27_d20240411_m033153_c001_v0001180_t0023_u01712806313832") 2024/04/11 03:33:09 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f112bf3c0cbab2288_d20240411_m033150_c001_v0001026_t0023_u01712806310370") 2024/04/11 03:33:09 DEBUG : dst/three.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a8707a6_d20240411_m033155_c001_v7007000_t0000_u01712806315780") 2024/04/11 03:33:09 DEBUG : dst/three.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f101fd9ac729f5f33_d20240411_m033154_c001_v0001153_t0003_u01712806314470") 2024/04/11 03:33:09 DEBUG : dst/three.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870792_d20240411_m033154_c001_v7007000_t0000_u01712806314286") 2024/04/11 03:33:09 DEBUG : dst/three.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f101fd9ac729f5f2b_d20240411_m033151_c001_v0001153_t0025_u01712806311082") 2024/04/11 03:33:09 DEBUG : dst/three.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870766_d20240411_m033150_c001_v7007000_t0000_u01712806310896") 2024/04/11 03:33:10 DEBUG : dst/three.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfe1b_d20240411_m033145_c001_v0001157_t0054_u01712806305763") 2024/04/11 03:33:10 DEBUG : dst/three.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870725_d20240411_m033143_c001_v7007000_t0000_u01712806303547") 2024/04/11 03:33:10 DEBUG : dst/three.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f101203622b0781a8_d20240411_m033142_c001_v0001128_t0005_u01712806302220") 2024/04/11 03:33:10 DEBUG : dst/three.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870720_d20240411_m033142_c001_v7007000_t0000_u01712806302032") 2024/04/11 03:33:10 DEBUG : dst/three.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f101203622b07819c_d20240411_m033138_c001_v0001128_t0028_u01712806298736") 2024/04/11 03:33:10 DEBUG : dst/three.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870719_d20240411_m033138_c001_v7007000_t0000_u01712806298549") 2024/04/11 03:33:10 DEBUG : dst/three.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97c956_d20240411_m033133_c001_v0001181_t0004_u01712806293840") 2024/04/11 03:33:10 DEBUG : dst/three.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a8706e7_d20240411_m033131_c001_v7007000_t0000_u01712806291045") 2024/04/11 03:33:10 DEBUG : dst/three.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfdab_d20240411_m033128_c001_v0001157_t0004_u01712806288898") 2024/04/11 03:33:10 DEBUG : dst/three.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a8706c4_d20240411_m033128_c001_v7007000_t0000_u01712806288523") 2024/04/11 03:33:10 DEBUG : dst/three.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97c7dc_d20240411_m033124_c001_v0001181_t0029_u01712806284604") 2024/04/11 03:33:10 DEBUG : dst/three.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870694_d20240411_m033121_c001_v7007000_t0000_u01712806281581") 2024/04/11 03:33:10 DEBUG : dst/three.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfd38_d20240411_m033117_c001_v0001157_t0005_u01712806277212") 2024/04/11 03:33:10 DEBUG : dst/three.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a87068c_d20240411_m033116_c001_v7007000_t0000_u01712806276466") 2024/04/11 03:33:10 DEBUG : dst/three.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97c5ea_d20240411_m033111_c001_v0001181_t0058_u01712806271641") 2024/04/11 03:33:10 DEBUG : dst/three.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870652_d20240411_m033108_c001_v7007000_t0000_u01712806268932") 2024/04/11 03:33:10 DEBUG : dst/three.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfce6_d20240411_m033106_c001_v0001157_t0054_u01712806266398") 2024/04/11 03:33:10 DEBUG : dst/three.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870624_d20240411_m033105_c001_v7007000_t0000_u01712806265666") 2024/04/11 03:33:10 DEBUG : dst/three.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97c422_d20240411_m033059_c001_v0001181_t0020_u01712806259484") 2024/04/11 03:33:10 DEBUG : dst/three.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a8705f1_d20240411_m033056_c001_v7007000_t0000_u01712806256634") 2024/04/11 03:33:11 DEBUG : dst/three.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfc88_d20240411_m033053_c001_v0001157_t0028_u01712806253822") 2024/04/11 03:33:11 DEBUG : dst/three.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a8705ac_d20240411_m033053_c001_v7007000_t0000_u01712806253088") 2024/04/11 03:33:11 DEBUG : dst/three.txt: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97c26c_d20240411_m033048_c001_v0001181_t0023_u01712806248085") 2024/04/11 03:33:11 DEBUG : dst/three.txt.bak: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870726_d20240411_m033143_c001_v7007000_t0000_u01712806303749") 2024/04/11 03:33:11 DEBUG : dst/three.txt.bak: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f119b20bd6e3104bf_d20240411_m033141_c001_v0001180_t0020_u01712806301791") 2024/04/11 03:33:11 DEBUG : dst/three.txt.bak: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11039af5c599605b_d20240411_m033138_c001_v0001181_t0039_u01712806298209") 2024/04/11 03:33:11 DEBUG : dst/three.txt.bak: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a8706f7_d20240411_m033132_c001_v7007000_t0000_u01712806292043") 2024/04/11 03:33:11 DEBUG : dst/three.txt.bak: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f115f888c14b7b200_d20240411_m033130_c001_v0001178_t0058_u01712806290793") 2024/04/11 03:33:11 DEBUG : dst/three.txt.bak: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f116d1ff977e0cf38_d20240411_m033128_c001_v0001172_t0042_u01712806288238") 2024/04/11 03:33:11 DEBUG : dst/two: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a8707a7_d20240411_m033155_c001_v7007000_t0000_u01712806315975") 2024/04/11 03:33:11 DEBUG : dst/two: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97cb0c_d20240411_m033145_c001_v0001181_t0056_u01712806305525") 2024/04/11 03:33:11 DEBUG : dst/two: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870727_d20240411_m033143_c001_v7007000_t0000_u01712806303961") 2024/04/11 03:33:11 DEBUG : dst/two: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfdc9_d20240411_m033133_c001_v0001157_t0013_u01712806293537") 2024/04/11 03:33:11 DEBUG : dst/two: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a8706fa_d20240411_m033132_c001_v7007000_t0000_u01712806292228") 2024/04/11 03:33:11 DEBUG : dst/two: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfd83_d20240411_m033124_c001_v0001157_t0006_u01712806284268") 2024/04/11 03:33:11 DEBUG : dst/two: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a87069a_d20240411_m033122_c001_v7007000_t0000_u01712806282792") 2024/04/11 03:33:11 DEBUG : dst/two: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfd0e_d20240411_m033111_c001_v0001157_t0016_u01712806271140") 2024/04/11 03:33:11 DEBUG : dst/two: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870661_d20240411_m033110_c001_v7007000_t0000_u01712806270145") 2024/04/11 03:33:11 DEBUG : dst/two: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfcb4_d20240411_m033058_c001_v0001157_t0021_u01712806258985") 2024/04/11 03:33:12 DEBUG : dst/two: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a8705fe_d20240411_m033057_c001_v7007000_t0000_u01712806257786") 2024/04/11 03:33:12 DEBUG : dst/two: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfc6a_d20240411_m033047_c001_v0001157_t0000_u01712806247630") 2024/04/11 03:33:12 DEBUG : dst/two: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870521_d20240411_m033046_c001_v7007000_t0000_u01712806246637") 2024/04/11 03:33:12 DEBUG : dst/two: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f100c077ec90a3c9c_d20240411_m033041_c001_v0001134_t0049_u01712806241041") 2024/04/11 03:33:12 DEBUG : dst/two: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f40566323c6991a39_d20240411_m033023_c001_v7007000_t0000_u01712806223932") 2024/04/11 03:33:12 DEBUG : dst/two: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f101d41fd7e897a49_d20240411_m033022_c001_v0001103_t0053_u01712806222518") 2024/04/11 03:33:12 DEBUG : empty space: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f40739ad12d213569_d20240411_m032945_c001_v7007000_t0000_u01712806185392") 2024/04/11 03:33:12 DEBUG : empty space: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfa85_d20240411_m032941_c001_v0001157_t0012_u01712806181522") 2024/04/11 03:33:12 DEBUG : empty space: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f40739ad12d213553_d20240411_m032939_c001_v7007000_t0000_u01712806179529") 2024/04/11 03:33:12 DEBUG : empty space: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97b773_d20240411_m032929_c001_v0001181_t0017_u01712806169799") 2024/04/11 03:33:12 DEBUG : empty space: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f4007893bcb4b066f_d20240411_m032922_c001_v7007000_t0000_u01712806162260") 2024/04/11 03:33:12 DEBUG : empty space: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddf9fb_d20240411_m032918_c001_v0001157_t0033_u01712806158102") 2024/04/11 03:33:12 DEBUG : empty space: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd4a78_d20240411_m032850_c001_v7007000_t0000_u01712806130941") 2024/04/11 03:33:12 DEBUG : empty space: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97b1ec_d20240411_m032849_c001_v0001181_t0044_u01712806129014") 2024/04/11 03:33:12 DEBUG : empty space: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd4a44_d20240411_m032847_c001_v7007000_t0000_u01712806127490") 2024/04/11 03:33:12 DEBUG : empty space: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97b182_d20240411_m032846_c001_v0001181_t0022_u01712806126296") 2024/04/11 03:33:12 DEBUG : empty space: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd4a35_d20240411_m032842_c001_v7007000_t0000_u01712806122858") 2024/04/11 03:33:12 DEBUG : empty space: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97b0d4_d20240411_m032841_c001_v0001181_t0028_u01712806121105") 2024/04/11 03:33:12 DEBUG : empty space: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd4a2f_d20240411_m032839_c001_v7007000_t0000_u01712806119853") 2024/04/11 03:33:13 DEBUG : empty space: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97b08a_d20240411_m032838_c001_v0001181_t0025_u01712806118506") 2024/04/11 03:33:13 DEBUG : empty space: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f411b8519caef39d4_d20240411_m032831_c001_v7007000_t0000_u01712806111292") 2024/04/11 03:33:13 DEBUG : empty space: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97af4d_d20240411_m032829_c001_v0001181_t0033_u01712806109625") 2024/04/11 03:33:13 DEBUG : empty space: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f411b8519caef39d1_d20240411_m032828_c001_v7007000_t0000_u01712806108376") 2024/04/11 03:33:13 DEBUG : empty space: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97af01_d20240411_m032827_c001_v0001181_t0017_u01712806107460") 2024/04/11 03:33:13 DEBUG : empty space: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f411b8519caef39cb_d20240411_m032821_c001_v7007000_t0000_u01712806101935") 2024/04/11 03:33:13 DEBUG : empty space: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97ade3_d20240411_m032820_c001_v0001181_t0019_u01712806100523") 2024/04/11 03:33:13 DEBUG : empty space: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f411b8519caef39c6_d20240411_m032817_c001_v7007000_t0000_u01712806097924") 2024/04/11 03:33:13 DEBUG : empty space: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97ad55_d20240411_m032816_c001_v0001181_t0047_u01712806096846") 2024/04/11 03:33:13 DEBUG : empty space: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f4075e69e2954bd70_d20240411_m032815_c001_v7007000_t0000_u01712806095758") 2024/04/11 03:33:13 DEBUG : empty space: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f108416062924ca0b_d20240411_m032814_c001_v0001042_t0004_u01712806094747") 2024/04/11 03:33:13 DEBUG : empty space: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97acc5_d20240411_m032812_c001_v0001181_t0052_u01712806092957") 2024/04/11 03:33:13 DEBUG : enormous: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd4a68_d20240411_m032849_c001_v7007000_t0000_u01712806129986") 2024/04/11 03:33:13 DEBUG : enormous: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97b1f6_d20240411_m032849_c001_v0001181_t0029_u01712806129270") 2024/04/11 03:33:13 DEBUG : existing: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a8707af_d20240411_m033201_c001_v7007000_t0000_u01712806321032") 2024/04/11 03:33:13 DEBUG : existing: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97cd1c_d20240411_m033159_c001_v0001181_t0052_u01712806319754") 2024/04/11 03:33:14 DEBUG : existing: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f40281caa55f49815_d20240411_m032916_c001_v7007000_t0000_u01712806156355") 2024/04/11 03:33:14 DEBUG : existing: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97b54f_d20240411_m032914_c001_v0001181_t0005_u01712806154887") 2024/04/11 03:33:14 DEBUG : existing: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f4075e69e2954bd6a_d20240411_m032808_c001_v7007000_t0000_u01712806088966") 2024/04/11 03:33:14 DEBUG : existing: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97abfd_d20240411_m032807_c001_v0001181_t0042_u01712806087944") 2024/04/11 03:33:14 DEBUG : existing: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f4075e69e2954bd67_d20240411_m032806_c001_v7007000_t0000_u01712806086655") 2024/04/11 03:33:14 DEBUG : existing: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97abbf_d20240411_m032805_c001_v0001181_t0013_u01712806085971") 2024/04/11 03:33:14 DEBUG : existing: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97ab8f_d20240411_m032804_c001_v0001181_t0000_u01712806084965") 2024/04/11 03:33:14 DEBUG : existing-b: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f40281caa55f49816_d20240411_m032916_c001_v7007000_t0000_u01712806156537") 2024/04/11 03:33:14 DEBUG : existing-b: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddf9e1_d20240411_m032914_c001_v0001157_t0059_u01712806154894") 2024/04/11 03:33:14 DEBUG : five: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd4ab2_d20240411_m032855_c001_v7007000_t0000_u01712806135404") 2024/04/11 03:33:14 DEBUG : five: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41980228ba97b28a_d20240411_m032853_c001_v0001181_t0058_u01712806133344") 2024/04/11 03:33:14 DEBUG : foo: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f411b8519caef39c8_d20240411_m032819_c001_v7007000_t0000_u01712806099780") 2024/04/11 03:33:14 DEBUG : foo: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41980228ba97adbb_d20240411_m032819_c001_v0001181_t0058_u01712806099230") 2024/04/11 03:33:14 DEBUG : foo: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41980228ba97ad9f_d20240411_m032818_c001_v0001181_t0058_u01712806098674") 2024/04/11 03:33:14 DEBUG : four: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd4ab4_d20240411_m032855_c001_v7007000_t0000_u01712806135630") 2024/04/11 03:33:14 DEBUG : four: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f410b800164ddf981_d20240411_m032854_c001_v0001157_t0041_u01712806134101") 2024/04/11 03:33:14 DEBUG : four: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97b274_d20240411_m032852_c001_v0001181_t0038_u01712806132689") 2024/04/11 03:33:14 DEBUG : hello world2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd465e_d20240411_m032739_c001_v7007000_t0000_u01712806059091") 2024/04/11 03:33:14 DEBUG : hello world2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97a78b_d20240411_m032737_c001_v0001181_t0013_u01712806057889") 2024/04/11 03:33:15 DEBUG : ignore-size: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f4075e69e2954bd65_d20240411_m032803_c001_v7007000_t0000_u01712806083854") 2024/04/11 03:33:15 DEBUG : ignore-size: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97ab23_d20240411_m032802_c001_v0001181_t0008_u01712806082823") 2024/04/11 03:33:15 DEBUG : nested/sub dir/file: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f40281caa55f49813_d20240411_m032913_c001_v7007000_t0000_u01712806153757") 2024/04/11 03:33:15 DEBUG : nested/sub dir/file: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddf9d7_d20240411_m032912_c001_v0001157_t0019_u01712806152848") 2024/04/11 03:33:15 DEBUG : nested/sub dir/file: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f40281caa55f49811_d20240411_m032911_c001_v7007000_t0000_u01712806151725") 2024/04/11 03:33:15 DEBUG : nested/sub dir/file: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97b4b1_d20240411_m032910_c001_v0001181_t0010_u01712806150760") 2024/04/11 03:33:15 DEBUG : one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd4ab7_d20240411_m032855_c001_v7007000_t0000_u01712806135813") 2024/04/11 03:33:15 DEBUG : one: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41980228ba97b25c_d20240411_m032852_c001_v0001181_t0058_u01712806132060") 2024/04/11 03:33:15 DEBUG : only0: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870967_d20240411_m033249_c001_v7007000_t0000_u01712806369286") 2024/04/11 03:33:15 DEBUG : only0: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41980228ba97d38c_d20240411_m033243_c001_v0001181_t0058_u01712806363283") 2024/04/11 03:33:15 DEBUG : only0: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddff71_d20240411_m033229_c001_v0001157_t0001_u01712806349250") 2024/04/11 03:33:15 DEBUG : only0: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f417075306c2ccd5e_d20240411_m033223_c001_v7007000_t0000_u01712806343199") 2024/04/11 03:33:15 DEBUG : only0: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfea7_d20240411_m033206_c001_v0001157_t0012_u01712806326430") 2024/04/11 03:33:15 DEBUG : only1: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a87096a_d20240411_m033249_c001_v7007000_t0000_u01712806369492") 2024/04/11 03:33:15 DEBUG : only1: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f410b800164ddffe4_d20240411_m033243_c001_v0001157_t0041_u01712806363293") 2024/04/11 03:33:15 DEBUG : only1: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddff77_d20240411_m033229_c001_v0001157_t0016_u01712806349860") 2024/04/11 03:33:16 DEBUG : only1: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41824713bddfb93f_d20240411_m033222_c001_v7007000_t0000_u01712806342628") 2024/04/11 03:33:16 DEBUG : only1: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfeaf_d20240411_m033207_c001_v0001157_t0054_u01712806327117") 2024/04/11 03:33:16 DEBUG : only10: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a87096c_d20240411_m033249_c001_v7007000_t0000_u01712806369681") 2024/04/11 03:33:16 DEBUG : only10: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f40310f59825ea969_d20240411_m033243_c001_v0001181_t0051_u01712806363853") 2024/04/11 03:33:16 DEBUG : only10: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddffac_d20240411_m033236_c001_v0001157_t0011_u01712806356016") 2024/04/11 03:33:16 DEBUG : only10: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41824713bddfb942_d20240411_m033222_c001_v7007000_t0000_u01712806342843") 2024/04/11 03:33:16 DEBUG : only10: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfeeb_d20240411_m033213_c001_v0001157_t0028_u01712806333551") 2024/04/11 03:33:16 DEBUG : only11: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a87096d_d20240411_m033249_c001_v7007000_t0000_u01712806369899") 2024/04/11 03:33:16 DEBUG : only11: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f40363234e295cf96_d20240411_m033244_c001_v0001154_t0012_u01712806364068") 2024/04/11 03:33:16 DEBUG : only11: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddffb2_d20240411_m033236_c001_v0001157_t0000_u01712806356860") 2024/04/11 03:33:16 DEBUG : only11: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41824713bddfb945_d20240411_m033223_c001_v7007000_t0000_u01712806343211") 2024/04/11 03:33:16 DEBUG : only11: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfef6_d20240411_m033214_c001_v0001157_t0022_u01712806334298") 2024/04/11 03:33:16 DEBUG : only12: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a87096f_d20240411_m033250_c001_v7007000_t0000_u01712806370083") 2024/04/11 03:33:16 DEBUG : only12: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41980228ba97d39c_d20240411_m033243_c001_v0001181_t0058_u01712806363688") 2024/04/11 03:33:16 DEBUG : only12: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddffba_d20240411_m033237_c001_v0001157_t0045_u01712806357538") 2024/04/11 03:33:16 DEBUG : only12: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41824713bddfb940_d20240411_m033222_c001_v7007000_t0000_u01712806342642") 2024/04/11 03:33:16 DEBUG : only12: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddff05_d20240411_m033215_c001_v0001157_t0004_u01712806335478") 2024/04/11 03:33:16 DEBUG : only13: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870970_d20240411_m033250_c001_v7007000_t0000_u01712806370264") 2024/04/11 03:33:16 DEBUG : only13: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f410b800164ddfff2_d20240411_m033243_c001_v0001157_t0041_u01712806363698") 2024/04/11 03:33:16 DEBUG : only13: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddffc4_d20240411_m033238_c001_v0001157_t0017_u01712806358131") 2024/04/11 03:33:17 DEBUG : only13: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f417075306c2ccd5b_d20240411_m033222_c001_v7007000_t0000_u01712806342977") 2024/04/11 03:33:17 DEBUG : only13: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddff0d_d20240411_m033216_c001_v0001157_t0033_u01712806336744") 2024/04/11 03:33:17 DEBUG : only14: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870972_d20240411_m033250_c001_v7007000_t0000_u01712806370507") 2024/04/11 03:33:17 DEBUG : only14: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41980228ba97d3a2_d20240411_m033243_c001_v0001181_t0058_u01712806363870") 2024/04/11 03:33:17 DEBUG : only14: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddffc8_d20240411_m033238_c001_v0001157_t0019_u01712806358915") 2024/04/11 03:33:17 DEBUG : only14: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f417075306c2ccd5f_d20240411_m033223_c001_v7007000_t0000_u01712806343342") 2024/04/11 03:33:17 DEBUG : only14: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddff19_d20240411_m033217_c001_v0001157_t0036_u01712806337470") 2024/04/11 03:33:17 DEBUG : only15: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870976_d20240411_m033250_c001_v7007000_t0000_u01712806370693") 2024/04/11 03:33:17 DEBUG : only15: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f410b800164ddfffa_d20240411_m033243_c001_v0001157_t0041_u01712806363881") 2024/04/11 03:33:17 DEBUG : only15: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddffca_d20240411_m033239_c001_v0001157_t0038_u01712806359455") 2024/04/11 03:33:17 DEBUG : only15: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f417075306c2ccd54_d20240411_m033222_c001_v7007000_t0000_u01712806342243") 2024/04/11 03:33:17 DEBUG : only15: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddff21_d20240411_m033218_c001_v0001157_t0007_u01712806338141") 2024/04/11 03:33:17 DEBUG : only16: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870977_d20240411_m033250_c001_v7007000_t0000_u01712806370874") 2024/04/11 03:33:17 DEBUG : only16: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f40310f59825ea973_d20240411_m033244_c001_v0001181_t0051_u01712806364035") 2024/04/11 03:33:17 DEBUG : only16: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddffd4_d20240411_m033240_c001_v0001157_t0041_u01712806360205") 2024/04/11 03:33:17 DEBUG : only16: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f417075306c2ccd5c_d20240411_m033223_c001_v7007000_t0000_u01712806343015") 2024/04/11 03:33:17 DEBUG : only16: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddff25_d20240411_m033219_c001_v0001157_t0039_u01712806339036") 2024/04/11 03:33:17 DEBUG : only17: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870979_d20240411_m033251_c001_v7007000_t0000_u01712806371067") 2024/04/11 03:33:17 DEBUG : only17: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41980228ba97d3ab_d20240411_m033244_c001_v0001181_t0058_u01712806364051") 2024/04/11 03:33:17 DEBUG : only17: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddffd6_d20240411_m033240_c001_v0001157_t0044_u01712806360777") 2024/04/11 03:33:18 DEBUG : only17: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f417075306c2ccd59_d20240411_m033222_c001_v7007000_t0000_u01712806342795") 2024/04/11 03:33:18 DEBUG : only17: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddff2d_d20240411_m033219_c001_v0001157_t0016_u01712806339599") 2024/04/11 03:33:18 DEBUG : only18: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a87097a_d20240411_m033251_c001_v7007000_t0000_u01712806371257") 2024/04/11 03:33:18 DEBUG : only18: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f410b800164ddfffc_d20240411_m033244_c001_v0001157_t0041_u01712806364063") 2024/04/11 03:33:18 DEBUG : only18: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddffda_d20240411_m033241_c001_v0001157_t0035_u01712806361465") 2024/04/11 03:33:18 DEBUG : only18: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f417075306c2ccd55_d20240411_m033222_c001_v7007000_t0000_u01712806342424") 2024/04/11 03:33:18 DEBUG : only18: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddff35_d20240411_m033220_c001_v0001157_t0021_u01712806340187") 2024/04/11 03:33:18 DEBUG : only19: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a87097c_d20240411_m033251_c001_v7007000_t0000_u01712806371440") 2024/04/11 03:33:18 DEBUG : only19: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f40310f59825ea97a_d20240411_m033244_c001_v0001181_t0051_u01712806364214") 2024/04/11 03:33:18 DEBUG : only19: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddffe0_d20240411_m033242_c001_v0001157_t0012_u01712806362366") 2024/04/11 03:33:18 DEBUG : only19: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41824713bddfb943_d20240411_m033223_c001_v7007000_t0000_u01712806343023") 2024/04/11 03:33:18 DEBUG : only19: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddff37_d20240411_m033220_c001_v0001157_t0025_u01712806340825") 2024/04/11 03:33:18 DEBUG : only2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a87097d_d20240411_m033251_c001_v7007000_t0000_u01712806371625") 2024/04/11 03:33:18 DEBUG : only2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41980228ba97d3b0_d20240411_m033244_c001_v0001181_t0058_u01712806364251") 2024/04/11 03:33:18 DEBUG : only2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddff7b_d20240411_m033230_c001_v0001157_t0014_u01712806350481") 2024/04/11 03:33:18 DEBUG : only2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f417075306c2ccd56_d20240411_m033222_c001_v7007000_t0000_u01712806342609") 2024/04/11 03:33:18 DEBUG : only2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfebb_d20240411_m033207_c001_v0001157_t0049_u01712806327898") 2024/04/11 03:33:19 DEBUG : only3: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a87097f_d20240411_m033251_c001_v7007000_t0000_u01712806371808") 2024/04/11 03:33:19 DEBUG : only3: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f410b800164de0000_d20240411_m033244_c001_v0001157_t0041_u01712806364250") 2024/04/11 03:33:19 DEBUG : only3: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddff85_d20240411_m033231_c001_v0001157_t0009_u01712806351142") 2024/04/11 03:33:19 DEBUG : only3: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f417075306c2ccd61_d20240411_m033223_c001_v7007000_t0000_u01712806343383") 2024/04/11 03:33:19 DEBUG : only3: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfebf_d20240411_m033208_c001_v0001157_t0019_u01712806328547") 2024/04/11 03:33:19 DEBUG : only4: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870980_d20240411_m033252_c001_v7007000_t0000_u01712806372029") 2024/04/11 03:33:19 DEBUG : only4: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f40363234e295cf98_d20240411_m033244_c001_v0001154_t0012_u01712806364256") 2024/04/11 03:33:19 DEBUG : only4: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddff89_d20240411_m033231_c001_v0001157_t0051_u01712806351907") 2024/04/11 03:33:19 DEBUG : only4: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41824713bddfb946_d20240411_m033223_c001_v7007000_t0000_u01712806343221") 2024/04/11 03:33:19 DEBUG : only4: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfec5_d20240411_m033209_c001_v0001157_t0025_u01712806329141") 2024/04/11 03:33:19 DEBUG : only5: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870982_d20240411_m033252_c001_v7007000_t0000_u01712806372225") 2024/04/11 03:33:19 DEBUG : only5: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f40310f59825ea989_d20240411_m033244_c001_v0001181_t0051_u01712806364394") 2024/04/11 03:33:19 DEBUG : only5: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddff91_d20240411_m033232_c001_v0001157_t0038_u01712806352554") 2024/04/11 03:33:19 DEBUG : only5: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41824713bddfb941_d20240411_m033222_c001_v7007000_t0000_u01712806342822") 2024/04/11 03:33:19 DEBUG : only5: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfec9_d20240411_m033209_c001_v0001157_t0004_u01712806329777") 2024/04/11 03:33:19 DEBUG : only6: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870983_d20240411_m033252_c001_v7007000_t0000_u01712806372426") 2024/04/11 03:33:19 DEBUG : only6: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41980228ba97d3b2_d20240411_m033244_c001_v0001181_t0058_u01712806364432") 2024/04/11 03:33:19 DEBUG : only6: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddff95_d20240411_m033233_c001_v0001157_t0055_u01712806353251") 2024/04/11 03:33:19 DEBUG : only6: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41824713bddfb944_d20240411_m033223_c001_v7007000_t0000_u01712806343033") 2024/04/11 03:33:20 DEBUG : only6: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfed7_d20240411_m033210_c001_v0001157_t0008_u01712806330569") 2024/04/11 03:33:20 DEBUG : only7: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870986_d20240411_m033252_c001_v7007000_t0000_u01712806372612") 2024/04/11 03:33:20 DEBUG : only7: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f410b800164de0004_d20240411_m033244_c001_v0001157_t0041_u01712806364443") 2024/04/11 03:33:20 DEBUG : only7: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddff9b_d20240411_m033234_c001_v0001157_t0044_u01712806354171") 2024/04/11 03:33:20 DEBUG : only7: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f417075306c2ccd5a_d20240411_m033222_c001_v7007000_t0000_u01712806342832") 2024/04/11 03:33:20 DEBUG : only7: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfedf_d20240411_m033211_c001_v0001157_t0044_u01712806331558") 2024/04/11 03:33:20 DEBUG : only8: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870988_d20240411_m033252_c001_v7007000_t0000_u01712806372811") 2024/04/11 03:33:20 DEBUG : only8: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f40363234e295cf9a_d20240411_m033244_c001_v0001154_t0012_u01712806364452") 2024/04/11 03:33:20 DEBUG : only8: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddffa1_d20240411_m033234_c001_v0001157_t0044_u01712806354922") 2024/04/11 03:33:20 DEBUG : only8: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f417075306c2ccd57_d20240411_m033222_c001_v7007000_t0000_u01712806342636") 2024/04/11 03:33:20 DEBUG : only8: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfee1_d20240411_m033212_c001_v0001157_t0004_u01712806332203") 2024/04/11 03:33:20 DEBUG : only9: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870989_d20240411_m033252_c001_v7007000_t0000_u01712806372997") 2024/04/11 03:33:20 DEBUG : only9: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f40310f59825ea991_d20240411_m033244_c001_v0001181_t0051_u01712806364604") 2024/04/11 03:33:20 DEBUG : only9: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddffa7_d20240411_m033235_c001_v0001157_t0043_u01712806355441") 2024/04/11 03:33:20 DEBUG : only9: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f417075306c2ccd5d_d20240411_m033223_c001_v7007000_t0000_u01712806343158") 2024/04/11 03:33:20 DEBUG : only9: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfee7_d20240411_m033212_c001_v0001157_t0050_u01712806332884") 2024/04/11 03:33:20 DEBUG : potato: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f40281caa55f4980e_d20240411_m032908_c001_v7007000_t0000_u01712806148839") 2024/04/11 03:33:21 DEBUG : potato: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddf9bd_d20240411_m032906_c001_v0001157_t0028_u01712806146398") 2024/04/11 03:33:21 DEBUG : potato: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd4be6_d20240411_m032904_c001_v7007000_t0000_u01712806144133") 2024/04/11 03:33:21 DEBUG : potato: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97b383_d20240411_m032901_c001_v0001181_t0046_u01712806141128") 2024/04/11 03:33:21 DEBUG : potato: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd4ae3_d20240411_m032859_c001_v7007000_t0000_u01712806139242") 2024/04/11 03:33:21 DEBUG : potato: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f1079e73c67ecd1eb_d20240411_m032856_c001_v0001181_t0021_u01712806136747") 2024/04/11 03:33:21 DEBUG : potato: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd4a3f_d20240411_m032845_c001_v7007000_t0000_u01712806125156") 2024/04/11 03:33:21 DEBUG : potato: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97b126_d20240411_m032843_c001_v0001181_t0048_u01712806123814") 2024/04/11 03:33:21 DEBUG : potato: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd4a33_d20240411_m032841_c001_v7007000_t0000_u01712806121773") 2024/04/11 03:33:21 DEBUG : potato: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97b0ca_d20240411_m032840_c001_v0001181_t0038_u01712806120774") 2024/04/11 03:33:21 DEBUG : potato: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd4a2d_d20240411_m032839_c001_v7007000_t0000_u01712806119243") 2024/04/11 03:33:21 DEBUG : potato: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97b07e_d20240411_m032838_c001_v0001181_t0020_u01712806118265") 2024/04/11 03:33:21 DEBUG : potato: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f411b8519caef39d3_d20240411_m032830_c001_v7007000_t0000_u01712806110698") 2024/04/11 03:33:21 DEBUG : potato: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97af45_d20240411_m032829_c001_v0001181_t0057_u01712806109292") 2024/04/11 03:33:21 DEBUG : potato: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f411b8519caef39d2_d20240411_m032828_c001_v7007000_t0000_u01712806108560") 2024/04/11 03:33:21 DEBUG : potato: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97aef3_d20240411_m032827_c001_v0001181_t0057_u01712806107096") 2024/04/11 03:33:21 DEBUG : potato: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f411b8519caef39cf_d20240411_m032826_c001_v7007000_t0000_u01712806106325") 2024/04/11 03:33:21 DEBUG : potato: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97aeb5_d20240411_m032825_c001_v0001181_t0046_u01712806105537") 2024/04/11 03:33:21 DEBUG : potato: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97aea3_d20240411_m032824_c001_v0001181_t0020_u01712806104929") 2024/04/11 03:33:22 DEBUG : potato: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f411b8519caef39ce_d20240411_m032824_c001_v7007000_t0000_u01712806104163") 2024/04/11 03:33:22 DEBUG : potato: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97ae63_d20240411_m032823_c001_v0001181_t0012_u01712806103551") 2024/04/11 03:33:22 DEBUG : potato: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97ae43_d20240411_m032822_c001_v0001181_t0058_u01712806102917") 2024/04/11 03:33:22 DEBUG : potato: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f411b8519caef39cc_d20240411_m032822_c001_v7007000_t0000_u01712806102130") 2024/04/11 03:33:22 DEBUG : potato: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97adff_d20240411_m032821_c001_v0001181_t0056_u01712806101275") 2024/04/11 03:33:22 DEBUG : potato2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f40566323c6991913_d20240411_m032953_c001_v7007000_t0000_u01712806193970") 2024/04/11 03:33:22 DEBUG : potato2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfade_d20240411_m032953_c001_v0001157_t0040_u01712806193203") 2024/04/11 03:33:22 DEBUG : potato2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f40878ed6710f9233_d20240411_m032946_c001_v7007000_t0000_u01712806186183") 2024/04/11 03:33:22 DEBUG : potato2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97b8fb_d20240411_m032940_c001_v0001181_t0006_u01712806180856") 2024/04/11 03:33:22 DEBUG : potato2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f40739ad12d21353a_d20240411_m032933_c001_v7007000_t0000_u01712806173626") 2024/04/11 03:33:22 DEBUG : potato2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfa3b_d20240411_m032929_c001_v0001157_t0053_u01712806169021") 2024/04/11 03:33:22 DEBUG : potato2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f40281caa55f49819_d20240411_m032922_c001_v7007000_t0000_u01712806162526") 2024/04/11 03:33:22 DEBUG : potato2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97b5a7_d20240411_m032917_c001_v0001181_t0011_u01712806157845") 2024/04/11 03:33:22 DEBUG : potato2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd4a6d_d20240411_m032850_c001_v7007000_t0000_u01712806130169") 2024/04/11 03:33:22 DEBUG : potato2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97b1dd_d20240411_m032848_c001_v0001181_t0043_u01712806128781") 2024/04/11 03:33:22 DEBUG : potato2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd4a45_d20240411_m032847_c001_v7007000_t0000_u01712806127671") 2024/04/11 03:33:22 DEBUG : potato2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97b17a_d20240411_m032846_c001_v0001181_t0051_u01712806126068") 2024/04/11 03:33:22 DEBUG : potato2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd4a40_d20240411_m032845_c001_v7007000_t0000_u01712806125337") 2024/04/11 03:33:22 DEBUG : potato2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97b142_d20240411_m032844_c001_v0001181_t0031_u01712806124478") 2024/04/11 03:33:23 DEBUG : potato2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd4a38_d20240411_m032843_c001_v7007000_t0000_u01712806123038") 2024/04/11 03:33:23 DEBUG : potato2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97b0f6_d20240411_m032842_c001_v0001181_t0049_u01712806122148") 2024/04/11 03:33:23 DEBUG : potato2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd4a30_d20240411_m032840_c001_v7007000_t0000_u01712806120043") 2024/04/11 03:33:23 DEBUG : potato2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97b0aa_d20240411_m032839_c001_v0001181_t0032_u01712806119252") 2024/04/11 03:33:23 DEBUG : potato2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f411b8519caef39d5_d20240411_m032831_c001_v7007000_t0000_u01712806111475") 2024/04/11 03:33:23 DEBUG : potato2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97af5b_d20240411_m032830_c001_v0001181_t0054_u01712806110266") 2024/04/11 03:33:23 DEBUG : potato2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd4665_d20240411_m032742_c001_v7007000_t0000_u01712806062835") 2024/04/11 03:33:23 DEBUG : potato2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97a82f_d20240411_m032742_c001_v0001181_t0038_u01712806062150") 2024/04/11 03:33:23 DEBUG : potato2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd4660_d20240411_m032740_c001_v7007000_t0000_u01712806060859") 2024/04/11 03:33:23 DEBUG : potato2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97a7e1_d20240411_m032739_c001_v0001181_t0019_u01712806059994") 2024/04/11 03:33:23 DEBUG : potato3: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f404178af593e43cf_d20240411_m032945_c001_v7007000_t0000_u01712806185654") 2024/04/11 03:33:23 DEBUG : potato3: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97b91d_d20240411_m032941_c001_v0001181_t0026_u01712806181902") 2024/04/11 03:33:23 DEBUG : potato3: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f402ff81f17091a44_d20240411_m032933_c001_v7007000_t0000_u01712806173566") 2024/04/11 03:33:23 DEBUG : potato3: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfa47_d20240411_m032930_c001_v0001157_t0024_u01712806170125") 2024/04/11 03:33:23 DEBUG : potato3: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f4007893bcb4b067a_d20240411_m032922_c001_v7007000_t0000_u01712806162827") 2024/04/11 03:33:23 DEBUG : potato3: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97b5df_d20240411_m032918_c001_v0001181_t0013_u01712806158938") 2024/04/11 03:33:23 DEBUG : pre-dest1/1: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870491_d20240411_m033030_c001_v7007000_t0000_u01712806230538") 2024/04/11 03:33:23 DEBUG : pre-dest1/1: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97bf20_d20240411_m033024_c001_v0001181_t0026_u01712806224737") 2024/04/11 03:33:24 DEBUG : pre-dest2/2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a870493_d20240411_m033030_c001_v7007000_t0000_u01712806230742") 2024/04/11 03:33:24 DEBUG : pre-dest2/2: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddfbc2_d20240411_m033025_c001_v0001157_t0017_u01712806225527") 2024/04/11 03:33:24 DEBUG : rclone-sync-test-ignore-file/.ignore: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f40566323c6991960_d20240411_m033003_c001_v7007000_t0000_u01712806203465") 2024/04/11 03:33:24 DEBUG : rclone-sync-test-ignore-file/.ignore: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97bb9f_d20240411_m033000_c001_v0001181_t0023_u01712806200088") 2024/04/11 03:33:24 DEBUG : sizeonly: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f4075e69e2954bd63_d20240411_m032801_c001_v7007000_t0000_u01712806081546") 2024/04/11 03:33:24 DEBUG : sizeonly: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97aad5_d20240411_m032800_c001_v0001181_t0004_u01712806080591") 2024/04/11 03:33:24 DEBUG : sub dir/hello world: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a87099b_d20240411_m033256_c001_v7007000_t0000_u01712806376962") 2024/04/11 03:33:24 DEBUG : sub dir/hello world: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97d54a_d20240411_m033254_c001_v0001181_t0014_u01712806374337") 2024/04/11 03:33:24 DEBUG : sub dir/hello world: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f40281caa55f49814_d20240411_m032913_c001_v7007000_t0000_u01712806153961") 2024/04/11 03:33:24 DEBUG : sub dir/hello world: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97b513_d20240411_m032912_c001_v0001181_t0021_u01712806152841") 2024/04/11 03:33:24 DEBUG : sub dir/hello world: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f40281caa55f49812_d20240411_m032911_c001_v7007000_t0000_u01712806151906") 2024/04/11 03:33:24 DEBUG : sub dir/hello world: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddf9d3_d20240411_m032910_c001_v0001157_t0024_u01712806150767") 2024/04/11 03:33:24 DEBUG : sub dir/hello world: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f4075e69e2954bd61_d20240411_m032757_c001_v7007000_t0000_u01712806077397") 2024/04/11 03:33:24 DEBUG : sub dir/hello world: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97aa13_d20240411_m032755_c001_v0001181_t0019_u01712806075739") 2024/04/11 03:33:24 DEBUG : sub dir/hello world: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f4075e69e2954bd55_d20240411_m032755_c001_v7007000_t0000_u01712806075001") 2024/04/11 03:33:24 DEBUG : sub dir/hello world: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97a9d9_d20240411_m032753_c001_v0001181_t0037_u01712806073843") 2024/04/11 03:33:24 DEBUG : sub dir/hello world: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd46c6_d20240411_m032753_c001_v7007000_t0000_u01712806073097") 2024/04/11 03:33:24 DEBUG : sub dir/hello world: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97a93d_d20240411_m032749_c001_v0001181_t0026_u01712806069229") 2024/04/11 03:33:24 DEBUG : sub dir/hello world: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd4678_d20240411_m032748_c001_v7007000_t0000_u01712806068094") 2024/04/11 03:33:24 DEBUG : sub dir/hello world: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97a905_d20240411_m032747_c001_v0001181_t0032_u01712806067433") 2024/04/11 03:33:25 DEBUG : sub dir/hello world: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd466f_d20240411_m032746_c001_v7007000_t0000_u01712806066170") 2024/04/11 03:33:25 DEBUG : sub dir/hello world: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97a8bd_d20240411_m032745_c001_v0001181_t0021_u01712806065382") 2024/04/11 03:33:25 DEBUG : sub dir/hello world: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd4669_d20240411_m032744_c001_v7007000_t0000_u01712806064480") 2024/04/11 03:33:25 DEBUG : sub dir/hello world: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97a873_d20240411_m032743_c001_v0001181_t0027_u01712806063735") 2024/04/11 03:33:25 DEBUG : sub dir/hello world: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd464e_d20240411_m032736_c001_v7007000_t0000_u01712806056981") 2024/04/11 03:33:25 DEBUG : sub dir/hello world: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97a73b_d20240411_m032736_c001_v0001181_t0024_u01712806056233") 2024/04/11 03:33:25 DEBUG : sub dir/hello world: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd4637_d20240411_m032735_c001_v7007000_t0000_u01712806055298") 2024/04/11 03:33:25 DEBUG : sub dir/hello world: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97a6f8_d20240411_m032734_c001_v0001181_t0056_u01712806054614") 2024/04/11 03:33:25 DEBUG : sub dir/hello world: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd4621_d20240411_m032733_c001_v7007000_t0000_u01712806053715") 2024/04/11 03:33:25 DEBUG : sub dir/hello world: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97a6ac_d20240411_m032732_c001_v0001181_t0001_u01712806052862") 2024/04/11 03:33:25 DEBUG : sub dir/hello world: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd45d2_d20240411_m032730_c001_v7007000_t0000_u01712806050314") 2024/04/11 03:33:25 DEBUG : sub dir/hello world: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97a628_d20240411_m032729_c001_v0001181_t0008_u01712806049634") 2024/04/11 03:33:25 DEBUG : sub dir2/very/very/very/very/very/nested/subdir/hello world: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41538d6c2a8709a0_d20240411_m033257_c001_v7007000_t0000_u01712806377156") 2024/04/11 03:33:25 DEBUG : sub dir2/very/very/very/very/very/nested/subdir/hello world: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f10363234e295cfa8_d20240411_m033254_c001_v0001154_t0011_u01712806374365") 2024/04/11 03:33:25 DEBUG : sub/yam: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f40281caa55f4980d_d20240411_m032908_c001_v7007000_t0000_u01712806148219") 2024/04/11 03:33:25 DEBUG : sub/yam: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97b432_d20240411_m032906_c001_v0001181_t0046_u01712806146064") 2024/04/11 03:33:25 DEBUG : three: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd4ab8_d20240411_m032856_c001_v7007000_t0000_u01712806136002") 2024/04/11 03:33:25 DEBUG : three: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97b2b8_d20240411_m032854_c001_v0001181_t0033_u01712806134704") 2024/04/11 03:33:26 DEBUG : three: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f11980228ba97b26c_d20240411_m032852_c001_v0001181_t0006_u01712806132446") 2024/04/11 03:33:26 DEBUG : two: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd4ab9_d20240411_m032856_c001_v7007000_t0000_u01712806136188") 2024/04/11 03:33:26 DEBUG : two: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f4079e73c67ecd18c_d20240411_m032853_c001_v0001181_t0041_u01712806133941") 2024/04/11 03:33:26 DEBUG : two: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f41980228ba97b266_d20240411_m032852_c001_v0001181_t0058_u01712806132261") 2024/04/11 03:33:26 DEBUG : yam: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f40281caa55f4980f_d20240411_m032909_c001_v7007000_t0000_u01712806149028") 2024/04/11 03:33:26 DEBUG : yam: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f109353489944c879_d20240411_m032907_c001_v0001181_t0019_u01712806147986") 2024/04/11 03:33:26 DEBUG : yam: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd4bd9_d20240411_m032903_c001_v7007000_t0000_u01712806143587") 2024/04/11 03:33:26 DEBUG : yam: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f1079e73c67ecd283_d20240411_m032900_c001_v0001181_t0047_u01712806140740") 2024/04/11 03:33:26 DEBUG : yam: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd4ad9_d20240411_m032858_c001_v7007000_t0000_u01712806138693") 2024/04/11 03:33:26 DEBUG : yam: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f110b800164ddf989_d20240411_m032856_c001_v0001157_t0058_u01712806136747") 2024/04/11 03:33:26 DEBUG : yaml: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f40281caa55f497fb_d20240411_m032904_c001_v7007000_t0000_u01712806144729") 2024/04/11 03:33:26 DEBUG : yaml: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f102f7ab4ede312df_d20240411_m032901_c001_v0001026_t0024_u01712806141990") 2024/04/11 03:33:26 DEBUG : yaml: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f401b3bfec9dd4ae6_d20240411_m032859_c001_v7007000_t0000_u01712806139428") 2024/04/11 03:33:26 DEBUG : yaml: Deleting (id "4_zaf022dd3302dcbbb8fe80e1b_f113346bda47dede7_d20240411_m032858_c001_v0001091_t0042_u01712806138108") "./sync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Finished OK in 6m1.867493651s (try 1/5)