"./sync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Starting (try 1/5) 2024/04/25 03:45:16 DEBUG : Creating backend with remote "TestB2:rclone-test-hemoxiz2mijihil7ribitul2" 2024/04/25 03:45:16 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/04/25 03:45:16 DEBUG : Creating backend with remote "/tmp/rclone687936681" === RUN TestPipe --- PASS: TestPipe (0.00s) === RUN TestPipeConcurrent --- PASS: TestPipeConcurrent (0.06s) === 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-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:45:17 NOTICE: sub dir: Skipped make directory as --dry-run is set 2024/04/25 03:45:17 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/25 03:45:17 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) 2024/04/25 03:45:17 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:45:17 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestCopyWithDryRun (1.91s) === RUN TestCopy run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:45:18 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/04/25 03:45:18 DEBUG : sub dir: Making directory 2024/04/25 03:45:18 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/25 03:45:18 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:45:18 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:45:19 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/25 03:45:19 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:45:20 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopy (2.22s) === RUN TestCopyMetadata run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", 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-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:45:21 DEBUG : Creating backend with remote "/non-existing" 2024/04/25 03:45:21 ERROR : Local file system at /non-existing: error reading source root directory: directory not found 2024/04/25 03:45:21 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:45:21 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestCopyMissingDirectory (0.90s) === RUN TestCopyNoTraverse run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:45:22 DEBUG : sub dir: Making directory 2024/04/25 03:45:22 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/25 03:45:22 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:45:22 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:45:23 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/25 03:45:23 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestCopyNoTraverse (2.15s) === RUN TestCopyCheckFirst run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:45:24 INFO : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Running all checks before starting transfers 2024/04/25 03:45:24 DEBUG : sub dir: Making directory 2024/04/25 03:45:24 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/25 03:45:24 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:45:24 INFO : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Checks finished, now starting transfers 2024/04/25 03:45:24 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:45:25 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/25 03:45:25 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestCopyCheckFirst (2.01s) === RUN TestSyncNoTraverse run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:45:26 ERROR : Ignoring --no-traverse with sync 2024/04/25 03:45:26 DEBUG : sub dir: Making directory 2024/04/25 03:45:26 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/25 03:45:26 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:45:26 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:45:26 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/25 03:45:26 INFO : sub dir/hello world: Copied (new) 2024/04/25 03:45:26 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestSyncNoTraverse (1.65s) === RUN TestCopyWithDepth run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:45:28 DEBUG : hello world2: Need to transfer - File not found at Destination 2024/04/25 03:45:28 DEBUG : sub dir: Making directory 2024/04/25 03:45:28 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:45:28 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:45:28 DEBUG : hello world2: sha1 = c0bf117f9c93d02c894fe8ffd6e5cecf3545c209 OK 2024/04/25 03:45:28 INFO : hello world2: Copied (new) run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestCopyWithDepth (1.64s) === RUN TestCopyWithFilesFrom run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:45:29 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/25 03:45:29 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:45:29 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:45:30 DEBUG : potato2: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/25 03:45:30 INFO : potato2: Copied (new) run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestCopyWithFilesFrom (1.82s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:45:31 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/25 03:45:31 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:45:31 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:45:32 DEBUG : potato2: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/25 03:45:32 INFO : potato2: Copied (new) run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestCopyWithFilesFromAndNoTraverse (2.11s) === RUN TestCopyEmptyDirectories run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:45:33 DEBUG : sub dir2: Making directory with metadata 2024/04/25 03:45:33 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2024/04/25 03:45:33 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/04/25 03:45:33 DEBUG : sub dir: Making directory 2024/04/25 03:45:33 DEBUG : sub dir2: Making directory 2024/04/25 03:45:33 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/25 03:45:33 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:45:33 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:45:34 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/25 03:45:34 INFO : sub dir/hello world: Copied (new) 2024/04/25 03:45:34 DEBUG : sub dir2: Making directory 2024/04/25 03:45:34 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: copied 1 directories run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" fstest.go:244: Filtering empty directory "sub dir2" 2024/04/25 03:45:34 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopyEmptyDirectories (1.85s) === RUN TestMoveEmptyDirectories run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:45:35 DEBUG : sub dir2: Making directory with metadata 2024/04/25 03:45:35 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2024/04/25 03:45:35 DEBUG : sub dir: Making directory 2024/04/25 03:45:35 DEBUG : sub dir2: Making directory 2024/04/25 03:45:35 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/25 03:45:35 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:45:35 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:45:35 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/25 03:45:35 INFO : sub dir/hello world: Copied (new) 2024/04/25 03:45:35 INFO : sub dir/hello world: Deleted 2024/04/25 03:45:35 DEBUG : sub dir: Making directory 2024/04/25 03:45:35 DEBUG : sub dir2: Making directory 2024/04/25 03:45:35 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: copied 2 directories run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" fstest.go:244: Filtering empty directory "sub dir2" 2024/04/25 03:45:36 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata 2024/04/25 03:45:36 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestMoveEmptyDirectories (1.82s) === RUN TestSyncNoUpdateDirModtime run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", 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-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:45:37 DEBUG : sub dir2: Making directory with metadata 2024/04/25 03:45:37 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2024/04/25 03:45:37 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/04/25 03:45:37 DEBUG : sub dir: Making directory 2024/04/25 03:45:37 DEBUG : sub dir2: Making directory 2024/04/25 03:45:37 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/25 03:45:37 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:45:37 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:45:38 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/25 03:45:38 INFO : sub dir/hello world: Copied (new) 2024/04/25 03:45:38 DEBUG : sub dir2: Making directory 2024/04/25 03:45:38 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: copied 1 directories 2024/04/25 03:45:38 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" fstest.go:244: Filtering empty directory "sub dir2" 2024/04/25 03:45:38 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestSyncEmptyDirectories (1.84s) === RUN TestSyncSetDelayedModTimes run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" sync_test.go:427: Backend doesn't have DirModTimeUpdatesOnWrite set --- SKIP: TestSyncSetDelayedModTimes (0.36s) === RUN TestServerSideCopy run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:45:40 DEBUG : Creating backend with remote "TestB2:rclone-test-mipidoh4terefej9yohapit2" sync_test.go:487: Server side copy (if possible) B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 -> B2 bucket rclone-test-mipidoh4terefej9yohapit2 2024/04/25 03:45:41 DEBUG : sub dir: Making directory 2024/04/25 03:45:42 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/25 03:45:42 DEBUG : B2 bucket rclone-test-mipidoh4terefej9yohapit2: Waiting for checks to finish 2024/04/25 03:45:42 DEBUG : B2 bucket rclone-test-mipidoh4terefej9yohapit2: Waiting for transfers to finish 2024/04/25 03:45:42 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/25 03:45:42 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:45:42 DEBUG : B2 bucket rclone-test-mipidoh4terefej9yohapit2: Purge remote 2024/04/25 03:45:42 INFO : B2 bucket rclone-test-mipidoh4terefej9yohapit2: cleaning bucket "rclone-test-mipidoh4terefej9yohapit2" of all files 2024/04/25 03:45:42 DEBUG : sub dir/hello world: Deleting (id "4_z5fb2ed9350bd1b3b8ff80e1b_f11519ed879aa147e_d20240425_m034542_c001_v0001136_t0032_u01714016742330") --- PASS: TestServerSideCopy (4.95s) === RUN TestCopyAfterDelete run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:45:45 ERROR : : error listing: directory not found 2024/04/25 03:45:45 DEBUG : Local file system at /tmp/rclone687936681: Making directory 2024/04/25 03:45:45 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:45:45 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestCopyAfterDelete (1.97s) === RUN TestCopyRedownload run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:45:47 DEBUG : sub dir: Making directory 2024/04/25 03:45:47 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/25 03:45:47 DEBUG : Local file system at /tmp/rclone687936681: Waiting for checks to finish 2024/04/25 03:45:47 DEBUG : Local file system at /tmp/rclone687936681: Waiting for transfers to finish 2024/04/25 03:45:48 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/25 03:45:48 DEBUG : sub dir/hello world.jelofeh8.partial: renamed to: sub dir/hello world 2024/04/25 03:45:48 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestCopyRedownload (2.40s) === RUN TestSyncBasedOnCheckSum run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:45:49 DEBUG : check sum: Need to transfer - File not found at Destination 2024/04/25 03:45:49 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:45:49 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:45:49 DEBUG : check sum: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/04/25 03:45:49 INFO : check sum: Copied (new) 2024/04/25 03:45:49 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:45:50 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:45:50 DEBUG : check sum: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/04/25 03:45:50 DEBUG : check sum: Size and sha1 of src and dst objects identical 2024/04/25 03:45:50 DEBUG : check sum: Unchanged skipping 2024/04/25 03:45:50 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:45:50 DEBUG : Waiting for deletions to finish 2024/04/25 03:45:50 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestSyncBasedOnCheckSum (2.38s) === RUN TestSyncSizeOnly run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:45:51 DEBUG : sizeonly: Need to transfer - File not found at Destination 2024/04/25 03:45:51 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:45:51 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:45:52 DEBUG : sizeonly: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2024/04/25 03:45:52 INFO : sizeonly: Copied (new) 2024/04/25 03:45:52 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:45:52 DEBUG : sizeonly: Sizes identical 2024/04/25 03:45:52 DEBUG : sizeonly: Unchanged skipping 2024/04/25 03:45:52 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:45:52 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:45:52 DEBUG : Waiting for deletions to finish 2024/04/25 03:45:52 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestSyncSizeOnly (2.37s) === RUN TestSyncIgnoreSize run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:45:54 DEBUG : ignore-size: Need to transfer - File not found at Destination 2024/04/25 03:45:54 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:45:54 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:45:54 DEBUG : ignore-size: sha1 = 4a756ca07e9487f482465a99e8286abc86ba4dc7 OK 2024/04/25 03:45:54 INFO : ignore-size: Copied (new) 2024/04/25 03:45:54 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:45:54 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:45:54 DEBUG : ignore-size: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:45:54 DEBUG : ignore-size: Unchanged skipping 2024/04/25 03:45:54 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:45:54 DEBUG : Waiting for deletions to finish 2024/04/25 03:45:54 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestSyncIgnoreSize (2.35s) === RUN TestSyncIgnoreTimes run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:45:56 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:45:56 DEBUG : existing: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:45:56 DEBUG : existing: Unchanged skipping 2024/04/25 03:45:56 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:45:56 DEBUG : Waiting for deletions to finish 2024/04/25 03:45:56 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:45:57 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2024/04/25 03:45:57 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:45:57 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:45:57 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2024/04/25 03:45:57 INFO : existing: Copied (replaced existing) 2024/04/25 03:45:57 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestSyncIgnoreTimes (2.82s) === RUN TestSyncIgnoreExisting run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:45:59 DEBUG : existing: Need to transfer - File not found at Destination 2024/04/25 03:45:59 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:45:59 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:45:59 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2024/04/25 03:45:59 INFO : existing: Copied (new) 2024/04/25 03:45:59 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:45:59 DEBUG : existing: Destination exists, skipping 2024/04/25 03:45:59 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:45:59 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:45:59 DEBUG : Waiting for deletions to finish 2024/04/25 03:45:59 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestSyncIgnoreExisting (2.31s) === RUN TestSyncIgnoreErrors run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:46:02 DEBUG : d: Making directory fstest.go:244: Filtering empty directory "d" 2024/04/25 03:46:02 DEBUG : a: Making directory 2024/04/25 03:46:02 DEBUG : a/potato2: Need to transfer - File not found at Destination 2024/04/25 03:46:02 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/25 03:46:02 DEBUG : c/non empty space: Unchanged skipping 2024/04/25 03:46:02 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:46:02 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:46:03 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/25 03:46:03 INFO : a/potato2: Copied (new) 2024/04/25 03:46:03 DEBUG : Waiting for deletions to finish 2024/04/25 03:46:03 INFO : b/potato: Deleted run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestSyncIgnoreErrors (3.34s) === RUN TestSyncAfterChangingModtimeOnly run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:46:05 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/25 03:46:05 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:46:05 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/04/25 03:46:05 NOTICE: empty space: Skipped update modification time as --dry-run is set (size 1) 2024/04/25 03:46:05 DEBUG : empty space: Unchanged skipping 2024/04/25 03:46:05 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:46:05 DEBUG : Waiting for deletions to finish 2024/04/25 03:46:05 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:46:05 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/25 03:46:05 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:46:05 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/04/25 03:46:06 INFO : empty space: Updated modification time in destination 2024/04/25 03:46:06 DEBUG : empty space: Unchanged skipping 2024/04/25 03:46:06 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:46:06 DEBUG : Waiting for deletions to finish 2024/04/25 03:46:06 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestSyncAfterChangingModtimeOnly (3.59s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:46:09 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/25 03:46:09 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:46:09 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/04/25 03:46:09 DEBUG : empty space: Unchanged skipping 2024/04/25 03:46:09 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:46:09 DEBUG : Waiting for deletions to finish 2024/04/25 03:46:09 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (1.95s) === RUN TestSyncDoesntUpdateModtime run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:46:10 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/25 03:46:10 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:46:10 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 (Local file system at /tmp/rclone687936681) 2024/04/25 03:46:10 DEBUG : foo: sha1 = 62cdb7020ff920e5aa642c3d4066950dd1f01f4d (B2 bucket rclone-test-hemoxiz2mijihil7ribitul2) 2024/04/25 03:46:10 DEBUG : foo: sha1 differ 2024/04/25 03:46:10 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:46:10 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 OK 2024/04/25 03:46:10 INFO : foo: Copied (replaced existing) 2024/04/25 03:46:10 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestSyncDoesntUpdateModtime (1.87s) === RUN TestSyncAfterAddingAFile run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:46:12 DEBUG : potato: Need to transfer - File not found at Destination 2024/04/25 03:46:12 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/25 03:46:12 DEBUG : empty space: Unchanged skipping 2024/04/25 03:46:12 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:46:12 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:46:13 DEBUG : potato: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/25 03:46:13 INFO : potato: Copied (new) 2024/04/25 03:46:13 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestSyncAfterAddingAFile (2.36s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:46:15 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2024/04/25 03:46:15 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:46:15 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:46:15 DEBUG : potato: sha1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f OK 2024/04/25 03:46:15 INFO : potato: Copied (replaced existing) 2024/04/25 03:46:15 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestSyncAfterChangingFilesSizeOnly (2.36s) === RUN TestSyncAfterChangingContentsOnly run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:46:17 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/25 03:46:17 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:46:17 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f (Local file system at /tmp/rclone687936681) 2024/04/25 03:46:17 DEBUG : potato: sha1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f (B2 bucket rclone-test-hemoxiz2mijihil7ribitul2) 2024/04/25 03:46:17 DEBUG : potato: sha1 differ 2024/04/25 03:46:17 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:46:18 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f OK 2024/04/25 03:46:18 INFO : potato: Copied (replaced existing) 2024/04/25 03:46:18 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestSyncAfterChangingContentsOnly (2.85s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:46:20 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/25 03:46:20 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2024/04/25 03:46:20 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:46:20 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/25 03:46:20 DEBUG : empty space: Unchanged skipping 2024/04/25 03:46:20 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:46:20 DEBUG : Waiting for deletions to finish 2024/04/25 03:46:20 NOTICE: potato: Skipped delete as --dry-run is set (size 21) run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (2.43s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:46:23 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/25 03:46:23 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/25 03:46:23 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:46:23 DEBUG : empty space: Unchanged skipping 2024/04/25 03:46:23 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:46:23 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/25 03:46:23 INFO : potato2: Copied (new) 2024/04/25 03:46:23 DEBUG : Waiting for deletions to finish 2024/04/25 03:46:23 INFO : potato: Deleted run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (2.97s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:46:25 DEBUG : d: Making directory 2024/04/25 03:46:25 DEBUG : d/e: Making directory fstest.go:244: Filtering empty directory "d" fstest.go:244: Filtering empty directory "d/e" 2024/04/25 03:46:26 DEBUG : a: Making directory 2024/04/25 03:46:26 DEBUG : a/potato2: Need to transfer - File not found at Destination 2024/04/25 03:46:26 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/25 03:46:26 DEBUG : c/non empty space: Unchanged skipping 2024/04/25 03:46:26 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:46:26 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:46:26 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/25 03:46:26 INFO : a/potato2: Copied (new) 2024/04/25 03:46:26 DEBUG : Waiting for deletions to finish 2024/04/25 03:46:26 INFO : b/potato: Deleted run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (3.24s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:46:29 DEBUG : d: Making directory fstest.go:244: Filtering empty directory "d" 2024/04/25 03:46:29 DEBUG : a: Making directory 2024/04/25 03:46:29 DEBUG : a/potato2: Need to transfer - File not found at Destination 2024/04/25 03:46:29 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/25 03:46:29 DEBUG : c/non empty space: Unchanged skipping 2024/04/25 03:46:29 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:46:29 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:46:29 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/25 03:46:29 INFO : a/potato2: Copied (new) 2024/04/25 03:46:29 ERROR : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: not deleting files as there were IO errors 2024/04/25 03:46:29 ERROR : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: not deleting directories as there were IO errors run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" fstest.go:244: Filtering empty directory "d" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (2.99s) === RUN TestSyncDeleteAfter --- PASS: TestSyncDeleteAfter (0.00s) === RUN TestSyncDeleteDuring run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:46:32 DEBUG : Waiting for deletions to finish 2024/04/25 03:46:32 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/25 03:46:32 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/25 03:46:32 DEBUG : empty space: Unchanged skipping 2024/04/25 03:46:32 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:46:32 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:46:32 INFO : potato: Deleted 2024/04/25 03:46:33 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/25 03:46:33 INFO : potato2: Copied (new) run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestSyncDeleteDuring (3.12s) === RUN TestSyncDeleteBefore run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:46:35 DEBUG : Waiting for deletions to finish 2024/04/25 03:46:35 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:46:35 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:46:35 INFO : potato: Deleted 2024/04/25 03:46:35 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/25 03:46:35 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/25 03:46:35 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:46:35 DEBUG : empty space: Unchanged skipping 2024/04/25 03:46:35 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:46:36 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/25 03:46:36 INFO : potato2: Copied (new) run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestSyncDeleteBefore (3.47s) === RUN TestCopyDeleteBefore run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:46:38 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/25 03:46:38 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:46:38 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:46:38 DEBUG : potato2: sha1 = 810274f0df19dab60a894a562b7a8ff04c072623 OK 2024/04/25 03:46:38 INFO : potato2: Copied (new) run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestCopyDeleteBefore (2.34s) === RUN TestSyncWithExclude run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:46:41 DEBUG : enormous: Excluded (Size Filter) 2024/04/25 03:46:41 DEBUG : enormous: Excluded 2024/04/25 03:46:41 DEBUG : potato2: Excluded (Size Filter) 2024/04/25 03:46:41 DEBUG : potato2: Excluded 2024/04/25 03:46:41 DEBUG : potato2: Excluded (Size Filter) 2024/04/25 03:46:41 DEBUG : potato2: Excluded 2024/04/25 03:46:41 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/25 03:46:41 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:46:41 DEBUG : empty space: Unchanged skipping 2024/04/25 03:46:41 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:46:41 DEBUG : Waiting for deletions to finish 2024/04/25 03:46:41 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:46:41 DEBUG : enormous: Excluded (Size Filter) 2024/04/25 03:46:41 DEBUG : enormous: Excluded 2024/04/25 03:46:41 DEBUG : potato2: Excluded (Size Filter) 2024/04/25 03:46:41 DEBUG : potato2: Excluded 2024/04/25 03:46:41 DEBUG : potato2: Excluded (Size Filter) 2024/04/25 03:46:41 DEBUG : potato2: Excluded 2024/04/25 03:46:41 DEBUG : Local file system at /tmp/rclone687936681: Waiting for checks to finish 2024/04/25 03:46:41 DEBUG : empty space: Size and modification time the same (differ by 456.789µs, within tolerance 1ms) 2024/04/25 03:46:41 DEBUG : empty space: Unchanged skipping 2024/04/25 03:46:41 DEBUG : Local file system at /tmp/rclone687936681: Waiting for transfers to finish 2024/04/25 03:46:41 DEBUG : Waiting for deletions to finish 2024/04/25 03:46:41 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestSyncWithExclude (3.02s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:46:44 DEBUG : enormous: Excluded (Size Filter) 2024/04/25 03:46:44 DEBUG : enormous: Excluded 2024/04/25 03:46:44 DEBUG : potato2: Excluded (Size Filter) 2024/04/25 03:46:44 DEBUG : potato2: Excluded 2024/04/25 03:46:44 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:46:44 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/25 03:46:44 DEBUG : empty space: Unchanged skipping 2024/04/25 03:46:44 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:46:44 DEBUG : Waiting for deletions to finish 2024/04/25 03:46:45 INFO : enormous: Deleted 2024/04/25 03:46:45 INFO : potato2: Deleted 2024/04/25 03:46:45 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:46:45 DEBUG : Local file system at /tmp/rclone687936681: Waiting for checks to finish 2024/04/25 03:46:45 DEBUG : empty space: Size and modification time the same (differ by 456.789µs, within tolerance 1ms) 2024/04/25 03:46:45 DEBUG : empty space: Unchanged skipping 2024/04/25 03:46:45 DEBUG : Local file system at /tmp/rclone687936681: Waiting for transfers to finish 2024/04/25 03:46:45 DEBUG : Waiting for deletions to finish 2024/04/25 03:46:45 INFO : enormous: Deleted 2024/04/25 03:46:45 INFO : potato2: Deleted 2024/04/25 03:46:45 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestSyncWithExcludeAndDeleteExcluded (3.62s) === RUN TestSyncWithUpdateOlder run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:46:48 DEBUG : five: Need to transfer - File not found at Destination 2024/04/25 03:46:48 DEBUG : four: Sizes differ (src 4 vs dst 8) 2024/04/25 03:46:48 DEBUG : one: Destination is newer than source, skipping 2024/04/25 03:46:48 DEBUG : three: Sizes identical 2024/04/25 03:46:48 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2024/04/25 03:46:48 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2024/04/25 03:46:48 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:46:48 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b (Local file system at /tmp/rclone687936681) 2024/04/25 03:46:48 DEBUG : two: sha1 = b10e0da85e90399abfec36c7376b20aa4596461b (B2 bucket rclone-test-hemoxiz2mijihil7ribitul2) 2024/04/25 03:46:48 DEBUG : two: sha1 differ 2024/04/25 03:46:48 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:46:48 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2024/04/25 03:46:48 INFO : five: Copied (new) 2024/04/25 03:46:49 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2024/04/25 03:46:49 INFO : four: Copied (replaced existing) 2024/04/25 03:46:49 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2024/04/25 03:46:49 INFO : two: Copied (replaced existing) 2024/04/25 03:46:49 DEBUG : Waiting for deletions to finish 2024/04/25 03:46:49 DEBUG : one: Destination is newer than source, skipping 2024/04/25 03:46:49 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:46:49 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2024/04/25 03:46:49 DEBUG : two: Size and sha1 of src and dst objects identical 2024/04/25 03:46:49 DEBUG : two: Destination mod time is within 1s of source and files identical, skipping 2024/04/25 03:46:49 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb (Local file system at /tmp/rclone687936681) 2024/04/25 03:46:49 DEBUG : three: sha1 = 03731cad13f4cf7b59703c77529381cdec1632e5 (B2 bucket rclone-test-hemoxiz2mijihil7ribitul2) 2024/04/25 03:46:49 DEBUG : three: sha1 differ 2024/04/25 03:46:49 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2024/04/25 03:46:49 DEBUG : five: Size and sha1 of src and dst objects identical 2024/04/25 03:46:49 DEBUG : three: Destination mod time is within 1s of source but files differ, transferring 2024/04/25 03:46:49 DEBUG : five: Destination mod time is within 1s of source and files identical, skipping 2024/04/25 03:46:49 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2024/04/25 03:46:49 DEBUG : four: Size and sha1 of src and dst objects identical 2024/04/25 03:46:49 DEBUG : four: Destination mod time is within 1s of source and files identical, skipping 2024/04/25 03:46:49 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:46:50 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2024/04/25 03:46:50 INFO : three: Copied (replaced existing) 2024/04/25 03:46:50 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithUpdateOlder (4.66s) === 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-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" sync_test.go:1327: Can track renames: true 2024/04/25 03:46:51 INFO : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Making map for --track-renames 2024/04/25 03:46:51 INFO : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Finished making map for --track-renames 2024/04/25 03:46:51 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:46:51 DEBUG : potato: Need to transfer - No matching file found at Destination 2024/04/25 03:46:51 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for renames to finish 2024/04/25 03:46:51 DEBUG : yam: Need to transfer - No matching file found at Destination 2024/04/25 03:46:51 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:46:52 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/04/25 03:46:52 INFO : yam: Copied (new) 2024/04/25 03:46:52 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2024/04/25 03:46:52 INFO : potato: Copied (new) 2024/04/25 03:46:52 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:46:52 INFO : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Making map for --track-renames 2024/04/25 03:46:52 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:46:52 INFO : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Finished making map for --track-renames 2024/04/25 03:46:52 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:46:52 DEBUG : potato: Unchanged skipping 2024/04/25 03:46:52 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for renames to finish 2024/04/25 03:46:53 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/04/25 03:46:53 INFO : yam: Copied (server-side copy) to: yaml 2024/04/25 03:46:53 INFO : yam: Deleted 2024/04/25 03:46:53 INFO : yaml: Renamed from "yam" 2024/04/25 03:46:53 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:46:53 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestSyncWithTrackRenames (3.90s) === RUN TestParseRenamesStrategyModtime --- PASS: TestParseRenamesStrategyModtime (0.00s) === RUN TestRenamesStrategyModtime --- PASS: TestRenamesStrategyModtime (0.00s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" sync_test.go:1399: Can track renames: true 2024/04/25 03:46:55 INFO : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Making map for --track-renames 2024/04/25 03:46:55 INFO : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Finished making map for --track-renames 2024/04/25 03:46:55 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:46:55 DEBUG : potato: Need to transfer - No matching file found at Destination 2024/04/25 03:46:55 DEBUG : yam: Need to transfer - No matching file found at Destination 2024/04/25 03:46:55 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for renames to finish 2024/04/25 03:46:55 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:46:55 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/04/25 03:46:55 INFO : yam: Copied (new) 2024/04/25 03:46:56 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2024/04/25 03:46:56 INFO : potato: Copied (new) 2024/04/25 03:46:56 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:46:56 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:46:56 INFO : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Making map for --track-renames 2024/04/25 03:46:56 INFO : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Finished making map for --track-renames 2024/04/25 03:46:56 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:46:56 DEBUG : potato: Unchanged skipping 2024/04/25 03:46:56 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for renames to finish 2024/04/25 03:46:57 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/04/25 03:46:57 INFO : yam: Copied (server-side copy) to: yaml 2024/04/25 03:46:57 INFO : yam: Deleted 2024/04/25 03:46:57 INFO : yaml: Renamed from "yam" 2024/04/25 03:46:57 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:46:57 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestSyncWithTrackRenamesStrategyModtime (3.98s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" sync_test.go:1438: Can track renames: true 2024/04/25 03:46:59 DEBUG : sub: Making directory 2024/04/25 03:46:59 INFO : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Making map for --track-renames 2024/04/25 03:46:59 INFO : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Finished making map for --track-renames 2024/04/25 03:46:59 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:46:59 DEBUG : potato: Need to transfer - No matching file found at Destination 2024/04/25 03:46:59 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for renames to finish 2024/04/25 03:46:59 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2024/04/25 03:46:59 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:46:59 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/04/25 03:46:59 INFO : sub/yam: Copied (new) 2024/04/25 03:47:00 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2024/04/25 03:47:00 INFO : potato: Copied (new) 2024/04/25 03:47:00 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:47:00 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:47:00 DEBUG : potato: Unchanged skipping 2024/04/25 03:47:01 INFO : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Making map for --track-renames 2024/04/25 03:47:01 INFO : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Finished making map for --track-renames 2024/04/25 03:47:01 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:47:01 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for renames to finish 2024/04/25 03:47:01 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/04/25 03:47:01 INFO : sub/yam: Copied (server-side copy) to: yam 2024/04/25 03:47:01 INFO : sub/yam: Deleted 2024/04/25 03:47:01 INFO : yam: Renamed from "sub/yam" 2024/04/25 03:47:01 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:47:01 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestSyncWithTrackRenamesStrategyLeaf (4.07s) === RUN TestServerSideMoveLocal run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:47:03 DEBUG : Creating backend with remote "/tmp/rclone687936681/dir1" 2024/04/25 03:47:03 DEBUG : Creating backend with remote "/tmp/rclone687936681/dir2" 2024/04/25 03:47:03 DEBUG : Local file system at /tmp/rclone687936681/dir2: Using server-side directory move 2024/04/25 03:47:03 INFO : Local file system at /tmp/rclone687936681/dir2: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2024/04/25 03:47:03 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/25 03:47:03 INFO : file1.txt: Moved (server-side) 2024/04/25 03:47:03 DEBUG : Local file system at /tmp/rclone687936681/dir2: Waiting for checks to finish 2024/04/25 03:47:03 DEBUG : Local file system at /tmp/rclone687936681/dir2: Waiting for transfers to finish --- PASS: TestServerSideMoveLocal (0.37s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:47:04 DEBUG : nested: Making directory 2024/04/25 03:47:04 DEBUG : sub dir: Making directory 2024/04/25 03:47:04 DEBUG : nested/sub dir: Making directory 2024/04/25 03:47:04 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/25 03:47:04 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2024/04/25 03:47:04 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:47:04 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:47:04 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/25 03:47:04 INFO : sub dir/hello world: Copied (new) 2024/04/25 03:47:04 INFO : sub dir/hello world: Deleted 2024/04/25 03:47:04 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2024/04/25 03:47:04 INFO : nested/sub dir/file: Copied (new) 2024/04/25 03:47:04 INFO : nested/sub dir/file: Deleted 2024/04/25 03:47:04 INFO : sub dir: Removing directory 2024/04/25 03:47:04 INFO : nested/sub dir: Removing directory 2024/04/25 03:47:04 INFO : nested: Removing directory 2024/04/25 03:47:04 DEBUG : Local file system at /tmp/rclone687936681: deleted 3 directories run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestMoveWithDeleteEmptySrcDirs (2.38s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:47:06 DEBUG : nested: Making directory 2024/04/25 03:47:06 DEBUG : sub dir: Making directory 2024/04/25 03:47:06 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/25 03:47:06 DEBUG : nested/sub dir: Making directory 2024/04/25 03:47:06 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2024/04/25 03:47:06 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:47:06 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:47:06 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2024/04/25 03:47:06 INFO : nested/sub dir/file: Copied (new) 2024/04/25 03:47:06 INFO : nested/sub dir/file: Deleted 2024/04/25 03:47:07 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/25 03:47:07 INFO : sub dir/hello world: Copied (new) 2024/04/25 03:47:07 INFO : sub dir/hello world: Deleted run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestMoveWithoutDeleteEmptySrcDirs (2.52s) === RUN TestMoveWithIgnoreExisting run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:47:08 DEBUG : existing: Need to transfer - File not found at Destination 2024/04/25 03:47:08 DEBUG : existing-b: Need to transfer - File not found at Destination 2024/04/25 03:47:08 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:47:08 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:47:09 DEBUG : existing-b: sha1 = 321f6b7e8bf7f29aab89c5e41a555b1b0baa41a9 OK 2024/04/25 03:47:09 INFO : existing-b: Copied (new) 2024/04/25 03:47:09 INFO : existing-b: Deleted 2024/04/25 03:47:09 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2024/04/25 03:47:09 INFO : existing: Copied (new) 2024/04/25 03:47:09 INFO : existing: Deleted 2024/04/25 03:47:09 DEBUG : existing: Destination exists, skipping 2024/04/25 03:47:09 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:47:09 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2024/04/25 03:47:09 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:47:09 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestMoveWithIgnoreExisting (2.29s) === RUN TestServerSideMove run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:47:11 DEBUG : Creating backend with remote "TestB2:rclone-test-bovixoj3jituqix3cesivop6" sync_test.go:1494: Server side move (if possible) B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 -> B2 bucket rclone-test-bovixoj3jituqix3cesivop6 2024/04/25 03:47:15 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/25 03:47:15 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ms) 2024/04/25 03:47:15 DEBUG : empty space: Unchanged skipping 2024/04/25 03:47:15 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2024/04/25 03:47:15 DEBUG : B2 bucket rclone-test-bovixoj3jituqix3cesivop6: Waiting for checks to finish 2024/04/25 03:47:15 INFO : empty space: Deleted 2024/04/25 03:47:15 DEBUG : B2 bucket rclone-test-bovixoj3jituqix3cesivop6: Waiting for transfers to finish 2024/04/25 03:47:15 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/25 03:47:15 INFO : potato2: Copied (server-side copy) 2024/04/25 03:47:15 INFO : potato2: Deleted 2024/04/25 03:47:15 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2024/04/25 03:47:15 INFO : potato3: Copied (server-side copy) 2024/04/25 03:47:15 INFO : potato3: Deleted 2024/04/25 03:47:16 DEBUG : Creating backend with remote "TestB2:rclone-test-dozomep7dowevip3qodipay1" 2024/04/25 03:47:16 DEBUG : empty space: Need to transfer - File not found at Destination 2024/04/25 03:47:16 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/25 03:47:16 DEBUG : potato3: Need to transfer - File not found at Destination 2024/04/25 03:47:16 DEBUG : B2 bucket rclone-test-dozomep7dowevip3qodipay1: Waiting for checks to finish 2024/04/25 03:47:16 DEBUG : B2 bucket rclone-test-dozomep7dowevip3qodipay1: Waiting for transfers to finish 2024/04/25 03:47:17 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/25 03:47:17 INFO : potato2: Copied (server-side copy) 2024/04/25 03:47:17 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/04/25 03:47:17 INFO : empty space: Copied (server-side copy) 2024/04/25 03:47:17 INFO : potato2: Deleted 2024/04/25 03:47:17 INFO : empty space: Deleted 2024/04/25 03:47:18 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2024/04/25 03:47:18 INFO : potato3: Copied (server-side copy) 2024/04/25 03:47:18 INFO : potato3: Deleted 2024/04/25 03:47:18 DEBUG : B2 bucket rclone-test-dozomep7dowevip3qodipay1: Purge remote 2024/04/25 03:47:18 INFO : B2 bucket rclone-test-dozomep7dowevip3qodipay1: cleaning bucket "rclone-test-dozomep7dowevip3qodipay1" of all files 2024/04/25 03:47:18 DEBUG : empty space: Deleting (id "4_z7f525dc350dd1b3b8ff80e1b_f100bcd927b11cd1b_d20240425_m034717_c001_v0001040_t0000_u01714016837178") 2024/04/25 03:47:18 DEBUG : potato2: Deleting (id "4_z7f525dc350dd1b3b8ff80e1b_f11773b04ebd9ce4b_d20240425_m034717_c001_v0001179_t0028_u01714016837184") 2024/04/25 03:47:18 DEBUG : potato3: Deleting (id "4_z7f525dc350dd1b3b8ff80e1b_f111b43e51eda07d3_d20240425_m034717_c001_v0001026_t0018_u01714016837221") 2024/04/25 03:47:19 DEBUG : B2 bucket rclone-test-bovixoj3jituqix3cesivop6: Purge remote 2024/04/25 03:47:19 INFO : B2 bucket rclone-test-bovixoj3jituqix3cesivop6: cleaning bucket "rclone-test-bovixoj3jituqix3cesivop6" of all files 2024/04/25 03:47:19 DEBUG : empty space: Deleting (id "4_zaf124de350dd1b3b8ff80e1b_f4184ecc6980a65b2_d20240425_m034717_c001_v7007000_t0000_u01714016837536") 2024/04/25 03:47:19 DEBUG : empty space: Deleting (id "4_zaf124de350dd1b3b8ff80e1b_f107ffbc604122824_d20240425_m034714_c001_v0001179_t0027_u01714016834276") 2024/04/25 03:47:19 DEBUG : potato2: Deleting (id "4_zaf124de350dd1b3b8ff80e1b_f40137b6632333a00_d20240425_m034717_c001_v7007000_t0000_u01714016837404") 2024/04/25 03:47:19 DEBUG : potato2: Deleting (id "4_zaf124de350dd1b3b8ff80e1b_f115abc6401f9671e_d20240425_m034715_c001_v0001179_t0055_u01714016835371") 2024/04/25 03:47:19 DEBUG : potato3: Deleting (id "4_zaf124de350dd1b3b8ff80e1b_f401d64cbda9b85b9_d20240425_m034718_c001_v7007000_t0000_u01714016838241") 2024/04/25 03:47:19 DEBUG : potato3: Deleting (id "4_zaf124de350dd1b3b8ff80e1b_f1172714191df1145_d20240425_m034715_c001_v0001181_t0056_u01714016835569") 2024/04/25 03:47:19 DEBUG : potato3: Deleting (id "4_zaf124de350dd1b3b8ff80e1b_f107ffbc60412282a_d20240425_m034714_c001_v0001179_t0046_u01714016834464") --- PASS: TestServerSideMove (10.27s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:47:21 DEBUG : Creating backend with remote "TestB2:rclone-test-joxucil9munifud8yavibiw2" sync_test.go:1494: Server side move (if possible) B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 -> B2 bucket rclone-test-joxucil9munifud8yavibiw2 2024/04/25 03:47:26 DEBUG : empty space: Excluded (Size Filter) 2024/04/25 03:47:26 DEBUG : empty space: Excluded 2024/04/25 03:47:26 DEBUG : empty space: Excluded (Size Filter) 2024/04/25 03:47:26 DEBUG : empty space: Excluded 2024/04/25 03:47:26 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/25 03:47:26 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2024/04/25 03:47:26 DEBUG : B2 bucket rclone-test-joxucil9munifud8yavibiw2: Waiting for checks to finish 2024/04/25 03:47:26 DEBUG : B2 bucket rclone-test-joxucil9munifud8yavibiw2: Waiting for transfers to finish 2024/04/25 03:47:26 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/25 03:47:26 INFO : potato2: Copied (server-side copy) 2024/04/25 03:47:26 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2024/04/25 03:47:26 INFO : potato3: Copied (server-side copy) 2024/04/25 03:47:26 INFO : potato2: Deleted 2024/04/25 03:47:26 INFO : potato3: Deleted 2024/04/25 03:47:27 DEBUG : Creating backend with remote "TestB2:rclone-test-hifosaq1salonuv4gecadah2" 2024/04/25 03:47:28 DEBUG : empty space: Excluded (Size Filter) 2024/04/25 03:47:28 DEBUG : empty space: Excluded 2024/04/25 03:47:28 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/25 03:47:28 DEBUG : potato3: Need to transfer - File not found at Destination 2024/04/25 03:47:28 DEBUG : B2 bucket rclone-test-hifosaq1salonuv4gecadah2: Waiting for checks to finish 2024/04/25 03:47:28 DEBUG : B2 bucket rclone-test-hifosaq1salonuv4gecadah2: Waiting for transfers to finish 2024/04/25 03:47:28 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2024/04/25 03:47:28 INFO : potato3: Copied (server-side copy) 2024/04/25 03:47:28 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/25 03:47:28 INFO : potato2: Copied (server-side copy) 2024/04/25 03:47:28 INFO : potato3: Deleted 2024/04/25 03:47:29 INFO : potato2: Deleted 2024/04/25 03:47:29 DEBUG : B2 bucket rclone-test-hifosaq1salonuv4gecadah2: Purge remote 2024/04/25 03:47:29 INFO : B2 bucket rclone-test-hifosaq1salonuv4gecadah2: cleaning bucket "rclone-test-hifosaq1salonuv4gecadah2" of all files 2024/04/25 03:47:29 DEBUG : potato2: Deleting (id "4_z0f628d9350dd1b3b8ff80e1b_f116c005414ca450e_d20240425_m034728_c001_v0001181_t0049_u01714016848688") 2024/04/25 03:47:29 DEBUG : potato3: Deleting (id "4_z0f628d9350dd1b3b8ff80e1b_f10154602503e38ec_d20240425_m034728_c001_v0001179_t0016_u01714016848691") 2024/04/25 03:47:30 DEBUG : B2 bucket rclone-test-joxucil9munifud8yavibiw2: Purge remote 2024/04/25 03:47:30 INFO : B2 bucket rclone-test-joxucil9munifud8yavibiw2: cleaning bucket "rclone-test-joxucil9munifud8yavibiw2" of all files 2024/04/25 03:47:30 DEBUG : empty space: Deleting (id "4_z7fa27db350dd1b3b8ff80e1b_f11180922ff7d81bf_d20240425_m034725_c001_v0001179_t0028_u01714016845653") 2024/04/25 03:47:30 DEBUG : potato2: Deleting (id "4_z7fa27db350dd1b3b8ff80e1b_f406f8db543db7942_d20240425_m034729_c001_v7007000_t0000_u01714016849038") 2024/04/25 03:47:30 DEBUG : potato2: Deleting (id "4_z7fa27db350dd1b3b8ff80e1b_f1095d1af98d2c388_d20240425_m034726_c001_v0001179_t0016_u01714016846588") 2024/04/25 03:47:30 DEBUG : potato3: Deleting (id "4_z7fa27db350dd1b3b8ff80e1b_f40733e9547e03d18_d20240425_m034728_c001_v7007000_t0000_u01714016848888") 2024/04/25 03:47:30 DEBUG : potato3: Deleting (id "4_z7fa27db350dd1b3b8ff80e1b_f11747f76ead858a1_d20240425_m034726_c001_v0001165_t0039_u01714016846600") 2024/04/25 03:47:30 DEBUG : potato3: Deleting (id "4_z7fa27db350dd1b3b8ff80e1b_f11180922ff7d81c5_d20240425_m034725_c001_v0001179_t0053_u01714016845995") --- PASS: TestServerSideMoveWithFilter (10.65s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:47:31 DEBUG : Creating backend with remote "TestB2:rclone-test-yibuvob4fiqaneb5jimoyut0" 2024/04/25 03:47:34 DEBUG : tomatoDir: Making directory sync_test.go:1494: Server side move (if possible) B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 -> B2 bucket rclone-test-yibuvob4fiqaneb5jimoyut0 2024/04/25 03:47:37 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/25 03:47:37 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ms) 2024/04/25 03:47:37 DEBUG : empty space: Unchanged skipping 2024/04/25 03:47:37 DEBUG : B2 bucket rclone-test-yibuvob4fiqaneb5jimoyut0: Waiting for checks to finish 2024/04/25 03:47:37 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2024/04/25 03:47:37 INFO : empty space: Deleted 2024/04/25 03:47:37 DEBUG : B2 bucket rclone-test-yibuvob4fiqaneb5jimoyut0: Waiting for transfers to finish 2024/04/25 03:47:37 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/25 03:47:37 INFO : potato2: Copied (server-side copy) 2024/04/25 03:47:37 INFO : potato2: Deleted 2024/04/25 03:47:37 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2024/04/25 03:47:37 INFO : potato3: Copied (server-side copy) 2024/04/25 03:47:37 INFO : potato3: Deleted 2024/04/25 03:47:38 DEBUG : Creating backend with remote "TestB2:rclone-test-hoburem8yupulav8gopudof2" 2024/04/25 03:47:38 DEBUG : tomatoDir: Making directory 2024/04/25 03:47:39 DEBUG : empty space: Need to transfer - File not found at Destination 2024/04/25 03:47:39 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/25 03:47:39 DEBUG : potato3: Need to transfer - File not found at Destination 2024/04/25 03:47:39 DEBUG : B2 bucket rclone-test-hoburem8yupulav8gopudof2: Waiting for checks to finish 2024/04/25 03:47:39 DEBUG : B2 bucket rclone-test-hoburem8yupulav8gopudof2: Waiting for transfers to finish 2024/04/25 03:47:39 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/04/25 03:47:39 INFO : empty space: Copied (server-side copy) 2024/04/25 03:47:39 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2024/04/25 03:47:39 INFO : potato3: Copied (server-side copy) 2024/04/25 03:47:39 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/25 03:47:39 INFO : potato2: Copied (server-side copy) 2024/04/25 03:47:39 INFO : empty space: Deleted 2024/04/25 03:47:40 INFO : potato3: Deleted 2024/04/25 03:47:40 INFO : potato2: Deleted 2024/04/25 03:47:40 DEBUG : B2 bucket rclone-test-hoburem8yupulav8gopudof2: Purge remote 2024/04/25 03:47:40 INFO : B2 bucket rclone-test-hoburem8yupulav8gopudof2: cleaning bucket "rclone-test-hoburem8yupulav8gopudof2" of all files 2024/04/25 03:47:40 DEBUG : empty space: Deleting (id "4_z5f12bd4350dd1b3b8ff80e1b_f105c19147a68bac4_d20240425_m034739_c001_v0001176_t0019_u01714016859689") 2024/04/25 03:47:40 DEBUG : potato2: Deleting (id "4_z5f12bd4350dd1b3b8ff80e1b_f116058ff7325b02a_d20240425_m034739_c001_v0001036_t0000_u01714016859707") 2024/04/25 03:47:40 DEBUG : potato3: Deleting (id "4_z5f12bd4350dd1b3b8ff80e1b_f113dcf6bee1c6206_d20240425_m034739_c001_v0001179_t0006_u01714016859717") 2024/04/25 03:47:41 DEBUG : B2 bucket rclone-test-yibuvob4fiqaneb5jimoyut0: Purge remote 2024/04/25 03:47:41 INFO : B2 bucket rclone-test-yibuvob4fiqaneb5jimoyut0: cleaning bucket "rclone-test-yibuvob4fiqaneb5jimoyut0" of all files 2024/04/25 03:47:41 DEBUG : empty space: Deleting (id "4_zbf52ad3350dd1b3b8ff80e1b_f40733e9547e03d2e_d20240425_m034739_c001_v7007000_t0000_u01714016859905") 2024/04/25 03:47:41 DEBUG : empty space: Deleting (id "4_zbf52ad3350dd1b3b8ff80e1b_f1059023efd4daadb_d20240425_m034735_c001_v0001178_t0014_u01714016855950") 2024/04/25 03:47:41 DEBUG : potato2: Deleting (id "4_zbf52ad3350dd1b3b8ff80e1b_f419e0e3b77825339_d20240425_m034740_c001_v7007000_t0000_u01714016860079") 2024/04/25 03:47:41 DEBUG : potato2: Deleting (id "4_zbf52ad3350dd1b3b8ff80e1b_f11415d34c266c9cc_d20240425_m034737_c001_v0001176_t0018_u01714016857200") 2024/04/25 03:47:41 DEBUG : potato3: Deleting (id "4_zbf52ad3350dd1b3b8ff80e1b_f40524a78a48ae44c_d20240425_m034739_c001_v7007000_t0000_u01714016859917") 2024/04/25 03:47:41 DEBUG : potato3: Deleting (id "4_zbf52ad3350dd1b3b8ff80e1b_f110d935a4aac7361_d20240425_m034737_c001_v0001036_t0046_u01714016857330") 2024/04/25 03:47:41 DEBUG : potato3: Deleting (id "4_zbf52ad3350dd1b3b8ff80e1b_f1059023efd4daae4_d20240425_m034736_c001_v0001178_t0047_u01714016856303") --- PASS: TestServerSideMoveDeleteEmptySourceDirs (11.18s) === RUN TestServerSideMoveOverlap run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:47:43 DEBUG : Creating backend with remote "TestB2:rclone-test-hemoxiz2mijihil7ribitul2/rclone-move-test" --- PASS: TestServerSideMoveOverlap (2.42s) === RUN TestSyncOverlap run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:47:45 DEBUG : Creating backend with remote "TestB2:rclone-test-hemoxiz2mijihil7ribitul2/rclone-sync-test" run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestSyncOverlap (2.33s) === RUN TestSyncOverlapWithFilter run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:47:47 DEBUG : Creating backend with remote "TestB2:rclone-test-hemoxiz2mijihil7ribitul2/rclone-sync-test" 2024/04/25 03:47:48 DEBUG : Creating backend with remote "TestB2:rclone-test-hemoxiz2mijihil7ribitul2/rclone-sync-test-include/layer2" 2024/04/25 03:47:49 DEBUG : Creating backend with remote "TestB2:rclone-test-hemoxiz2mijihil7ribitul2/rclone-sync-test-ignore-file" 2024/04/25 03:47:51 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/04/25 03:47:51 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path rclone-sync-test: Waiting for checks to finish 2024/04/25 03:47:51 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path rclone-sync-test: Waiting for transfers to finish 2024/04/25 03:47:51 DEBUG : Waiting for deletions to finish 2024/04/25 03:47:51 INFO : There was nothing to transfer 2024/04/25 03:47:52 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/04/25 03:47:52 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:47:52 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:47:52 DEBUG : Waiting for deletions to finish 2024/04/25 03:47:52 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:47:52 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/04/25 03:47:52 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path rclone-sync-test-include/layer2: Waiting for checks to finish 2024/04/25 03:47:52 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path rclone-sync-test-include/layer2: Waiting for transfers to finish 2024/04/25 03:47:52 DEBUG : Waiting for deletions to finish 2024/04/25 03:47:52 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:47:53 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/04/25 03:47:53 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:47:53 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:47:53 DEBUG : Waiting for deletions to finish 2024/04/25 03:47:53 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:47:53 DEBUG : : Excluded 2024/04/25 03:47:53 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/04/25 03:47:53 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path rclone-sync-test-ignore-file: Waiting for checks to finish 2024/04/25 03:47:53 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path rclone-sync-test-ignore-file: Waiting for transfers to finish 2024/04/25 03:47:53 DEBUG : Waiting for deletions to finish 2024/04/25 03:47:53 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestSyncOverlapWithFilter (13.08s) === RUN TestSyncCompareDest run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:48:00 DEBUG : Creating backend with remote "TestB2:rclone-test-hemoxiz2mijihil7ribitul2/dst" 2024/04/25 03:48:02 DEBUG : Creating backend with remote "TestB2:rclone-test-hemoxiz2mijihil7ribitul2/CompareDest" 2024/04/25 03:48:02 DEBUG : one: Need to transfer - File not found at Destination 2024/04/25 03:48:02 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for checks to finish 2024/04/25 03:48:02 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for transfers to finish 2024/04/25 03:48:04 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/04/25 03:48:04 INFO : one: Copied (new) 2024/04/25 03:48:04 DEBUG : Waiting for deletions to finish 2024/04/25 03:48:05 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/04/25 03:48:05 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for checks to finish 2024/04/25 03:48:05 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for transfers to finish 2024/04/25 03:48:05 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2024/04/25 03:48:05 INFO : one: Copied (replaced existing) 2024/04/25 03:48:05 DEBUG : Waiting for deletions to finish 2024/04/25 03:48:08 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for checks to finish 2024/04/25 03:48:08 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/04/25 03:48:08 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/25 03:48:08 DEBUG : one: Destination found in --compare-dest, skipping 2024/04/25 03:48:08 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for transfers to finish 2024/04/25 03:48:08 DEBUG : Waiting for deletions to finish 2024/04/25 03:48:08 INFO : There was nothing to transfer 2024/04/25 03:48:09 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/25 03:48:09 DEBUG : two: Destination found in --compare-dest, skipping 2024/04/25 03:48:09 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/04/25 03:48:09 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for checks to finish 2024/04/25 03:48:09 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/25 03:48:09 DEBUG : one: Destination found in --compare-dest, skipping 2024/04/25 03:48:09 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for transfers to finish 2024/04/25 03:48:09 DEBUG : Waiting for deletions to finish 2024/04/25 03:48:09 INFO : There was nothing to transfer 2024/04/25 03:48:10 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/25 03:48:10 DEBUG : two: Destination found in --compare-dest, skipping 2024/04/25 03:48:10 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/04/25 03:48:10 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for checks to finish 2024/04/25 03:48:10 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/25 03:48:10 DEBUG : one: Destination found in --compare-dest, skipping 2024/04/25 03:48:10 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for transfers to finish 2024/04/25 03:48:10 DEBUG : Waiting for deletions to finish 2024/04/25 03:48:10 INFO : There was nothing to transfer 2024/04/25 03:48:11 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/25 03:48:11 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2024/04/25 03:48:11 DEBUG : two: Destination found in --compare-dest, skipping 2024/04/25 03:48:11 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/04/25 03:48:11 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for checks to finish 2024/04/25 03:48:11 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/25 03:48:11 DEBUG : one: Destination found in --compare-dest, skipping 2024/04/25 03:48:11 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for transfers to finish 2024/04/25 03:48:11 DEBUG : Waiting for deletions to finish 2024/04/25 03:48:11 INFO : There was nothing to transfer 2024/04/25 03:48:12 DEBUG : two: Sizes differ (src 5 vs dst 3) 2024/04/25 03:48:12 DEBUG : two: Need to transfer - File not found at Destination 2024/04/25 03:48:12 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/04/25 03:48:12 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for checks to finish 2024/04/25 03:48:12 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/25 03:48:12 DEBUG : one: Destination found in --compare-dest, skipping 2024/04/25 03:48:12 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for transfers to finish 2024/04/25 03:48:13 DEBUG : two: sha1 = a4be8877ad88f3109a6411985a1f359e10e2d930 OK 2024/04/25 03:48:13 INFO : two: Copied (new) 2024/04/25 03:48:13 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (13.76s) === RUN TestSyncMultipleCompareDest run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:48:16 DEBUG : Creating backend with remote "TestB2:rclone-test-hemoxiz2mijihil7ribitul2/dest" 2024/04/25 03:48:17 DEBUG : Creating backend with remote "TestB2:rclone-test-hemoxiz2mijihil7ribitul2/pre-dest1" 2024/04/25 03:48:17 DEBUG : Creating backend with remote "TestB2:rclone-test-hemoxiz2mijihil7ribitul2/pre-dest2" 2024/04/25 03:48:18 DEBUG : 1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:48:18 DEBUG : 1: Destination found in --compare-dest, skipping 2024/04/25 03:48:19 DEBUG : 2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:48:19 DEBUG : 2: Destination found in --compare-dest, skipping 2024/04/25 03:48:19 DEBUG : 3: Need to transfer - File not found at Destination 2024/04/25 03:48:19 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dest: Waiting for checks to finish 2024/04/25 03:48:19 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dest: Waiting for transfers to finish 2024/04/25 03:48:20 DEBUG : 3: sha1 = 77de68daecd823babbb58edb1c8e14d7106e83bb OK 2024/04/25 03:48:20 INFO : 3: Copied (new) 2024/04/25 03:48:20 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (6.74s) === RUN TestSyncCopyDest run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:48:21 DEBUG : Creating backend with remote "TestB2:rclone-test-hemoxiz2mijihil7ribitul2/dst" 2024/04/25 03:48:21 DEBUG : Creating backend with remote "TestB2:rclone-test-hemoxiz2mijihil7ribitul2/CopyDest" 2024/04/25 03:48:22 DEBUG : one: Need to transfer - File not found at Destination 2024/04/25 03:48:22 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for checks to finish 2024/04/25 03:48:22 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for transfers to finish 2024/04/25 03:48:24 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/04/25 03:48:24 INFO : one: Copied (new) 2024/04/25 03:48:24 DEBUG : Waiting for deletions to finish 2024/04/25 03:48:24 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for checks to finish 2024/04/25 03:48:24 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/04/25 03:48:24 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for transfers to finish 2024/04/25 03:48:25 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2024/04/25 03:48:25 INFO : one: Copied (replaced existing) 2024/04/25 03:48:25 DEBUG : Waiting for deletions to finish 2024/04/25 03:48:27 DEBUG : Creating backend with remote "TestB2:rclone-test-hemoxiz2mijihil7ribitul2/BackupDir" 2024/04/25 03:48:28 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/04/25 03:48:28 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for checks to finish 2024/04/25 03:48:28 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/25 03:48:28 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/04/25 03:48:29 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/04/25 03:48:29 INFO : one: Copied (server-side copy) 2024/04/25 03:48:29 INFO : one: Deleted 2024/04/25 03:48:30 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2024/04/25 03:48:30 INFO : one: Copied (server-side copy) 2024/04/25 03:48:30 DEBUG : one: Destination found in --copy-dest, using server-side copy 2024/04/25 03:48:30 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for transfers to finish 2024/04/25 03:48:30 DEBUG : Waiting for deletions to finish 2024/04/25 03:48:32 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/25 03:48:32 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2024/04/25 03:48:32 INFO : two: Copied (server-side copy) 2024/04/25 03:48:32 DEBUG : two: Destination found in --copy-dest, using server-side copy 2024/04/25 03:48:32 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/25 03:48:32 DEBUG : one: Unchanged skipping 2024/04/25 03:48:32 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for checks to finish 2024/04/25 03:48:32 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for transfers to finish 2024/04/25 03:48:32 DEBUG : Waiting for deletions to finish 2024/04/25 03:48:33 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/25 03:48:33 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for checks to finish 2024/04/25 03:48:33 DEBUG : two: Unchanged skipping 2024/04/25 03:48:33 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/25 03:48:33 DEBUG : one: Unchanged skipping 2024/04/25 03:48:33 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for transfers to finish 2024/04/25 03:48:33 DEBUG : Waiting for deletions to finish 2024/04/25 03:48:33 INFO : There was nothing to transfer 2024/04/25 03:48:34 DEBUG : three: Sizes differ (src 7 vs dst 5) 2024/04/25 03:48:34 DEBUG : three: Destination not found in --copy-dest 2024/04/25 03:48:34 DEBUG : three: Need to transfer - File not found at Destination 2024/04/25 03:48:34 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/25 03:48:34 DEBUG : one: Unchanged skipping 2024/04/25 03:48:34 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for checks to finish 2024/04/25 03:48:34 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/25 03:48:34 DEBUG : two: Unchanged skipping 2024/04/25 03:48:34 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for transfers to finish 2024/04/25 03:48:35 DEBUG : three: sha1 = 370e613335f3cf2f19b2a2d35a86402f55c659f8 OK 2024/04/25 03:48:35 INFO : three: Copied (new) 2024/04/25 03:48:35 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCopyDest (16.02s) === RUN TestSyncBackupDir run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:48:39 DEBUG : Creating backend with remote "TestB2:rclone-test-hemoxiz2mijihil7ribitul2/dst" 2024/04/25 03:48:41 DEBUG : Creating backend with remote "TestB2:rclone-test-hemoxiz2mijihil7ribitul2/backup" 2024/04/25 03:48:41 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/04/25 03:48:41 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for checks to finish 2024/04/25 03:48:41 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:48:41 DEBUG : two: Unchanged skipping 2024/04/25 03:48:42 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/04/25 03:48:42 INFO : one: Copied (server-side copy) 2024/04/25 03:48:42 INFO : one: Deleted 2024/04/25 03:48:42 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for transfers to finish 2024/04/25 03:48:43 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/25 03:48:43 INFO : one: Copied (new) 2024/04/25 03:48:43 DEBUG : Waiting for deletions to finish 2024/04/25 03:48:45 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2024/04/25 03:48:45 INFO : three.txt: Copied (server-side copy) 2024/04/25 03:48:45 INFO : three.txt: Deleted 2024/04/25 03:48:45 INFO : three.txt: Moved into backup dir 2024/04/25 03:48:46 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/04/25 03:48:46 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for checks to finish 2024/04/25 03:48:46 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:48:46 DEBUG : two: Unchanged skipping 2024/04/25 03:48:47 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/25 03:48:47 INFO : one: Copied (server-side copy) 2024/04/25 03:48:47 INFO : one: Deleted 2024/04/25 03:48:47 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for transfers to finish 2024/04/25 03:48:48 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2024/04/25 03:48:48 INFO : one: Copied (new) 2024/04/25 03:48:48 DEBUG : Waiting for deletions to finish 2024/04/25 03:48:48 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/04/25 03:48:48 INFO : three.txt: Copied (server-side copy) 2024/04/25 03:48:49 INFO : three.txt: Deleted 2024/04/25 03:48:49 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (12.86s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:48:53 DEBUG : Creating backend with remote "TestB2:rclone-test-hemoxiz2mijihil7ribitul2/dst" 2024/04/25 03:48:54 DEBUG : Creating backend with remote "TestB2:rclone-test-hemoxiz2mijihil7ribitul2/backup" 2024/04/25 03:48:54 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/04/25 03:48:54 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:48:54 DEBUG : two: Unchanged skipping 2024/04/25 03:48:54 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for checks to finish 2024/04/25 03:48:56 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/04/25 03:48:56 INFO : one: Copied (server-side copy) to: one.bak 2024/04/25 03:48:56 INFO : one: Deleted 2024/04/25 03:48:56 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for transfers to finish 2024/04/25 03:48:57 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/25 03:48:57 INFO : one: Copied (new) 2024/04/25 03:48:57 DEBUG : Waiting for deletions to finish 2024/04/25 03:48:58 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2024/04/25 03:48:58 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/04/25 03:48:58 INFO : three.txt: Deleted 2024/04/25 03:48:58 INFO : three.txt: Moved into backup dir 2024/04/25 03:49:00 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:49:00 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for checks to finish 2024/04/25 03:49:00 DEBUG : two: Unchanged skipping 2024/04/25 03:49:00 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/04/25 03:49:00 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/25 03:49:00 INFO : one: Copied (server-side copy) to: one.bak 2024/04/25 03:49:01 INFO : one: Deleted 2024/04/25 03:49:01 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for transfers to finish 2024/04/25 03:49:01 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2024/04/25 03:49:01 INFO : one: Copied (new) 2024/04/25 03:49:01 DEBUG : Waiting for deletions to finish 2024/04/25 03:49:02 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/04/25 03:49:02 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/04/25 03:49:02 INFO : three.txt: Deleted 2024/04/25 03:49:02 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (13.50s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:49:06 DEBUG : Creating backend with remote "TestB2:rclone-test-hemoxiz2mijihil7ribitul2/dst" 2024/04/25 03:49:07 DEBUG : Creating backend with remote "TestB2:rclone-test-hemoxiz2mijihil7ribitul2/backup" 2024/04/25 03:49:08 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for checks to finish 2024/04/25 03:49:08 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:49:08 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/04/25 03:49:08 DEBUG : two: Unchanged skipping 2024/04/25 03:49:09 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/04/25 03:49:09 INFO : one: Copied (server-side copy) to: one-2019-01-01 2024/04/25 03:49:09 INFO : one: Deleted 2024/04/25 03:49:09 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for transfers to finish 2024/04/25 03:49:11 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/25 03:49:11 INFO : one: Copied (new) 2024/04/25 03:49:11 DEBUG : Waiting for deletions to finish 2024/04/25 03:49:11 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2024/04/25 03:49:11 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2024/04/25 03:49:12 INFO : three.txt: Deleted 2024/04/25 03:49:12 INFO : three.txt: Moved into backup dir 2024/04/25 03:49:13 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/04/25 03:49:13 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:49:13 DEBUG : two: Unchanged skipping 2024/04/25 03:49:13 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for checks to finish 2024/04/25 03:49:13 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/25 03:49:13 INFO : one: Copied (server-side copy) to: one-2019-01-01 2024/04/25 03:49:14 INFO : one: Deleted 2024/04/25 03:49:14 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for transfers to finish 2024/04/25 03:49:14 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2024/04/25 03:49:14 INFO : one: Copied (new) 2024/04/25 03:49:14 DEBUG : Waiting for deletions to finish 2024/04/25 03:49:15 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/04/25 03:49:15 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2024/04/25 03:49:15 INFO : three.txt: Deleted 2024/04/25 03:49:15 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (13.01s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:49:19 DEBUG : Creating backend with remote "TestB2:rclone-test-hemoxiz2mijihil7ribitul2/dst" 2024/04/25 03:49:20 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/04/25 03:49:20 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:49:20 DEBUG : two: Unchanged skipping 2024/04/25 03:49:20 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for checks to finish 2024/04/25 03:49:21 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/04/25 03:49:21 INFO : one: Copied (server-side copy) to: one.bak 2024/04/25 03:49:21 INFO : one: Deleted 2024/04/25 03:49:21 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for transfers to finish 2024/04/25 03:49:22 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/25 03:49:22 INFO : one: Copied (new) 2024/04/25 03:49:22 DEBUG : Waiting for deletions to finish 2024/04/25 03:49:23 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2024/04/25 03:49:23 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/04/25 03:49:23 INFO : three.txt: Deleted 2024/04/25 03:49:23 INFO : three.txt: Moved into backup dir 2024/04/25 03:49:25 DEBUG : one.bak: Excluded (Path Filter) 2024/04/25 03:49:25 DEBUG : one.bak: Excluded 2024/04/25 03:49:25 DEBUG : three.txt.bak: Excluded (Path Filter) 2024/04/25 03:49:25 DEBUG : three.txt.bak: Excluded 2024/04/25 03:49:25 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for checks to finish 2024/04/25 03:49:25 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:49:25 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/04/25 03:49:25 DEBUG : two: Unchanged skipping 2024/04/25 03:49:26 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/25 03:49:26 INFO : one: Copied (server-side copy) to: one.bak 2024/04/25 03:49:26 INFO : one: Deleted 2024/04/25 03:49:26 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2 path dst: Waiting for transfers to finish 2024/04/25 03:49:26 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2024/04/25 03:49:26 INFO : one: Copied (new) 2024/04/25 03:49:26 DEBUG : Waiting for deletions to finish 2024/04/25 03:49:27 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/04/25 03:49:27 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/04/25 03:49:27 INFO : three.txt: Deleted 2024/04/25 03:49:27 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (12.22s) === RUN TestSyncSuffix run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:49:31 DEBUG : Creating backend with remote "TestB2:rclone-test-hemoxiz2mijihil7ribitul2/dst" 2024/04/25 03:49:31 DEBUG : Config file has changed externally - reloading 2024/04/25 03:49:32 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/04/25 03:49:34 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/04/25 03:49:34 INFO : one: Copied (server-side copy) to: one.bak 2024/04/25 03:49:34 INFO : one: Deleted 2024/04/25 03:49:35 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/25 03:49:35 INFO : one: Copied (new) 2024/04/25 03:49:35 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:49:35 DEBUG : two: Unchanged skipping 2024/04/25 03:49:35 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2024/04/25 03:49:36 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2024/04/25 03:49:36 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/04/25 03:49:36 INFO : three.txt: Deleted 2024/04/25 03:49:37 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/04/25 03:49:37 INFO : three.txt: Copied (new) 2024/04/25 03:49:37 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/04/25 03:49:38 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/25 03:49:38 INFO : one: Copied (server-side copy) to: one.bak 2024/04/25 03:49:38 INFO : one: Deleted 2024/04/25 03:49:39 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2024/04/25 03:49:39 INFO : one: Copied (new) 2024/04/25 03:49:39 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:49:39 DEBUG : two: Unchanged skipping 2024/04/25 03:49:39 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2024/04/25 03:49:40 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/04/25 03:49:40 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/04/25 03:49:40 INFO : three.txt: Deleted 2024/04/25 03:49:41 DEBUG : three.txt: sha1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK 2024/04/25 03:49:41 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (13.61s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:49:45 DEBUG : Creating backend with remote "TestB2:rclone-test-hemoxiz2mijihil7ribitul2/dst" 2024/04/25 03:49:46 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/04/25 03:49:47 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/04/25 03:49:47 INFO : one: Copied (server-side copy) to: one-2019-01-01 2024/04/25 03:49:47 INFO : one: Deleted 2024/04/25 03:49:48 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/25 03:49:48 INFO : one: Copied (new) 2024/04/25 03:49:48 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:49:48 DEBUG : two: Unchanged skipping 2024/04/25 03:49:48 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2024/04/25 03:49:49 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2024/04/25 03:49:49 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2024/04/25 03:49:49 INFO : three.txt: Deleted 2024/04/25 03:49:49 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/04/25 03:49:49 INFO : three.txt: Copied (new) 2024/04/25 03:49:50 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/04/25 03:49:50 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/25 03:49:50 INFO : one: Copied (server-side copy) to: one-2019-01-01 2024/04/25 03:49:50 INFO : one: Deleted 2024/04/25 03:49:51 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2024/04/25 03:49:51 INFO : one: Copied (new) 2024/04/25 03:49:51 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:49:51 DEBUG : two: Unchanged skipping 2024/04/25 03:49:51 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2024/04/25 03:49:52 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/04/25 03:49:52 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2024/04/25 03:49:52 INFO : three.txt: Deleted 2024/04/25 03:49:53 DEBUG : three.txt: sha1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK 2024/04/25 03:49:53 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (12.14s) === RUN TestSyncUTFNorm run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:49:56 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2024/04/25 03:49:56 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:49:56 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:49:56 DEBUG : Testêé: sha1 = a54d88e06612d820bc3be72877c74f257b561b19 OK 2024/04/25 03:49:56 INFO : Testêé: Copied (replaced existing) to: Testêé 2024/04/25 03:49:56 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (2.83s) === RUN TestSyncImmutable run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:49:58 DEBUG : existing: Need to transfer - File not found at Destination 2024/04/25 03:49:58 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:49:58 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:49:58 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2024/04/25 03:49:58 INFO : existing: Copied (new) 2024/04/25 03:49:58 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:49:59 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2024/04/25 03:49:59 ERROR : existing: Source and destination exist but do not match: immutable file modified 2024/04/25 03:49:59 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:49:59 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:49:59 ERROR : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: not deleting files as there were IO errors 2024/04/25 03:49:59 ERROR : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: not deleting directories as there were IO errors run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestSyncImmutable (3.41s) === RUN TestSyncIgnoreCase run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:50:02 DEBUG : existing: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:02 DEBUG : existing: Unchanged skipping 2024/04/25 03:50:02 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:50:02 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:50:02 DEBUG : Waiting for deletions to finish 2024/04/25 03:50:02 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (2.04s) === RUN TestFixCase run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" sync_test.go:2420: Skipping test as local or remote are case-sensitive --- SKIP: TestFixCase (0.38s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" sync_test.go:2459: This test only runs on local === RUN TestMaxTransfer/Soft run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" sync_test.go:2459: This test only runs on local === RUN TestMaxTransfer/Cautious run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" sync_test.go:2459: This test only runs on local --- PASS: TestMaxTransfer (1.13s) --- SKIP: TestMaxTransfer/Hard (0.38s) --- SKIP: TestMaxTransfer/Soft (0.38s) --- SKIP: TestMaxTransfer/Cautious (0.38s) === RUN TestSyncConcurrentDelete run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:50:24 DEBUG : both1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:24 DEBUG : both10: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:24 DEBUG : both11: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:24 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:50:24 DEBUG : both0: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:24 DEBUG : both1: Unchanged skipping 2024/04/25 03:50:24 DEBUG : both12: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:24 DEBUG : both12: Unchanged skipping 2024/04/25 03:50:24 DEBUG : both13: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:24 DEBUG : both13: Unchanged skipping 2024/04/25 03:50:24 DEBUG : both14: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:24 DEBUG : both14: Unchanged skipping 2024/04/25 03:50:24 DEBUG : both15: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:24 DEBUG : both15: Unchanged skipping 2024/04/25 03:50:24 DEBUG : both16: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:24 DEBUG : both16: Unchanged skipping 2024/04/25 03:50:24 DEBUG : both17: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:24 DEBUG : both17: Unchanged skipping 2024/04/25 03:50:24 DEBUG : both18: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:24 DEBUG : both18: Unchanged skipping 2024/04/25 03:50:24 DEBUG : both19: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:24 DEBUG : both19: Unchanged skipping 2024/04/25 03:50:24 DEBUG : both2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:24 DEBUG : both2: Unchanged skipping 2024/04/25 03:50:24 DEBUG : both3: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:24 DEBUG : both3: Unchanged skipping 2024/04/25 03:50:24 DEBUG : both4: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:24 DEBUG : both4: Unchanged skipping 2024/04/25 03:50:24 DEBUG : both5: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:24 DEBUG : both5: Unchanged skipping 2024/04/25 03:50:24 DEBUG : both6: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:24 DEBUG : both6: Unchanged skipping 2024/04/25 03:50:24 DEBUG : both7: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:24 DEBUG : both7: Unchanged skipping 2024/04/25 03:50:24 DEBUG : both8: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:24 DEBUG : both8: Unchanged skipping 2024/04/25 03:50:24 DEBUG : both9: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:24 DEBUG : both9: Unchanged skipping 2024/04/25 03:50:24 DEBUG : both10: Unchanged skipping 2024/04/25 03:50:24 DEBUG : both11: Unchanged skipping 2024/04/25 03:50:24 DEBUG : both0: Unchanged skipping 2024/04/25 03:50:24 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:50:24 DEBUG : Waiting for deletions to finish 2024/04/25 03:50:24 INFO : only5: Deleted 2024/04/25 03:50:24 INFO : only7: Deleted 2024/04/25 03:50:24 INFO : only1: Deleted 2024/04/25 03:50:24 INFO : only4: Deleted 2024/04/25 03:50:24 INFO : only15: Deleted 2024/04/25 03:50:24 INFO : only0: Deleted 2024/04/25 03:50:24 INFO : only18: Deleted 2024/04/25 03:50:24 INFO : only3: Deleted 2024/04/25 03:50:24 INFO : only6: Deleted 2024/04/25 03:50:24 INFO : only11: Deleted 2024/04/25 03:50:24 INFO : only12: Deleted 2024/04/25 03:50:25 INFO : only14: Deleted 2024/04/25 03:50:25 INFO : only19: Deleted 2024/04/25 03:50:25 INFO : only2: Deleted 2024/04/25 03:50:25 INFO : only8: Deleted 2024/04/25 03:50:25 INFO : only9: Deleted 2024/04/25 03:50:25 INFO : only17: Deleted 2024/04/25 03:50:25 INFO : only10: Deleted 2024/04/25 03:50:25 INFO : only13: Deleted 2024/04/25 03:50:25 INFO : only16: Deleted 2024/04/25 03:50:25 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestSyncConcurrentDelete (25.47s) === RUN TestSyncConcurrentTruncate run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:50:48 DEBUG : both0: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:48 DEBUG : both10: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:48 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for checks to finish 2024/04/25 03:50:48 DEBUG : both1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:48 DEBUG : both11: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:48 DEBUG : both0: Unchanged skipping 2024/04/25 03:50:48 DEBUG : both12: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:48 DEBUG : both10: Unchanged skipping 2024/04/25 03:50:48 DEBUG : both13: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:48 DEBUG : both13: Unchanged skipping 2024/04/25 03:50:48 DEBUG : both14: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:48 DEBUG : both14: Unchanged skipping 2024/04/25 03:50:48 DEBUG : both15: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:48 DEBUG : both15: Unchanged skipping 2024/04/25 03:50:48 DEBUG : both16: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:48 DEBUG : both16: Unchanged skipping 2024/04/25 03:50:48 DEBUG : both17: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:48 DEBUG : both17: Unchanged skipping 2024/04/25 03:50:48 DEBUG : both18: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:48 DEBUG : both18: Unchanged skipping 2024/04/25 03:50:48 DEBUG : both19: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:48 DEBUG : both19: Unchanged skipping 2024/04/25 03:50:48 DEBUG : both2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:48 DEBUG : both2: Unchanged skipping 2024/04/25 03:50:48 DEBUG : both3: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:48 DEBUG : both3: Unchanged skipping 2024/04/25 03:50:48 DEBUG : both4: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:48 DEBUG : both4: Unchanged skipping 2024/04/25 03:50:48 DEBUG : both5: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:48 DEBUG : both5: Unchanged skipping 2024/04/25 03:50:48 DEBUG : both6: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:48 DEBUG : both6: Unchanged skipping 2024/04/25 03:50:48 DEBUG : both7: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:48 DEBUG : both7: Unchanged skipping 2024/04/25 03:50:48 DEBUG : both8: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:48 DEBUG : both8: Unchanged skipping 2024/04/25 03:50:48 DEBUG : both9: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/25 03:50:48 DEBUG : both9: Unchanged skipping 2024/04/25 03:50:48 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2024/04/25 03:50:48 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2024/04/25 03:50:48 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2024/04/25 03:50:48 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2024/04/25 03:50:48 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2024/04/25 03:50:48 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2024/04/25 03:50:48 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2024/04/25 03:50:48 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2024/04/25 03:50:48 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2024/04/25 03:50:48 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2024/04/25 03:50:48 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2024/04/25 03:50:48 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2024/04/25 03:50:48 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2024/04/25 03:50:48 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2024/04/25 03:50:48 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2024/04/25 03:50:48 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2024/04/25 03:50:48 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2024/04/25 03:50:48 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2024/04/25 03:50:48 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2024/04/25 03:50:48 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2024/04/25 03:50:48 DEBUG : both1: Unchanged skipping 2024/04/25 03:50:48 DEBUG : both11: Unchanged skipping 2024/04/25 03:50:48 DEBUG : both12: Unchanged skipping 2024/04/25 03:50:48 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Waiting for transfers to finish 2024/04/25 03:50:49 DEBUG : only0: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/25 03:50:49 INFO : only0: Copied (replaced existing) 2024/04/25 03:50:49 DEBUG : only1: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/25 03:50:49 INFO : only1: Copied (replaced existing) 2024/04/25 03:50:49 DEBUG : only10: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/25 03:50:49 INFO : only10: Copied (replaced existing) 2024/04/25 03:50:49 DEBUG : only12: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/25 03:50:49 INFO : only12: Copied (replaced existing) 2024/04/25 03:50:49 DEBUG : only13: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/25 03:50:49 INFO : only13: Copied (replaced existing) 2024/04/25 03:50:49 DEBUG : only14: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/25 03:50:49 INFO : only14: Copied (replaced existing) 2024/04/25 03:50:49 DEBUG : only15: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/25 03:50:49 INFO : only15: Copied (replaced existing) 2024/04/25 03:50:49 DEBUG : only16: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/25 03:50:49 INFO : only16: Copied (replaced existing) 2024/04/25 03:50:49 DEBUG : only17: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/25 03:50:49 INFO : only17: Copied (replaced existing) 2024/04/25 03:50:49 DEBUG : only18: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/25 03:50:49 INFO : only18: Copied (replaced existing) 2024/04/25 03:50:49 DEBUG : only11: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/25 03:50:49 INFO : only11: Copied (replaced existing) 2024/04/25 03:50:49 DEBUG : only19: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/25 03:50:49 INFO : only19: Copied (replaced existing) 2024/04/25 03:50:49 DEBUG : only2: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/25 03:50:49 INFO : only2: Copied (replaced existing) 2024/04/25 03:50:49 DEBUG : only3: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/25 03:50:49 INFO : only3: Copied (replaced existing) 2024/04/25 03:50:49 DEBUG : only4: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/25 03:50:49 INFO : only4: Copied (replaced existing) 2024/04/25 03:50:49 DEBUG : only5: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/25 03:50:49 INFO : only5: Copied (replaced existing) 2024/04/25 03:50:49 DEBUG : only6: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/25 03:50:49 INFO : only6: Copied (replaced existing) 2024/04/25 03:50:50 DEBUG : only7: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/25 03:50:50 INFO : only7: Copied (replaced existing) 2024/04/25 03:50:50 DEBUG : only8: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/25 03:50:50 INFO : only8: Copied (replaced existing) 2024/04/25 03:50:50 DEBUG : only9: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/25 03:50:50 INFO : only9: Copied (replaced existing) 2024/04/25 03:50:50 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestSyncConcurrentTruncate (28.54s) === RUN TestNothingToTransfer run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" 2024/04/25 03:50:58 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/04/25 03:50:58 DEBUG : sub dir: Making directory 2024/04/25 03:50:58 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-hemoxiz2mijihil7ribitul2", Local "Local file system at /tmp/rclone687936681", Modify Window "1ms" --- PASS: TestNothingToTransfer (4.92s) PASS 2024/04/25 03:51:03 DEBUG : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: Purge remote 2024/04/25 03:51:03 INFO : B2 bucket rclone-test-hemoxiz2mijihil7ribitul2: cleaning bucket "rclone-test-hemoxiz2mijihil7ribitul2" of all files 2024/04/25 03:51:04 DEBUG : BackupDir/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03d97_d20240425_m034836_c001_v7007000_t0000_u01714016916054") 2024/04/25 03:51:04 DEBUG : BackupDir/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f11309105c89fe24f_d20240425_m034829_c001_v0001172_t0013_u01714016909357") 2024/04/25 03:51:04 DEBUG : CompareDest/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f4184ecc6980a66d9_d20240425_m034813_c001_v7007000_t0000_u01714016893888") 2024/04/25 03:51:04 DEBUG : CompareDest/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1cbb_d20240425_m034807_c001_v0001026_t0029_u01714016887296") 2024/04/25 03:51:04 DEBUG : CompareDest/two: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f4184ecc6980a66db_d20240425_m034814_c001_v7007000_t0000_u01714016894070") 2024/04/25 03:51:04 DEBUG : CompareDest/two: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbbc13_d20240425_m034809_c001_v0001181_t0037_u01714016889119") 2024/04/25 03:51:04 DEBUG : CopyDest/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03d98_d20240425_m034836_c001_v7007000_t0000_u01714016916236") 2024/04/25 03:51:04 DEBUG : CopyDest/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098e60_d20240425_m034827_c001_v0001099_t0011_u01714016907050") 2024/04/25 03:51:04 DEBUG : CopyDest/three: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03d9a_d20240425_m034836_c001_v7007000_t0000_u01714016916431") 2024/04/25 03:51:04 DEBUG : CopyDest/three: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbbf11_d20240425_m034833_c001_v0001181_t0022_u01714016913826") 2024/04/25 03:51:04 DEBUG : CopyDest/two: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03d9b_d20240425_m034836_c001_v7007000_t0000_u01714016916628") 2024/04/25 03:51:04 DEBUG : CopyDest/two: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1ce5_d20240425_m034830_c001_v0001026_t0006_u01714016910883") 2024/04/25 03:51:04 DEBUG : EXISTING: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40074547cace2181_d20240425_m035002_c001_v7007000_t0000_u01714017002815") 2024/04/25 03:51:04 DEBUG : EXISTING: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1dc9_d20240425_m035001_c001_v0001026_t0033_u01714017001531") 2024/04/25 03:51:04 DEBUG : Testêé: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40074547cace2175_d20240425_m034957_c001_v7007000_t0000_u01714016997371") 2024/04/25 03:51:04 DEBUG : Testêé: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbc9f9_d20240425_m034956_c001_v0001181_t0049_u01714016996729") 2024/04/25 03:51:04 DEBUG : Testêé: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1dbb_d20240425_m034955_c001_v0001026_t0004_u01714016995290") 2024/04/25 03:51:05 DEBUG : a/potato2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40137b6632333945_d20240425_m034630_c001_v7007000_t0000_u01714016790258") 2024/04/25 03:51:05 DEBUG : a/potato2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098c70_d20240425_m034629_c001_v0001099_t0045_u01714016789542") 2024/04/25 03:51:05 DEBUG : a/potato2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c65c_d20240425_m034627_c001_v7007000_t0000_u01714016787384") 2024/04/25 03:51:05 DEBUG : a/potato2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098c5e_d20240425_m034626_c001_v0001099_t0012_u01714016786417") 2024/04/25 03:51:05 DEBUG : a/potato2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40137b6632333911_d20240425_m034603_c001_v7007000_t0000_u01714016763840") 2024/04/25 03:51:05 DEBUG : a/potato2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098bea_d20240425_m034602_c001_v0001099_t0030_u01714016762712") 2024/04/25 03:51:05 DEBUG : b/potato: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40137b6632333946_d20240425_m034630_c001_v7007000_t0000_u01714016790439") 2024/04/25 03:51:05 DEBUG : b/potato: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098c68_d20240425_m034628_c001_v0001099_t0059_u01714016788386") 2024/04/25 03:51:05 DEBUG : b/potato: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c65b_d20240425_m034626_c001_v7007000_t0000_u01714016786822") 2024/04/25 03:51:05 DEBUG : b/potato: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098c56_d20240425_m034625_c001_v0001099_t0058_u01714016785141") 2024/04/25 03:51:05 DEBUG : b/potato: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40137b6632333910_d20240425_m034603_c001_v7007000_t0000_u01714016763269") 2024/04/25 03:51:05 DEBUG : b/potato: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098be0_d20240425_m034601_c001_v0001099_t0052_u01714016761415") 2024/04/25 03:51:05 DEBUG : backup/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03db5_d20240425_m034849_c001_v7007000_t0000_u01714016929492") 2024/04/25 03:51:05 DEBUG : backup/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1102ad97fbd9b977_d20240425_m034846_c001_v0001181_t0024_u01714016926978") 2024/04/25 03:51:05 DEBUG : backup/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f112ce6248ae7820b_d20240425_m034842_c001_v0001179_t0019_u01714016922626") 2024/04/25 03:51:05 DEBUG : backup/one-2019-01-01: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03df1_d20240425_m034916_c001_v7007000_t0000_u01714016956025") 2024/04/25 03:51:05 DEBUG : backup/one-2019-01-01: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f107ffbc60412380d_d20240425_m034913_c001_v0001179_t0011_u01714016953639") 2024/04/25 03:51:05 DEBUG : backup/one-2019-01-01: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f116fdcb6c52eb678_d20240425_m034909_c001_v0001179_t0049_u01714016949377") 2024/04/25 03:51:05 DEBUG : backup/one.bak: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03dd0_d20240425_m034902_c001_v7007000_t0000_u01714016942986") 2024/04/25 03:51:06 DEBUG : backup/one.bak: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f112d32261dc92cae_d20240425_m034900_c001_v0001100_t0030_u01714016940647") 2024/04/25 03:51:06 DEBUG : backup/one.bak: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1170607deafde1bc_d20240425_m034855_c001_v0001033_t0005_u01714016935594") 2024/04/25 03:51:06 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03df2_d20240425_m034916_c001_v7007000_t0000_u01714016956208") 2024/04/25 03:51:06 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1123e1d3632912b0_d20240425_m034915_c001_v0001172_t0007_u01714016955117") 2024/04/25 03:51:06 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1102ad97fbd9bdb5_d20240425_m034911_c001_v0001181_t0024_u01714016951600") 2024/04/25 03:51:06 DEBUG : backup/three.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03db7_d20240425_m034849_c001_v7007000_t0000_u01714016929674") 2024/04/25 03:51:06 DEBUG : backup/three.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f112a47e471ec4f46_d20240425_m034848_c001_v0001176_t0008_u01714016928679") 2024/04/25 03:51:06 DEBUG : backup/three.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f106da6540ded6357_d20240425_m034844_c001_v0001120_t0056_u01714016924163") 2024/04/25 03:51:06 DEBUG : backup/three.txt.bak: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03dd1_d20240425_m034903_c001_v7007000_t0000_u01714016943168") 2024/04/25 03:51:06 DEBUG : backup/three.txt.bak: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f112ce6248ae78525_d20240425_m034902_c001_v0001179_t0034_u01714016942206") 2024/04/25 03:51:06 DEBUG : backup/three.txt.bak: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1137482dc4259d73_d20240425_m034858_c001_v0001031_t0016_u01714016938069") 2024/04/25 03:51:06 DEBUG : both0: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7bf8_d20240425_m035050_c001_v7007000_t0000_u01714017050768") 2024/04/25 03:51:06 DEBUG : both0: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a0990ce_d20240425_m035030_c001_v0001099_t0021_u01714017030539") 2024/04/25 03:51:06 DEBUG : both0: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419e0e3b778255d8_d20240425_m035025_c001_v7007000_t0000_u01714017025928") 2024/04/25 03:51:06 DEBUG : both0: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbcb3f_d20240425_m035005_c001_v0001181_t0051_u01714017005089") 2024/04/25 03:51:06 DEBUG : both1: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7bf9_d20240425_m035050_c001_v7007000_t0000_u01714017050950") 2024/04/25 03:51:06 DEBUG : both1: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbcf58_d20240425_m035032_c001_v0001181_t0014_u01714017032163") 2024/04/25 03:51:06 DEBUG : both1: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419e0e3b778255d9_d20240425_m035026_c001_v7007000_t0000_u01714017026109") 2024/04/25 03:51:06 DEBUG : both1: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1dcf_d20240425_m035005_c001_v0001026_t0002_u01714017005953") 2024/04/25 03:51:06 DEBUG : both10: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7bfa_d20240425_m035051_c001_v7007000_t0000_u01714017051130") 2024/04/25 03:51:07 DEBUG : both10: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbd03e_d20240425_m035039_c001_v0001181_t0013_u01714017039875") 2024/04/25 03:51:07 DEBUG : both10: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419e0e3b778255db_d20240425_m035026_c001_v7007000_t0000_u01714017026290") 2024/04/25 03:51:07 DEBUG : both10: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1deb_d20240425_m035014_c001_v0001026_t0029_u01714017014531") 2024/04/25 03:51:07 DEBUG : both11: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7bfb_d20240425_m035051_c001_v7007000_t0000_u01714017051312") 2024/04/25 03:51:07 DEBUG : both11: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1e30_d20240425_m035040_c001_v0001026_t0016_u01714017040664") 2024/04/25 03:51:07 DEBUG : both11: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419e0e3b778255dc_d20240425_m035026_c001_v7007000_t0000_u01714017026471") 2024/04/25 03:51:07 DEBUG : both11: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a09907a_d20240425_m035015_c001_v0001099_t0032_u01714017015221") 2024/04/25 03:51:07 DEBUG : both12: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7bfd_d20240425_m035051_c001_v7007000_t0000_u01714017051492") 2024/04/25 03:51:07 DEBUG : both12: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a09910e_d20240425_m035041_c001_v0001099_t0057_u01714017041364") 2024/04/25 03:51:07 DEBUG : both12: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419e0e3b778255dd_d20240425_m035026_c001_v7007000_t0000_u01714017026651") 2024/04/25 03:51:07 DEBUG : both12: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbccfd_d20240425_m035016_c001_v0001181_t0004_u01714017016271") 2024/04/25 03:51:07 DEBUG : both13: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c00_d20240425_m035051_c001_v7007000_t0000_u01714017051673") 2024/04/25 03:51:07 DEBUG : both13: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbd0ab_d20240425_m035042_c001_v0001181_t0043_u01714017042590") 2024/04/25 03:51:07 DEBUG : both13: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419e0e3b778255de_d20240425_m035026_c001_v7007000_t0000_u01714017026832") 2024/04/25 03:51:07 DEBUG : both13: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1df7_d20240425_m035016_c001_v0001026_t0037_u01714017016880") 2024/04/25 03:51:07 DEBUG : both14: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c03_d20240425_m035051_c001_v7007000_t0000_u01714017051854") 2024/04/25 03:51:07 DEBUG : both14: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1e36_d20240425_m035043_c001_v0001026_t0024_u01714017043274") 2024/04/25 03:51:07 DEBUG : both14: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419e0e3b778255df_d20240425_m035027_c001_v7007000_t0000_u01714017027012") 2024/04/25 03:51:07 DEBUG : both14: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a09908e_d20240425_m035017_c001_v0001099_t0027_u01714017017946") 2024/04/25 03:51:08 DEBUG : both15: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c04_d20240425_m035052_c001_v7007000_t0000_u01714017052036") 2024/04/25 03:51:08 DEBUG : both15: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a09911c_d20240425_m035044_c001_v0001099_t0028_u01714017044278") 2024/04/25 03:51:08 DEBUG : both15: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419e0e3b778255e0_d20240425_m035027_c001_v7007000_t0000_u01714017027193") 2024/04/25 03:51:08 DEBUG : both15: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbcd92_d20240425_m035018_c001_v0001181_t0052_u01714017018708") 2024/04/25 03:51:08 DEBUG : both16: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c05_d20240425_m035052_c001_v7007000_t0000_u01714017052217") 2024/04/25 03:51:08 DEBUG : both16: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbd111_d20240425_m035045_c001_v0001181_t0042_u01714017045322") 2024/04/25 03:51:08 DEBUG : both16: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419e0e3b778255e3_d20240425_m035027_c001_v7007000_t0000_u01714017027374") 2024/04/25 03:51:08 DEBUG : both16: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1e03_d20240425_m035019_c001_v0001026_t0043_u01714017019373") 2024/04/25 03:51:08 DEBUG : both17: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c06_d20240425_m035052_c001_v7007000_t0000_u01714017052407") 2024/04/25 03:51:08 DEBUG : both17: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1e44_d20240425_m035046_c001_v0001026_t0028_u01714017046126") 2024/04/25 03:51:08 DEBUG : both17: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419e0e3b778255e4_d20240425_m035027_c001_v7007000_t0000_u01714017027569") 2024/04/25 03:51:08 DEBUG : both17: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a0990a2_d20240425_m035020_c001_v0001099_t0004_u01714017020271") 2024/04/25 03:51:08 DEBUG : both18: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c07_d20240425_m035052_c001_v7007000_t0000_u01714017052601") 2024/04/25 03:51:08 DEBUG : both18: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a09912a_d20240425_m035046_c001_v0001099_t0029_u01714017046922") 2024/04/25 03:51:08 DEBUG : both18: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419e0e3b778255e6_d20240425_m035027_c001_v7007000_t0000_u01714017027751") 2024/04/25 03:51:08 DEBUG : both18: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbce02_d20240425_m035021_c001_v0001181_t0014_u01714017021607") 2024/04/25 03:51:08 DEBUG : both19: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c09_d20240425_m035052_c001_v7007000_t0000_u01714017052783") 2024/04/25 03:51:09 DEBUG : both19: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbd163_d20240425_m035047_c001_v0001181_t0050_u01714017047683") 2024/04/25 03:51:09 DEBUG : both19: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419e0e3b778255e7_d20240425_m035027_c001_v7007000_t0000_u01714017027931") 2024/04/25 03:51:09 DEBUG : both19: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1e0b_d20240425_m035022_c001_v0001026_t0005_u01714017022326") 2024/04/25 03:51:09 DEBUG : both2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c0a_d20240425_m035052_c001_v7007000_t0000_u01714017052965") 2024/04/25 03:51:09 DEBUG : both2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1e1f_d20240425_m035032_c001_v0001026_t0020_u01714017032754") 2024/04/25 03:51:09 DEBUG : both2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419e0e3b778255e8_d20240425_m035028_c001_v7007000_t0000_u01714017028113") 2024/04/25 03:51:09 DEBUG : both2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a09903e_d20240425_m035007_c001_v0001099_t0025_u01714017007161") 2024/04/25 03:51:09 DEBUG : both3: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c0b_d20240425_m035053_c001_v7007000_t0000_u01714017053146") 2024/04/25 03:51:09 DEBUG : both3: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a0990e4_d20240425_m035033_c001_v0001099_t0039_u01714017033830") 2024/04/25 03:51:09 DEBUG : both3: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419e0e3b778255ea_d20240425_m035028_c001_v7007000_t0000_u01714017028295") 2024/04/25 03:51:09 DEBUG : both3: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbcba9_d20240425_m035008_c001_v0001181_t0039_u01714017008233") 2024/04/25 03:51:09 DEBUG : both4: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c0d_d20240425_m035053_c001_v7007000_t0000_u01714017053326") 2024/04/25 03:51:09 DEBUG : both4: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbcfb2_d20240425_m035034_c001_v0001181_t0032_u01714017034849") 2024/04/25 03:51:09 DEBUG : both4: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419e0e3b778255eb_d20240425_m035028_c001_v7007000_t0000_u01714017028477") 2024/04/25 03:51:09 DEBUG : both4: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1dd7_d20240425_m035009_c001_v0001026_t0024_u01714017009164") 2024/04/25 03:51:09 DEBUG : both5: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c0e_d20240425_m035053_c001_v7007000_t0000_u01714017053507") 2024/04/25 03:51:09 DEBUG : both5: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1e25_d20240425_m035035_c001_v0001026_t0018_u01714017035502") 2024/04/25 03:51:09 DEBUG : both5: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419e0e3b778255ec_d20240425_m035028_c001_v7007000_t0000_u01714017028670") 2024/04/25 03:51:09 DEBUG : both5: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a099054_d20240425_m035010_c001_v0001099_t0012_u01714017010026") 2024/04/25 03:51:09 DEBUG : both6: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c10_d20240425_m035053_c001_v7007000_t0000_u01714017053706") 2024/04/25 03:51:10 DEBUG : both6: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a0990f2_d20240425_m035036_c001_v0001099_t0050_u01714017036448") 2024/04/25 03:51:10 DEBUG : both6: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419e0e3b778255ee_d20240425_m035028_c001_v7007000_t0000_u01714017028852") 2024/04/25 03:51:10 DEBUG : both6: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbcc11_d20240425_m035011_c001_v0001181_t0008_u01714017011115") 2024/04/25 03:51:10 DEBUG : both7: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c11_d20240425_m035053_c001_v7007000_t0000_u01714017053889") 2024/04/25 03:51:10 DEBUG : both7: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbd000_d20240425_m035037_c001_v0001181_t0049_u01714017037341") 2024/04/25 03:51:10 DEBUG : both7: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419e0e3b778255f0_d20240425_m035029_c001_v7007000_t0000_u01714017029035") 2024/04/25 03:51:10 DEBUG : both7: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1ddf_d20240425_m035011_c001_v0001026_t0035_u01714017011743") 2024/04/25 03:51:10 DEBUG : both8: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c12_d20240425_m035054_c001_v7007000_t0000_u01714017054074") 2024/04/25 03:51:10 DEBUG : both8: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1e2a_d20240425_m035038_c001_v0001026_t0010_u01714017038050") 2024/04/25 03:51:10 DEBUG : both8: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419e0e3b778255f1_d20240425_m035029_c001_v7007000_t0000_u01714017029216") 2024/04/25 03:51:10 DEBUG : both8: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a099068_d20240425_m035012_c001_v0001099_t0048_u01714017012891") 2024/04/25 03:51:10 DEBUG : both9: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c13_d20240425_m035054_c001_v7007000_t0000_u01714017054255") 2024/04/25 03:51:10 DEBUG : both9: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a099100_d20240425_m035039_c001_v0001099_t0003_u01714017039024") 2024/04/25 03:51:10 DEBUG : both9: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419e0e3b778255f2_d20240425_m035029_c001_v7007000_t0000_u01714017029403") 2024/04/25 03:51:10 DEBUG : both9: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbcc7b_d20240425_m035013_c001_v0001181_t0002_u01714017013866") 2024/04/25 03:51:10 DEBUG : c/non empty space: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40137b6632333947_d20240425_m034630_c001_v7007000_t0000_u01714016790648") 2024/04/25 03:51:10 DEBUG : c/non empty space: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098c6a_d20240425_m034628_c001_v0001099_t0053_u01714016788768") 2024/04/25 03:51:10 DEBUG : c/non empty space: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c65d_d20240425_m034627_c001_v7007000_t0000_u01714016787572") 2024/04/25 03:51:10 DEBUG : c/non empty space: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098c5a_d20240425_m034625_c001_v0001099_t0020_u01714016785675") 2024/04/25 03:51:11 DEBUG : c/non empty space: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40137b6632333912_d20240425_m034604_c001_v7007000_t0000_u01714016764022") 2024/04/25 03:51:11 DEBUG : c/non empty space: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098be4_d20240425_m034601_c001_v0001099_t0037_u01714016761966") 2024/04/25 03:51:11 DEBUG : check sum: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40524a78a48ae341_d20240425_m034550_c001_v7007000_t0000_u01714016750497") 2024/04/25 03:51:11 DEBUG : check sum: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098b98_d20240425_m034549_c001_v0001099_t0048_u01714016749384") 2024/04/25 03:51:11 DEBUG : dest/3: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f4184ecc6980a66e8_d20240425_m034820_c001_v7007000_t0000_u01714016900793") 2024/04/25 03:51:11 DEBUG : dest/3: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f410a91ebec059a60_d20240425_m034820_c001_v0001037_t0040_u01714016900053") 2024/04/25 03:51:11 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40074547cace2165_d20240425_m034953_c001_v7007000_t0000_u01714016993803") 2024/04/25 03:51:11 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f10116161ecde1516_d20240425_m034951_c001_v0001093_t0019_u01714016991061") 2024/04/25 03:51:11 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40074547cace2155_d20240425_m034950_c001_v7007000_t0000_u01714016990880") 2024/04/25 03:51:11 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f10116161ecde1510_d20240425_m034948_c001_v0001093_t0012_u01714016988134") 2024/04/25 03:51:11 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40074547cace2138_d20240425_m034947_c001_v7007000_t0000_u01714016987411") 2024/04/25 03:51:11 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1d9b_d20240425_m034943_c001_v0001026_t0014_u01714016983143") 2024/04/25 03:51:11 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40074547cace2105_d20240425_m034941_c001_v7007000_t0000_u01714016981666") 2024/04/25 03:51:11 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f103cc0ece3e2ca84_d20240425_m034938_c001_v0001025_t0036_u01714016978680") 2024/04/25 03:51:11 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40074547cace20ec_d20240425_m034938_c001_v7007000_t0000_u01714016978499") 2024/04/25 03:51:11 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f103cc0ece3e2ca7e_d20240425_m034934_c001_v0001025_t0043_u01714016974845") 2024/04/25 03:51:11 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40074547cace20cd_d20240425_m034934_c001_v7007000_t0000_u01714016974111") 2024/04/25 03:51:11 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1d75_d20240425_m034929_c001_v0001026_t0035_u01714016969535") 2024/04/25 03:51:11 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40074547cace20ba_d20240425_m034928_c001_v7007000_t0000_u01714016968170") 2024/04/25 03:51:11 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f100b3989fe9fb48e_d20240425_m034926_c001_v0001179_t0015_u01714016966589") 2024/04/25 03:51:12 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03e07_d20240425_m034926_c001_v7007000_t0000_u01714016966403") 2024/04/25 03:51:12 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f100b3989fe9fb3f8_d20240425_m034922_c001_v0001179_t0045_u01714016962362") 2024/04/25 03:51:12 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03e01_d20240425_m034921_c001_v7007000_t0000_u01714016961611") 2024/04/25 03:51:12 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098f40_d20240425_m034917_c001_v0001099_t0054_u01714016957316") 2024/04/25 03:51:12 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03df3_d20240425_m034916_c001_v7007000_t0000_u01714016956389") 2024/04/25 03:51:12 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f110a0aab214c901e_d20240425_m034914_c001_v0001120_t0042_u01714016954225") 2024/04/25 03:51:12 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03dec_d20240425_m034914_c001_v7007000_t0000_u01714016954028") 2024/04/25 03:51:12 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f110a0aab214c9012_d20240425_m034910_c001_v0001120_t0056_u01714016950319") 2024/04/25 03:51:12 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03de4_d20240425_m034909_c001_v7007000_t0000_u01714016949571") 2024/04/25 03:51:12 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbc2da_d20240425_m034904_c001_v0001181_t0037_u01714016944304") 2024/04/25 03:51:12 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03dd3_d20240425_m034903_c001_v7007000_t0000_u01714016943376") 2024/04/25 03:51:12 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1018bf9cb48a66da_d20240425_m034901_c001_v0001145_t0040_u01714016941148") 2024/04/25 03:51:12 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03dce_d20240425_m034900_c001_v7007000_t0000_u01714016940964") 2024/04/25 03:51:12 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1018bf9cb48a66ce_d20240425_m034857_c001_v0001145_t0058_u01714016937037") 2024/04/25 03:51:12 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03dc6_d20240425_m034856_c001_v7007000_t0000_u01714016936281") 2024/04/25 03:51:12 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1d17_d20240425_m034850_c001_v0001026_t0028_u01714016930808") 2024/04/25 03:51:12 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03db8_d20240425_m034849_c001_v7007000_t0000_u01714016929876") 2024/04/25 03:51:12 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f114bd4e13e6cd50b_d20240425_m034847_c001_v0001136_t0053_u01714016927384") 2024/04/25 03:51:12 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03db0_d20240425_m034847_c001_v7007000_t0000_u01714016927201") 2024/04/25 03:51:12 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f114bd4e13e6cd4ff_d20240425_m034843_c001_v0001136_t0000_u01714016923597") 2024/04/25 03:51:13 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03dab_d20240425_m034842_c001_v7007000_t0000_u01714016922855") 2024/04/25 03:51:13 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098e8a_d20240425_m034837_c001_v0001099_t0030_u01714016917935") 2024/04/25 03:51:13 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03d9c_d20240425_m034836_c001_v7007000_t0000_u01714016916832") 2024/04/25 03:51:13 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1124adb3ec95ab06_d20240425_m034829_c001_v0001039_t0046_u01714016909876") 2024/04/25 03:51:13 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f4184ecc6980a66f5_d20240425_m034829_c001_v7007000_t0000_u01714016909666") 2024/04/25 03:51:13 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbbe1b_d20240425_m034826_c001_v0001181_t0049_u01714016906417") 2024/04/25 03:51:13 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1088ebd2049d4f9b_d20240425_m034825_c001_v0001030_t0002_u01714016905082") 2024/04/25 03:51:13 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1088ebd2049d4f91_d20240425_m034823_c001_v0001030_t0040_u01714016903407") 2024/04/25 03:51:13 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f4184ecc6980a66dc_d20240425_m034814_c001_v7007000_t0000_u01714016894253") 2024/04/25 03:51:13 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098e12_d20240425_m034806_c001_v0001099_t0050_u01714016886391") 2024/04/25 03:51:13 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118ad4464f64f2fe_d20240425_m034805_c001_v0001023_t0040_u01714016885306") 2024/04/25 03:51:13 DEBUG : dst/one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118ad4464f64f2f8_d20240425_m034803_c001_v0001023_t0036_u01714016883637") 2024/04/25 03:51:13 DEBUG : dst/one-2019-01-01: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40074547cace2168_d20240425_m034953_c001_v7007000_t0000_u01714016993986") 2024/04/25 03:51:13 DEBUG : dst/one-2019-01-01: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1039c1619184960d_d20240425_m034950_c001_v0001179_t0027_u01714016990650") 2024/04/25 03:51:13 DEBUG : dst/one-2019-01-01: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1037aa226ede7ed3_d20240425_m034947_c001_v0001100_t0048_u01714016987073") 2024/04/25 03:51:13 DEBUG : dst/one.bak: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40074547cace2109_d20240425_m034941_c001_v7007000_t0000_u01714016981849") 2024/04/25 03:51:13 DEBUG : dst/one.bak: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f11113b9451583d1b_d20240425_m034938_c001_v0001177_t0038_u01714016978161") 2024/04/25 03:51:13 DEBUG : dst/one.bak: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f103e8c15ce2a2bb3_d20240425_m034933_c001_v0001157_t0013_u01714016973662") 2024/04/25 03:51:13 DEBUG : dst/one.bak: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40074547cace20bb_d20240425_m034928_c001_v7007000_t0000_u01714016968368") 2024/04/25 03:51:14 DEBUG : dst/one.bak: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1154cb15ad12dedc_d20240425_m034925_c001_v0001026_t0008_u01714016965350") 2024/04/25 03:51:14 DEBUG : dst/one.bak: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f104485c63b7b1e2c_d20240425_m034921_c001_v0001154_t0004_u01714016961306") 2024/04/25 03:51:14 DEBUG : dst/three: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03d9d_d20240425_m034837_c001_v7007000_t0000_u01714016917013") 2024/04/25 03:51:14 DEBUG : dst/three: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1088ebd2049d4faf_d20240425_m034834_c001_v0001030_t0037_u01714016914999") 2024/04/25 03:51:14 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40074547cace2169_d20240425_m034954_c001_v7007000_t0000_u01714016994170") 2024/04/25 03:51:14 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f106add3ad5c111b6_d20240425_m034952_c001_v0001179_t0049_u01714016992113") 2024/04/25 03:51:14 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f113c1c2fd8015454_d20240425_m034949_c001_v0001134_t0031_u01714016989027") 2024/04/25 03:51:14 DEBUG : dst/three.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40074547cace216a_d20240425_m034954_c001_v7007000_t0000_u01714016994352") 2024/04/25 03:51:14 DEBUG : dst/three.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f10116161ecde151e_d20240425_m034952_c001_v0001093_t0001_u01714016992516") 2024/04/25 03:51:14 DEBUG : dst/three.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40074547cace215f_d20240425_m034952_c001_v7007000_t0000_u01714016992322") 2024/04/25 03:51:14 DEBUG : dst/three.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f10116161ecde1514_d20240425_m034949_c001_v0001093_t0036_u01714016989521") 2024/04/25 03:51:14 DEBUG : dst/three.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40074547cace2149_d20240425_m034949_c001_v7007000_t0000_u01714016989340") 2024/04/25 03:51:14 DEBUG : dst/three.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098fc8_d20240425_m034944_c001_v0001099_t0051_u01714016984485") 2024/04/25 03:51:14 DEBUG : dst/three.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40074547cace210b_d20240425_m034942_c001_v7007000_t0000_u01714016982031") 2024/04/25 03:51:14 DEBUG : dst/three.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f103cc0ece3e2ca92_d20240425_m034940_c001_v0001025_t0010_u01714016980722") 2024/04/25 03:51:14 DEBUG : dst/three.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40074547cace2100_d20240425_m034940_c001_v7007000_t0000_u01714016980541") 2024/04/25 03:51:14 DEBUG : dst/three.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f103cc0ece3e2ca80_d20240425_m034936_c001_v0001025_t0025_u01714016976770") 2024/04/25 03:51:14 DEBUG : dst/three.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40074547cace20dd_d20240425_m034936_c001_v7007000_t0000_u01714016976573") 2024/04/25 03:51:14 DEBUG : dst/three.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098f80_d20240425_m034931_c001_v0001099_t0004_u01714016971196") 2024/04/25 03:51:14 DEBUG : dst/three.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03e0a_d20240425_m034927_c001_v7007000_t0000_u01714016967227") 2024/04/25 03:51:14 DEBUG : dst/three.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098f5e_d20240425_m034924_c001_v0001099_t0008_u01714016964346") 2024/04/25 03:51:15 DEBUG : dst/three.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03e04_d20240425_m034923_c001_v7007000_t0000_u01714016963590") 2024/04/25 03:51:15 DEBUG : dst/three.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbc4de_d20240425_m034918_c001_v0001181_t0014_u01714016958951") 2024/04/25 03:51:15 DEBUG : dst/three.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03def_d20240425_m034915_c001_v7007000_t0000_u01714016955468") 2024/04/25 03:51:15 DEBUG : dst/three.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbc411_d20240425_m034912_c001_v0001181_t0053_u01714016952741") 2024/04/25 03:51:15 DEBUG : dst/three.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03de6_d20240425_m034911_c001_v7007000_t0000_u01714016951989") 2024/04/25 03:51:15 DEBUG : dst/three.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1d3d_d20240425_m034905_c001_v0001026_t0009_u01714016945624") 2024/04/25 03:51:15 DEBUG : dst/three.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03dcf_d20240425_m034902_c001_v7007000_t0000_u01714016942411") 2024/04/25 03:51:15 DEBUG : dst/three.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1d2d_d20240425_m034859_c001_v0001026_t0044_u01714016939390") 2024/04/25 03:51:15 DEBUG : dst/three.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03dca_d20240425_m034858_c001_v7007000_t0000_u01714016938631") 2024/04/25 03:51:15 DEBUG : dst/three.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098eca_d20240425_m034852_c001_v0001099_t0052_u01714016932382") 2024/04/25 03:51:15 DEBUG : dst/three.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03db4_d20240425_m034848_c001_v7007000_t0000_u01714016928935") 2024/04/25 03:51:15 DEBUG : dst/three.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098eb2_d20240425_m034845_c001_v0001099_t0033_u01714016925850") 2024/04/25 03:51:15 DEBUG : dst/three.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03dac_d20240425_m034845_c001_v7007000_t0000_u01714016925097") 2024/04/25 03:51:15 DEBUG : dst/three.txt: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbbfdf_d20240425_m034839_c001_v0001181_t0011_u01714016919615") 2024/04/25 03:51:15 DEBUG : dst/three.txt.bak: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40074547cace210f_d20240425_m034942_c001_v7007000_t0000_u01714016982213") 2024/04/25 03:51:15 DEBUG : dst/three.txt.bak: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f109b095c53b69ff2_d20240425_m034939_c001_v0001161_t0052_u01714016979753") 2024/04/25 03:51:15 DEBUG : dst/three.txt.bak: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f11309105c89fe609_d20240425_m034936_c001_v0001172_t0014_u01714016976132") 2024/04/25 03:51:16 DEBUG : dst/three.txt.bak: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40074547cace20bd_d20240425_m034928_c001_v7007000_t0000_u01714016968551") 2024/04/25 03:51:16 DEBUG : dst/three.txt.bak: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f114757fc50d6e320_d20240425_m034927_c001_v0001180_t0015_u01714016967020") 2024/04/25 03:51:16 DEBUG : dst/three.txt.bak: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f11517a0f6c71a48d_d20240425_m034923_c001_v0001128_t0037_u01714016963078") 2024/04/25 03:51:16 DEBUG : dst/two: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40074547cace216b_d20240425_m034954_c001_v7007000_t0000_u01714016994536") 2024/04/25 03:51:16 DEBUG : dst/two: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbc85c_d20240425_m034943_c001_v0001181_t0006_u01714016983901") 2024/04/25 03:51:16 DEBUG : dst/two: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40074547cace2110_d20240425_m034942_c001_v7007000_t0000_u01714016982395") 2024/04/25 03:51:16 DEBUG : dst/two: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbc686_d20240425_m034930_c001_v0001181_t0033_u01714016970406") 2024/04/25 03:51:16 DEBUG : dst/two: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40074547cace20be_d20240425_m034928_c001_v7007000_t0000_u01714016968733") 2024/04/25 03:51:16 DEBUG : dst/two: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1d55_d20240425_m034918_c001_v0001026_t0010_u01714016958048") 2024/04/25 03:51:16 DEBUG : dst/two: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03df4_d20240425_m034916_c001_v7007000_t0000_u01714016956572") 2024/04/25 03:51:16 DEBUG : dst/two: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098f02_d20240425_m034904_c001_v0001099_t0006_u01714016944926") 2024/04/25 03:51:16 DEBUG : dst/two: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03dd4_d20240425_m034903_c001_v7007000_t0000_u01714016943558") 2024/04/25 03:51:16 DEBUG : dst/two: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbc143_d20240425_m034851_c001_v0001181_t0044_u01714016931712") 2024/04/25 03:51:16 DEBUG : dst/two: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03db9_d20240425_m034850_c001_v7007000_t0000_u01714016930058") 2024/04/25 03:51:16 DEBUG : dst/two: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1cfb_d20240425_m034838_c001_v0001026_t0011_u01714016918725") 2024/04/25 03:51:16 DEBUG : dst/two: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03d9e_d20240425_m034837_c001_v7007000_t0000_u01714016917194") 2024/04/25 03:51:16 DEBUG : dst/two: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbbee5_d20240425_m034832_c001_v0001181_t0006_u01714016912388") 2024/04/25 03:51:16 DEBUG : dst/two: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f4184ecc6980a66dd_d20240425_m034814_c001_v7007000_t0000_u01714016894435") 2024/04/25 03:51:16 DEBUG : dst/two: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118ad4464f64f310_d20240425_m034812_c001_v0001023_t0032_u01714016892889") 2024/04/25 03:51:16 DEBUG : empty space: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03d26_d20240425_m034737_c001_v7007000_t0000_u01714016857119") 2024/04/25 03:51:16 DEBUG : empty space: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbb808_d20240425_m034733_c001_v0001181_t0059_u01714016853819") 2024/04/25 03:51:16 DEBUG : empty space: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03d1c_d20240425_m034731_c001_v7007000_t0000_u01714016851666") 2024/04/25 03:51:17 DEBUG : empty space: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbb6c7_d20240425_m034723_c001_v0001181_t0035_u01714016843349") 2024/04/25 03:51:17 DEBUG : empty space: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f4184ecc6980a65ad_d20240425_m034715_c001_v7007000_t0000_u01714016835342") 2024/04/25 03:51:17 DEBUG : empty space: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbb573_d20240425_m034712_c001_v0001181_t0023_u01714016832423") 2024/04/25 03:51:17 DEBUG : empty space: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c683_d20240425_m034645_c001_v7007000_t0000_u01714016805843") 2024/04/25 03:51:17 DEBUG : empty space: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098cca_d20240425_m034643_c001_v0001099_t0057_u01714016803720") 2024/04/25 03:51:17 DEBUG : empty space: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c679_d20240425_m034642_c001_v7007000_t0000_u01714016802018") 2024/04/25 03:51:17 DEBUG : empty space: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098cba_d20240425_m034640_c001_v0001099_t0045_u01714016800765") 2024/04/25 03:51:17 DEBUG : empty space: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c66d_d20240425_m034637_c001_v7007000_t0000_u01714016797043") 2024/04/25 03:51:17 DEBUG : empty space: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098c98_d20240425_m034634_c001_v0001099_t0033_u01714016794839") 2024/04/25 03:51:17 DEBUG : empty space: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40137b663233394e_d20240425_m034633_c001_v7007000_t0000_u01714016793569") 2024/04/25 03:51:17 DEBUG : empty space: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098c82_d20240425_m034631_c001_v0001099_t0057_u01714016791787") 2024/04/25 03:51:17 DEBUG : empty space: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40137b663233393c_d20240425_m034624_c001_v7007000_t0000_u01714016784236") 2024/04/25 03:51:17 DEBUG : empty space: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098c4a_d20240425_m034622_c001_v0001099_t0027_u01714016782633") 2024/04/25 03:51:17 DEBUG : empty space: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40137b6632333935_d20240425_m034621_c001_v7007000_t0000_u01714016781230") 2024/04/25 03:51:17 DEBUG : empty space: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098c36_d20240425_m034620_c001_v0001099_t0031_u01714016780370") 2024/04/25 03:51:17 DEBUG : empty space: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40137b6632333929_d20240425_m034613_c001_v7007000_t0000_u01714016773614") 2024/04/25 03:51:17 DEBUG : empty space: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098c10_d20240425_m034612_c001_v0001099_t0049_u01714016772168") 2024/04/25 03:51:17 DEBUG : empty space: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40137b6632333921_d20240425_m034609_c001_v7007000_t0000_u01714016769572") 2024/04/25 03:51:18 DEBUG : empty space: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098c02_d20240425_m034608_c001_v0001099_t0058_u01714016768344") 2024/04/25 03:51:18 DEBUG : empty space: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40137b663233391a_d20240425_m034607_c001_v7007000_t0000_u01714016767262") 2024/04/25 03:51:18 DEBUG : empty space: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f101ec5b1554a0c64_d20240425_m034606_c001_v0001181_t0047_u01714016766484") 2024/04/25 03:51:18 DEBUG : empty space: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098bee_d20240425_m034604_c001_v0001099_t0018_u01714016764754") 2024/04/25 03:51:18 DEBUG : enormous: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c680_d20240425_m034644_c001_v7007000_t0000_u01714016804931") 2024/04/25 03:51:18 DEBUG : enormous: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098ccc_d20240425_m034644_c001_v0001099_t0047_u01714016804097") 2024/04/25 03:51:18 DEBUG : existing: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40074547cace2178_d20240425_m034959_c001_v7007000_t0000_u01714016999984") 2024/04/25 03:51:18 DEBUG : existing: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a09900a_d20240425_m034958_c001_v0001099_t0042_u01714016998507") 2024/04/25 03:51:18 DEBUG : existing: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40137b66323339f0_d20240425_m034710_c001_v7007000_t0000_u01714016830203") 2024/04/25 03:51:18 DEBUG : existing: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098d40_d20240425_m034709_c001_v0001099_t0051_u01714016829010") 2024/04/25 03:51:18 DEBUG : existing: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40524a78a48ae357_d20240425_m034600_c001_v7007000_t0000_u01714016760318") 2024/04/25 03:51:18 DEBUG : existing: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098bd2_d20240425_m034559_c001_v0001099_t0028_u01714016759290") 2024/04/25 03:51:18 DEBUG : existing: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40524a78a48ae355_d20240425_m034558_c001_v7007000_t0000_u01714016758028") 2024/04/25 03:51:18 DEBUG : existing: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098bc6_d20240425_m034557_c001_v0001099_t0006_u01714016757211") 2024/04/25 03:51:18 DEBUG : existing: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098bc0_d20240425_m034556_c001_v0001099_t0030_u01714016756292") 2024/04/25 03:51:18 DEBUG : existing-b: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40137b66323339f1_d20240425_m034710_c001_v7007000_t0000_u01714016830384") 2024/04/25 03:51:18 DEBUG : existing-b: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbb507_d20240425_m034709_c001_v0001181_t0005_u01714016829020") 2024/04/25 03:51:18 DEBUG : five: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c68b_d20240425_m034650_c001_v7007000_t0000_u01714016810486") 2024/04/25 03:51:18 DEBUG : five: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f418126a15a098cec_d20240425_m034648_c001_v0001099_t0044_u01714016808372") 2024/04/25 03:51:18 DEBUG : foo: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40137b6632333926_d20240425_m034611_c001_v7007000_t0000_u01714016771442") 2024/04/25 03:51:19 DEBUG : foo: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f418126a15a098c0a_d20240425_m034610_c001_v0001099_t0044_u01714016770840") 2024/04/25 03:51:19 DEBUG : foo: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f418126a15a098c08_d20240425_m034610_c001_v0001099_t0044_u01714016770294") 2024/04/25 03:51:19 DEBUG : four: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c68d_d20240425_m034650_c001_v7007000_t0000_u01714016810688") 2024/04/25 03:51:19 DEBUG : four: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419dea16e15d1c37_d20240425_m034648_c001_v0001026_t0009_u01714016808966") 2024/04/25 03:51:19 DEBUG : four: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098ce2_d20240425_m034647_c001_v0001099_t0026_u01714016807683") 2024/04/25 03:51:19 DEBUG : hello world2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c57b_d20240425_m034529_c001_v7007000_t0000_u01714016729002") 2024/04/25 03:51:19 DEBUG : hello world2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098b39_d20240425_m034528_c001_v0001099_t0050_u01714016728261") 2024/04/25 03:51:19 DEBUG : ignore-size: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40524a78a48ae353_d20240425_m034555_c001_v7007000_t0000_u01714016755193") 2024/04/25 03:51:19 DEBUG : ignore-size: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098bb2_d20240425_m034554_c001_v0001099_t0006_u01714016754128") 2024/04/25 03:51:19 DEBUG : nested/sub dir/file: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40137b66323339eb_d20240425_m034707_c001_v7007000_t0000_u01714016827909") 2024/04/25 03:51:19 DEBUG : nested/sub dir/file: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbb4a9_d20240425_m034706_c001_v0001181_t0020_u01714016826503") 2024/04/25 03:51:19 DEBUG : nested/sub dir/file: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40137b66323339e7_d20240425_m034705_c001_v7007000_t0000_u01714016825368") 2024/04/25 03:51:19 DEBUG : nested/sub dir/file: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098d2e_d20240425_m034704_c001_v0001099_t0050_u01714016824486") 2024/04/25 03:51:19 DEBUG : one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c68e_d20240425_m034650_c001_v7007000_t0000_u01714016810874") 2024/04/25 03:51:19 DEBUG : one: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f418126a15a098cda_d20240425_m034646_c001_v0001099_t0044_u01714016806959") 2024/04/25 03:51:19 DEBUG : only0: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c14_d20240425_m035054_c001_v7007000_t0000_u01714017054437") 2024/04/25 03:51:19 DEBUG : only0: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419dea16e15d1e4e_d20240425_m035049_c001_v0001026_t0009_u01714017049013") 2024/04/25 03:51:19 DEBUG : only0: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1e1d_d20240425_m035031_c001_v0001026_t0001_u01714017031227") 2024/04/25 03:51:19 DEBUG : only0: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f4184ecc6980a681c_d20240425_m035024_c001_v7007000_t0000_u01714017024518") 2024/04/25 03:51:20 DEBUG : only0: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a09902e_d20240425_m035005_c001_v0001099_t0038_u01714017005681") 2024/04/25 03:51:20 DEBUG : only1: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c15_d20240425_m035054_c001_v7007000_t0000_u01714017054618") 2024/04/25 03:51:20 DEBUG : only1: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f4093b0e860bbd185_d20240425_m035049_c001_v0001181_t0011_u01714017049022") 2024/04/25 03:51:20 DEBUG : only1: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a0990da_d20240425_m035032_c001_v0001099_t0012_u01714017032406") 2024/04/25 03:51:20 DEBUG : only1: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419e0e3b778255cf_d20240425_m035024_c001_v7007000_t0000_u01714017024536") 2024/04/25 03:51:20 DEBUG : only1: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbcb87_d20240425_m035006_c001_v0001181_t0027_u01714017006880") 2024/04/25 03:51:20 DEBUG : only10: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c16_d20240425_m035054_c001_v7007000_t0000_u01714017054799") 2024/04/25 03:51:20 DEBUG : only10: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f418126a15a099142_d20240425_m035049_c001_v0001099_t0044_u01714017049032") 2024/04/25 03:51:20 DEBUG : only10: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a099106_d20240425_m035040_c001_v0001099_t0003_u01714017040130") 2024/04/25 03:51:20 DEBUG : only10: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f4184ecc6980a6823_d20240425_m035025_c001_v7007000_t0000_u01714017025158") 2024/04/25 03:51:20 DEBUG : only10: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbcca9_d20240425_m035014_c001_v0001181_t0042_u01714017014917") 2024/04/25 03:51:20 DEBUG : only11: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c1a_d20240425_m035054_c001_v7007000_t0000_u01714017054981") 2024/04/25 03:51:20 DEBUG : only11: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f41125b456b122142_d20240425_m035049_c001_v0001181_t0034_u01714017049613") 2024/04/25 03:51:20 DEBUG : only11: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbd06a_d20240425_m035041_c001_v0001181_t0045_u01714017041074") 2024/04/25 03:51:20 DEBUG : only11: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f4184ecc6980a681e_d20240425_m035024_c001_v7007000_t0000_u01714017024793") 2024/04/25 03:51:20 DEBUG : only11: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1def_d20240425_m035015_c001_v0001026_t0020_u01714017015635") 2024/04/25 03:51:20 DEBUG : only12: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c1b_d20240425_m035055_c001_v7007000_t0000_u01714017055164") 2024/04/25 03:51:20 DEBUG : only12: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419dea16e15d1e50_d20240425_m035049_c001_v0001026_t0009_u01714017049235") 2024/04/25 03:51:20 DEBUG : only12: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1e32_d20240425_m035041_c001_v0001026_t0019_u01714017041777") 2024/04/25 03:51:20 DEBUG : only12: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419e0e3b778255d1_d20240425_m035024_c001_v7007000_t0000_u01714017024899") 2024/04/25 03:51:21 DEBUG : only12: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a099086_d20240425_m035016_c001_v0001099_t0012_u01714017016568") 2024/04/25 03:51:21 DEBUG : only13: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c1e_d20240425_m035055_c001_v7007000_t0000_u01714017055344") 2024/04/25 03:51:21 DEBUG : only13: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f4093b0e860bbd18b_d20240425_m035049_c001_v0001181_t0011_u01714017049245") 2024/04/25 03:51:21 DEBUG : only13: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a099114_d20240425_m035042_c001_v0001099_t0055_u01714017042875") 2024/04/25 03:51:21 DEBUG : only13: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f403ae994ee281013_d20240425_m035025_c001_v7007000_t0000_u01714017025289") 2024/04/25 03:51:21 DEBUG : only13: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbcd5e_d20240425_m035017_c001_v0001181_t0017_u01714017017694") 2024/04/25 03:51:21 DEBUG : only14: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c20_d20240425_m035055_c001_v7007000_t0000_u01714017055536") 2024/04/25 03:51:21 DEBUG : only14: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f418126a15a099146_d20240425_m035049_c001_v0001099_t0044_u01714017049254") 2024/04/25 03:51:21 DEBUG : only14: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbd0e5_d20240425_m035043_c001_v0001181_t0010_u01714017043920") 2024/04/25 03:51:21 DEBUG : only14: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f403ae994ee28100d_d20240425_m035024_c001_v7007000_t0000_u01714017024910") 2024/04/25 03:51:21 DEBUG : only14: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1dff_d20240425_m035018_c001_v0001026_t0002_u01714017018245") 2024/04/25 03:51:21 DEBUG : only15: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c21_d20240425_m035055_c001_v7007000_t0000_u01714017055717") 2024/04/25 03:51:21 DEBUG : only15: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419dea16e15d1e52_d20240425_m035049_c001_v0001026_t0009_u01714017049418") 2024/04/25 03:51:21 DEBUG : only15: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1e3e_d20240425_m035044_c001_v0001026_t0044_u01714017044570") 2024/04/25 03:51:21 DEBUG : only15: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f403ae994ee28100a_d20240425_m035024_c001_v7007000_t0000_u01714017024551") 2024/04/25 03:51:21 DEBUG : only15: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a09909a_d20240425_m035019_c001_v0001099_t0033_u01714017019074") 2024/04/25 03:51:21 DEBUG : only16: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c22_d20240425_m035055_c001_v7007000_t0000_u01714017055911") 2024/04/25 03:51:21 DEBUG : only16: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f4093b0e860bbd18d_d20240425_m035049_c001_v0001181_t0011_u01714017049431") 2024/04/25 03:51:21 DEBUG : only16: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a099122_d20240425_m035045_c001_v0001099_t0047_u01714017045741") 2024/04/25 03:51:21 DEBUG : only16: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419e0e3b778255d5_d20240425_m035025_c001_v7007000_t0000_u01714017025299") 2024/04/25 03:51:22 DEBUG : only16: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbcdcc_d20240425_m035020_c001_v0001181_t0035_u01714017020044") 2024/04/25 03:51:22 DEBUG : only17: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c23_d20240425_m035056_c001_v7007000_t0000_u01714017056103") 2024/04/25 03:51:22 DEBUG : only17: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f418126a15a099148_d20240425_m035049_c001_v0001099_t0044_u01714017049442") 2024/04/25 03:51:22 DEBUG : only17: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbd139_d20240425_m035046_c001_v0001181_t0054_u01714017046685") 2024/04/25 03:51:22 DEBUG : only17: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419e0e3b778255d3_d20240425_m035025_c001_v7007000_t0000_u01714017025105") 2024/04/25 03:51:22 DEBUG : only17: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1e05_d20240425_m035021_c001_v0001026_t0012_u01714017021001") 2024/04/25 03:51:22 DEBUG : only18: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c25_d20240425_m035056_c001_v7007000_t0000_u01714017056285") 2024/04/25 03:51:22 DEBUG : only18: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419dea16e15d1e54_d20240425_m035049_c001_v0001026_t0009_u01714017049613") 2024/04/25 03:51:22 DEBUG : only18: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1e4a_d20240425_m035047_c001_v0001026_t0040_u01714017047188") 2024/04/25 03:51:22 DEBUG : only18: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419e0e3b778255d0_d20240425_m035024_c001_v7007000_t0000_u01714017024717") 2024/04/25 03:51:22 DEBUG : only18: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a0990a8_d20240425_m035021_c001_v0001099_t0056_u01714017021933") 2024/04/25 03:51:22 DEBUG : only19: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c27_d20240425_m035056_c001_v7007000_t0000_u01714017056466") 2024/04/25 03:51:22 DEBUG : only19: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f4093b0e860bbd199_d20240425_m035049_c001_v0001181_t0011_u01714017049622") 2024/04/25 03:51:22 DEBUG : only19: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a099136_d20240425_m035047_c001_v0001099_t0024_u01714017047958") 2024/04/25 03:51:22 DEBUG : only19: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f403ae994ee28100e_d20240425_m035024_c001_v7007000_t0000_u01714017024922") 2024/04/25 03:51:22 DEBUG : only19: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbce36_d20240425_m035022_c001_v0001181_t0006_u01714017022956") 2024/04/25 03:51:22 DEBUG : only2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c28_d20240425_m035056_c001_v7007000_t0000_u01714017056661") 2024/04/25 03:51:22 DEBUG : only2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f418126a15a09914c_d20240425_m035049_c001_v0001099_t0044_u01714017049633") 2024/04/25 03:51:22 DEBUG : only2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbcf85_d20240425_m035033_c001_v0001181_t0025_u01714017033598") 2024/04/25 03:51:22 DEBUG : only2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f4184ecc6980a6821_d20240425_m035024_c001_v7007000_t0000_u01714017024977") 2024/04/25 03:51:23 DEBUG : only2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1dd3_d20240425_m035007_c001_v0001026_t0032_u01714017007711") 2024/04/25 03:51:23 DEBUG : only3: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c29_d20240425_m035056_c001_v7007000_t0000_u01714017056842") 2024/04/25 03:51:23 DEBUG : only3: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419dea16e15d1e56_d20240425_m035049_c001_v0001026_t0009_u01714017049796") 2024/04/25 03:51:23 DEBUG : only3: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1e23_d20240425_m035034_c001_v0001026_t0042_u01714017034271") 2024/04/25 03:51:23 DEBUG : only3: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f403ae994ee28100b_d20240425_m035024_c001_v7007000_t0000_u01714017024729") 2024/04/25 03:51:23 DEBUG : only3: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a099046_d20240425_m035008_c001_v0001099_t0041_u01714017008505") 2024/04/25 03:51:23 DEBUG : only4: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c2a_d20240425_m035057_c001_v7007000_t0000_u01714017057023") 2024/04/25 03:51:23 DEBUG : only4: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f41125b456b12214a_d20240425_m035049_c001_v0001181_t0034_u01714017049806") 2024/04/25 03:51:23 DEBUG : only4: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a0990ee_d20240425_m035035_c001_v0001099_t0019_u01714017035139") 2024/04/25 03:51:23 DEBUG : only4: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f403ae994ee281009_d20240425_m035024_c001_v7007000_t0000_u01714017024547") 2024/04/25 03:51:23 DEBUG : only4: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbcbe1_d20240425_m035009_c001_v0001181_t0055_u01714017009805") 2024/04/25 03:51:23 DEBUG : only5: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c2b_d20240425_m035057_c001_v7007000_t0000_u01714017057204") 2024/04/25 03:51:23 DEBUG : only5: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f4093b0e860bbd1a3_d20240425_m035049_c001_v0001181_t0011_u01714017049815") 2024/04/25 03:51:23 DEBUG : only5: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbcfea_d20240425_m035036_c001_v0001181_t0004_u01714017036209") 2024/04/25 03:51:23 DEBUG : only5: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f4184ecc6980a681a_d20240425_m035024_c001_v7007000_t0000_u01714017024157") 2024/04/25 03:51:23 DEBUG : only5: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1ddb_d20240425_m035010_c001_v0001026_t0020_u01714017010328") 2024/04/25 03:51:23 DEBUG : only6: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c2c_d20240425_m035057_c001_v7007000_t0000_u01714017057394") 2024/04/25 03:51:23 DEBUG : only6: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f418126a15a099150_d20240425_m035049_c001_v0001099_t0044_u01714017049828") 2024/04/25 03:51:23 DEBUG : only6: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1e28_d20240425_m035036_c001_v0001026_t0006_u01714017036850") 2024/04/25 03:51:24 DEBUG : only6: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f403ae994ee28100c_d20240425_m035024_c001_v7007000_t0000_u01714017024739") 2024/04/25 03:51:24 DEBUG : only6: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a099062_d20240425_m035011_c001_v0001099_t0028_u01714017011319") 2024/04/25 03:51:24 DEBUG : only7: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c2d_d20240425_m035057_c001_v7007000_t0000_u01714017057575") 2024/04/25 03:51:24 DEBUG : only7: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419dea16e15d1e58_d20240425_m035049_c001_v0001026_t0009_u01714017049979") 2024/04/25 03:51:24 DEBUG : only7: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a0990f8_d20240425_m035037_c001_v0001099_t0027_u01714017037602") 2024/04/25 03:51:24 DEBUG : only7: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f4184ecc6980a681b_d20240425_m035024_c001_v7007000_t0000_u01714017024338") 2024/04/25 03:51:24 DEBUG : only7: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbcc47_d20240425_m035012_c001_v0001181_t0048_u01714017012504") 2024/04/25 03:51:24 DEBUG : only8: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c2e_d20240425_m035057_c001_v7007000_t0000_u01714017057756") 2024/04/25 03:51:24 DEBUG : only8: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f41125b456b12214e_d20240425_m035049_c001_v0001181_t0034_u01714017049988") 2024/04/25 03:51:24 DEBUG : only8: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbd01c_d20240425_m035038_c001_v0001181_t0037_u01714017038573") 2024/04/25 03:51:24 DEBUG : only8: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f403ae994ee281010_d20240425_m035025_c001_v7007000_t0000_u01714017025106") 2024/04/25 03:51:24 DEBUG : only8: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1de3_d20240425_m035013_c001_v0001026_t0024_u01714017013249") 2024/04/25 03:51:24 DEBUG : only9: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c30_d20240425_m035057_c001_v7007000_t0000_u01714017057939") 2024/04/25 03:51:24 DEBUG : only9: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f4093b0e860bbd1b1_d20240425_m035050_c001_v0001181_t0011_u01714017050002") 2024/04/25 03:51:24 DEBUG : only9: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1e2e_d20240425_m035039_c001_v0001026_t0005_u01714017039441") 2024/04/25 03:51:24 DEBUG : only9: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f403ae994ee281011_d20240425_m035025_c001_v7007000_t0000_u01714017025111") 2024/04/25 03:51:24 DEBUG : only9: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a099074_d20240425_m035014_c001_v0001099_t0044_u01714017014085") 2024/04/25 03:51:25 DEBUG : potato: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40137b66323339df_d20240425_m034702_c001_v7007000_t0000_u01714016822264") 2024/04/25 03:51:25 DEBUG : potato: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1c4f_d20240425_m034700_c001_v0001026_t0015_u01714016820056") 2024/04/25 03:51:25 DEBUG : potato: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c69d_d20240425_m034657_c001_v7007000_t0000_u01714016817838") 2024/04/25 03:51:25 DEBUG : potato: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098d08_d20240425_m034656_c001_v0001099_t0037_u01714016816072") 2024/04/25 03:51:25 DEBUG : potato: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c696_d20240425_m034654_c001_v7007000_t0000_u01714016814235") 2024/04/25 03:51:25 DEBUG : potato: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1c3d_d20240425_m034651_c001_v0001026_t0042_u01714016811804") 2024/04/25 03:51:25 DEBUG : potato: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c675_d20240425_m034639_c001_v7007000_t0000_u01714016799387") 2024/04/25 03:51:25 DEBUG : potato: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098ca6_d20240425_m034637_c001_v0001099_t0044_u01714016797958") 2024/04/25 03:51:25 DEBUG : potato: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c667_d20240425_m034635_c001_v7007000_t0000_u01714016795602") 2024/04/25 03:51:25 DEBUG : potato: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098c96_d20240425_m034634_c001_v0001099_t0015_u01714016794491") 2024/04/25 03:51:25 DEBUG : potato: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40137b663233394a_d20240425_m034632_c001_v7007000_t0000_u01714016792585") 2024/04/25 03:51:25 DEBUG : potato: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098c7e_d20240425_m034631_c001_v0001099_t0057_u01714016791374") 2024/04/25 03:51:25 DEBUG : potato: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40137b663233393a_d20240425_m034623_c001_v7007000_t0000_u01714016783691") 2024/04/25 03:51:25 DEBUG : potato: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098c44_d20240425_m034622_c001_v0001099_t0022_u01714016782166") 2024/04/25 03:51:25 DEBUG : potato: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40137b6632333936_d20240425_m034621_c001_v7007000_t0000_u01714016781432") 2024/04/25 03:51:25 DEBUG : potato: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098c32_d20240425_m034619_c001_v0001099_t0058_u01714016779737") 2024/04/25 03:51:25 DEBUG : potato: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40137b6632333931_d20240425_m034619_c001_v7007000_t0000_u01714016779014") 2024/04/25 03:51:26 DEBUG : potato: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098c2c_d20240425_m034617_c001_v0001099_t0021_u01714016777752") 2024/04/25 03:51:26 DEBUG : potato: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098c2a_d20240425_m034616_c001_v0001099_t0001_u01714016776884") 2024/04/25 03:51:26 DEBUG : potato: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40137b663233392e_d20240425_m034616_c001_v7007000_t0000_u01714016776159") 2024/04/25 03:51:26 DEBUG : potato: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098c20_d20240425_m034615_c001_v0001099_t0035_u01714016775449") 2024/04/25 03:51:26 DEBUG : potato: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098c1c_d20240425_m034614_c001_v0001099_t0000_u01714016774523") 2024/04/25 03:51:26 DEBUG : potato: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40137b663233392a_d20240425_m034613_c001_v7007000_t0000_u01714016773798") 2024/04/25 03:51:26 DEBUG : potato: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098c16_d20240425_m034612_c001_v0001099_t0013_u01714016772900") 2024/04/25 03:51:26 DEBUG : potato2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db797b_d20240425_m034745_c001_v7007000_t0000_u01714016865260") 2024/04/25 03:51:26 DEBUG : potato2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1c99_d20240425_m034744_c001_v0001026_t0025_u01714016864402") 2024/04/25 03:51:26 DEBUG : potato2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f419e0e3b77825335_d20240425_m034737_c001_v7007000_t0000_u01714016857407") 2024/04/25 03:51:26 DEBUG : potato2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1c83_d20240425_m034732_c001_v0001026_t0034_u01714016852695") 2024/04/25 03:51:26 DEBUG : potato2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03d15_d20240425_m034726_c001_v7007000_t0000_u01714016846800") 2024/04/25 03:51:26 DEBUG : potato2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1c6b_d20240425_m034722_c001_v0001026_t0016_u01714016842468") 2024/04/25 03:51:26 DEBUG : potato2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40137b66323339fe_d20240425_m034715_c001_v7007000_t0000_u01714016835563") 2024/04/25 03:51:26 DEBUG : potato2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1c5f_d20240425_m034711_c001_v0001026_t0010_u01714016831700") 2024/04/25 03:51:26 DEBUG : potato2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c682_d20240425_m034645_c001_v7007000_t0000_u01714016805111") 2024/04/25 03:51:26 DEBUG : potato2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098cc6_d20240425_m034643_c001_v0001099_t0019_u01714016803321") 2024/04/25 03:51:27 DEBUG : potato2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c67a_d20240425_m034642_c001_v7007000_t0000_u01714016802214") 2024/04/25 03:51:27 DEBUG : potato2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098cb4_d20240425_m034640_c001_v0001099_t0048_u01714016800298") 2024/04/25 03:51:27 DEBUG : potato2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c676_d20240425_m034639_c001_v7007000_t0000_u01714016799567") 2024/04/25 03:51:27 DEBUG : potato2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098cac_d20240425_m034638_c001_v0001099_t0049_u01714016798637") 2024/04/25 03:51:27 DEBUG : potato2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c670_d20240425_m034637_c001_v7007000_t0000_u01714016797229") 2024/04/25 03:51:27 DEBUG : potato2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098c9e_d20240425_m034635_c001_v0001099_t0002_u01714016795967") 2024/04/25 03:51:27 DEBUG : potato2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40137b6632333950_d20240425_m034633_c001_v7007000_t0000_u01714016793752") 2024/04/25 03:51:27 DEBUG : potato2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098c8a_d20240425_m034632_c001_v0001099_t0029_u01714016792595") 2024/04/25 03:51:27 DEBUG : potato2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40137b663233393e_d20240425_m034624_c001_v7007000_t0000_u01714016784417") 2024/04/25 03:51:27 DEBUG : potato2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098c4c_d20240425_m034623_c001_v0001099_t0057_u01714016783355") 2024/04/25 03:51:27 DEBUG : potato2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c596_d20240425_m034532_c001_v7007000_t0000_u01714016732925") 2024/04/25 03:51:27 DEBUG : potato2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098b4b_d20240425_m034532_c001_v0001099_t0005_u01714016732080") 2024/04/25 03:51:27 DEBUG : potato2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c585_d20240425_m034530_c001_v7007000_t0000_u01714016730822") 2024/04/25 03:51:27 DEBUG : potato2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098b3f_d20240425_m034529_c001_v0001099_t0000_u01714016729897") 2024/04/25 03:51:27 DEBUG : potato3: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40733e9547e03d2a_d20240425_m034737_c001_v7007000_t0000_u01714016857699") 2024/04/25 03:51:27 DEBUG : potato3: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098d9e_d20240425_m034734_c001_v0001099_t0037_u01714016854413") 2024/04/25 03:51:27 DEBUG : potato3: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db793b_d20240425_m034726_c001_v7007000_t0000_u01714016846820") 2024/04/25 03:51:27 DEBUG : potato3: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098d70_d20240425_m034724_c001_v0001099_t0014_u01714016844038") 2024/04/25 03:51:27 DEBUG : potato3: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f4184ecc6980a65af_d20240425_m034715_c001_v7007000_t0000_u01714016835779") 2024/04/25 03:51:27 DEBUG : potato3: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098d4a_d20240425_m034712_c001_v0001099_t0023_u01714016832672") 2024/04/25 03:51:27 DEBUG : pre-dest1/1: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f4184ecc6980a66e9_d20240425_m034820_c001_v7007000_t0000_u01714016900975") 2024/04/25 03:51:27 DEBUG : pre-dest1/1: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098e2a_d20240425_m034815_c001_v0001099_t0045_u01714016895196") 2024/04/25 03:51:28 DEBUG : pre-dest2/2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f4184ecc6980a66ea_d20240425_m034821_c001_v7007000_t0000_u01714016901160") 2024/04/25 03:51:28 DEBUG : pre-dest2/2: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1cc7_d20240425_m034815_c001_v0001026_t0005_u01714016895872") 2024/04/25 03:51:28 DEBUG : rclone-sync-test-ignore-file/.ignore: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f4184ecc6980a6604_d20240425_m034754_c001_v7007000_t0000_u01714016874226") 2024/04/25 03:51:28 DEBUG : rclone-sync-test-ignore-file/.ignore: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbb9d2_d20240425_m034750_c001_v0001181_t0031_u01714016870787") 2024/04/25 03:51:28 DEBUG : sizeonly: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40524a78a48ae34f_d20240425_m034552_c001_v7007000_t0000_u01714016752858") 2024/04/25 03:51:28 DEBUG : sizeonly: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098ba8_d20240425_m034551_c001_v0001099_t0028_u01714016751758") 2024/04/25 03:51:28 DEBUG : sub dir/hello world: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c3f_d20240425_m035102_c001_v7007000_t0000_u01714017062254") 2024/04/25 03:51:28 DEBUG : sub dir/hello world: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a099170_d20240425_m035059_c001_v0001099_t0007_u01714017059282") 2024/04/25 03:51:28 DEBUG : sub dir/hello world: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40137b66323339ec_d20240425_m034708_c001_v7007000_t0000_u01714016828091") 2024/04/25 03:51:28 DEBUG : sub dir/hello world: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1c5b_d20240425_m034706_c001_v0001026_t0040_u01714016826871") 2024/04/25 03:51:28 DEBUG : sub dir/hello world: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40137b66323339e8_d20240425_m034705_c001_v7007000_t0000_u01714016825550") 2024/04/25 03:51:28 DEBUG : sub dir/hello world: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbb45f_d20240425_m034704_c001_v0001181_t0024_u01714016824125") 2024/04/25 03:51:28 DEBUG : sub dir/hello world: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40524a78a48ae324_d20240425_m034548_c001_v7007000_t0000_u01714016748474") 2024/04/25 03:51:28 DEBUG : sub dir/hello world: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098b8c_d20240425_m034546_c001_v0001099_t0045_u01714016746799") 2024/04/25 03:51:28 DEBUG : sub dir/hello world: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40524a78a48ae302_d20240425_m034546_c001_v7007000_t0000_u01714016746071") 2024/04/25 03:51:28 DEBUG : sub dir/hello world: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098b84_d20240425_m034544_c001_v0001099_t0023_u01714016744825") 2024/04/25 03:51:28 DEBUG : sub dir/hello world: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c5ee_d20240425_m034544_c001_v7007000_t0000_u01714016744098") 2024/04/25 03:51:28 DEBUG : sub dir/hello world: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098b6d_d20240425_m034539_c001_v0001099_t0057_u01714016739879") 2024/04/25 03:51:28 DEBUG : sub dir/hello world: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c5c4_d20240425_m034538_c001_v7007000_t0000_u01714016738800") 2024/04/25 03:51:29 DEBUG : sub dir/hello world: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098b65_d20240425_m034537_c001_v0001099_t0002_u01714016737857") 2024/04/25 03:51:29 DEBUG : sub dir/hello world: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c5b3_d20240425_m034536_c001_v7007000_t0000_u01714016736596") 2024/04/25 03:51:29 DEBUG : sub dir/hello world: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098b59_d20240425_m034535_c001_v0001099_t0014_u01714016735683") 2024/04/25 03:51:29 DEBUG : sub dir/hello world: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c5a5_d20240425_m034534_c001_v7007000_t0000_u01714016734765") 2024/04/25 03:51:29 DEBUG : sub dir/hello world: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098b53_d20240425_m034533_c001_v0001099_t0044_u01714016733830") 2024/04/25 03:51:29 DEBUG : sub dir/hello world: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c578_d20240425_m034527_c001_v7007000_t0000_u01714016727365") 2024/04/25 03:51:29 DEBUG : sub dir/hello world: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098b2d_d20240425_m034526_c001_v0001099_t0037_u01714016726606") 2024/04/25 03:51:29 DEBUG : sub dir/hello world: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c574_d20240425_m034525_c001_v7007000_t0000_u01714016725697") 2024/04/25 03:51:29 DEBUG : sub dir/hello world: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098b27_d20240425_m034524_c001_v0001099_t0057_u01714016724594") 2024/04/25 03:51:29 DEBUG : sub dir/hello world: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c571_d20240425_m034523_c001_v7007000_t0000_u01714016723696") 2024/04/25 03:51:29 DEBUG : sub dir/hello world: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098b21_d20240425_m034522_c001_v0001099_t0031_u01714016722833") 2024/04/25 03:51:29 DEBUG : sub dir/hello world: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c56d_d20240425_m034520_c001_v7007000_t0000_u01714016720271") 2024/04/25 03:51:29 DEBUG : sub dir/hello world: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098b11_d20240425_m034519_c001_v0001099_t0045_u01714016719524") 2024/04/25 03:51:29 DEBUG : sub dir2/very/very/very/very/very/nested/subdir/hello world: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f406f8db543db7c41_d20240425_m035102_c001_v7007000_t0000_u01714017062435") 2024/04/25 03:51:29 DEBUG : sub dir2/very/very/very/very/very/nested/subdir/hello world: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f119dea16e15d1e6c_d20240425_m035059_c001_v0001026_t0028_u01714017059292") 2024/04/25 03:51:29 DEBUG : sub/yam: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40137b66323339de_d20240425_m034701_c001_v7007000_t0000_u01714016821693") 2024/04/25 03:51:29 DEBUG : sub/yam: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbb3bd_d20240425_m034659_c001_v0001181_t0039_u01714016819686") 2024/04/25 03:51:29 DEBUG : three: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c68f_d20240425_m034651_c001_v7007000_t0000_u01714016811059") 2024/04/25 03:51:29 DEBUG : three: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098cee_d20240425_m034649_c001_v0001099_t0031_u01714016809699") 2024/04/25 03:51:29 DEBUG : three: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f118126a15a098ce0_d20240425_m034647_c001_v0001099_t0016_u01714016807325") 2024/04/25 03:51:30 DEBUG : two: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c691_d20240425_m034651_c001_v7007000_t0000_u01714016811241") 2024/04/25 03:51:30 DEBUG : two: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f4093b0e860bbb29f_d20240425_m034649_c001_v0001181_t0011_u01714016809124") 2024/04/25 03:51:30 DEBUG : two: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f418126a15a098cdc_d20240425_m034647_c001_v0001099_t0044_u01714016807142") 2024/04/25 03:51:30 DEBUG : yam: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f40137b66323339e0_d20240425_m034702_c001_v7007000_t0000_u01714016822446") 2024/04/25 03:51:30 DEBUG : yam: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1087086f07f7f9b8_d20240425_m034701_c001_v0001136_t0002_u01714016821382") 2024/04/25 03:51:30 DEBUG : yam: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c69c_d20240425_m034657_c001_v7007000_t0000_u01714016817288") 2024/04/25 03:51:30 DEBUG : yam: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbb337_d20240425_m034655_c001_v0001181_t0038_u01714016815703") 2024/04/25 03:51:30 DEBUG : yam: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c695_d20240425_m034653_c001_v7007000_t0000_u01714016813686") 2024/04/25 03:51:30 DEBUG : yam: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1093b0e860bbb2df_d20240425_m034651_c001_v0001181_t0024_u01714016811811") 2024/04/25 03:51:30 DEBUG : yaml: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c69e_d20240425_m034658_c001_v7007000_t0000_u01714016818030") 2024/04/25 03:51:30 DEBUG : yaml: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f1054610c62b471de_d20240425_m034657_c001_v0001181_t0051_u01714016817055") 2024/04/25 03:51:30 DEBUG : yaml: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f402835d306d1c697_d20240425_m034654_c001_v7007000_t0000_u01714016814416") 2024/04/25 03:51:30 DEBUG : yaml: Deleting (id "4_zcf628d9350bd1b3b8ff80e1b_f11041a1b49e76950_d20240425_m034653_c001_v0001130_t0032_u01714016813261") "./sync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Finished OK in 6m15.874523076s (try 1/5)