"./sync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Starting (try 1/5) 2024/04/18 02:51:37 DEBUG : Creating backend with remote "TestB2:rclone-test-pozucow4nemibit1qujeraz7" 2024/04/18 02:51:37 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/04/18 02:51:38 DEBUG : Creating backend with remote "/tmp/rclone401943241" === RUN TestPipe --- PASS: TestPipe (0.00s) === RUN TestPipeConcurrent --- PASS: TestPipeConcurrent (0.04s) === 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-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:51:39 NOTICE: sub dir: Skipped make directory as --dry-run is set 2024/04/18 02:51:39 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/18 02:51:39 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:51:39 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:51:39 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestCopyWithDryRun (1.97s) === RUN TestCopy run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:51:40 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/04/18 02:51:40 DEBUG : sub dir: Making directory 2024/04/18 02:51:40 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/18 02:51:40 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:51:40 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:51:41 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/18 02:51:41 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:51:41 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: 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-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" sync_test.go:97: Skipping as metadata not supported --- SKIP: TestCopyMetadata (0.38s) === RUN TestCopyMissingDirectory run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:51:42 DEBUG : Creating backend with remote "/non-existing" 2024/04/18 02:51:42 ERROR : Local file system at /non-existing: error reading source root directory: directory not found 2024/04/18 02:51:42 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:51:42 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestCopyMissingDirectory (0.91s) === RUN TestCopyNoTraverse run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:51:43 DEBUG : sub dir: Making directory 2024/04/18 02:51:44 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/18 02:51:44 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:51:44 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:51:44 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/18 02:51:44 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestCopyNoTraverse (2.41s) === RUN TestCopyCheckFirst run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:51:45 INFO : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Running all checks before starting transfers 2024/04/18 02:51:46 DEBUG : sub dir: Making directory 2024/04/18 02:51:46 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/18 02:51:46 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:51:46 INFO : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Checks finished, now starting transfers 2024/04/18 02:51:46 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:51:46 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/18 02:51:46 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestCopyCheckFirst (1.76s) === RUN TestSyncNoTraverse run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:51:47 ERROR : Ignoring --no-traverse with sync 2024/04/18 02:51:47 DEBUG : sub dir: Making directory 2024/04/18 02:51:47 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/18 02:51:47 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:51:47 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:51:48 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/18 02:51:48 INFO : sub dir/hello world: Copied (new) 2024/04/18 02:51:48 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestSyncNoTraverse (1.62s) === RUN TestCopyWithDepth run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:51:49 DEBUG : hello world2: Need to transfer - File not found at Destination 2024/04/18 02:51:49 DEBUG : sub dir: Making directory 2024/04/18 02:51:49 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:51:49 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:51:50 DEBUG : hello world2: sha1 = c0bf117f9c93d02c894fe8ffd6e5cecf3545c209 OK 2024/04/18 02:51:50 INFO : hello world2: Copied (new) run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestCopyWithDepth (2.03s) === RUN TestCopyWithFilesFrom run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:51:51 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/18 02:51:51 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:51:51 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:51:51 DEBUG : potato2: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/18 02:51:51 INFO : potato2: Copied (new) run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestCopyWithFilesFrom (1.73s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:51:53 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/18 02:51:53 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:51:53 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:51:54 DEBUG : potato2: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/18 02:51:54 INFO : potato2: Copied (new) run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestCopyWithFilesFromAndNoTraverse (2.25s) === RUN TestCopyEmptyDirectories run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:51:55 DEBUG : sub dir2: Making directory with metadata 2024/04/18 02:51:55 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2024/04/18 02:51:55 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/04/18 02:51:55 DEBUG : sub dir: Making directory 2024/04/18 02:51:55 DEBUG : sub dir2: Making directory 2024/04/18 02:51:55 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/18 02:51:55 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:51:55 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:51:56 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/18 02:51:56 INFO : sub dir/hello world: Copied (new) 2024/04/18 02:51:56 DEBUG : sub dir2: Making directory 2024/04/18 02:51:56 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: copied 1 directories run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" fstest.go:244: Filtering empty directory "sub dir2" 2024/04/18 02:51:56 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopyEmptyDirectories (2.18s) === RUN TestMoveEmptyDirectories run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:51:57 DEBUG : sub dir2: Making directory with metadata 2024/04/18 02:51:57 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2024/04/18 02:51:57 DEBUG : sub dir: Making directory 2024/04/18 02:51:57 DEBUG : sub dir2: Making directory 2024/04/18 02:51:57 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/18 02:51:57 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:51:57 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:51:58 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/18 02:51:58 INFO : sub dir/hello world: Copied (new) 2024/04/18 02:51:58 INFO : sub dir/hello world: Deleted 2024/04/18 02:51:58 DEBUG : sub dir: Making directory 2024/04/18 02:51:58 DEBUG : sub dir2: Making directory 2024/04/18 02:51:58 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: copied 2 directories run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" fstest.go:244: Filtering empty directory "sub dir2" 2024/04/18 02:51:58 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata 2024/04/18 02:51:58 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestMoveEmptyDirectories (1.85s) === RUN TestSyncNoUpdateDirModtime run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", 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-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:51:59 DEBUG : sub dir2: Making directory with metadata 2024/04/18 02:51:59 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2024/04/18 02:51:59 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/04/18 02:51:59 DEBUG : sub dir: Making directory 2024/04/18 02:51:59 DEBUG : sub dir2: Making directory 2024/04/18 02:51:59 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/18 02:51:59 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:51:59 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:52:00 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/18 02:52:00 INFO : sub dir/hello world: Copied (new) 2024/04/18 02:52:00 DEBUG : sub dir2: Making directory 2024/04/18 02:52:00 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: copied 1 directories 2024/04/18 02:52:00 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" fstest.go:244: Filtering empty directory "sub dir2" 2024/04/18 02:52:00 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestSyncEmptyDirectories (2.04s) === RUN TestSyncSetDelayedModTimes run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", 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-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:52:02 DEBUG : Creating backend with remote "TestB2:rclone-test-dumuwel6fuxaqeq1vinawas7" sync_test.go:487: Server side copy (if possible) B2 bucket rclone-test-pozucow4nemibit1qujeraz7 -> B2 bucket rclone-test-dumuwel6fuxaqeq1vinawas7 2024/04/18 02:52:03 DEBUG : sub dir: Making directory 2024/04/18 02:52:04 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/18 02:52:04 DEBUG : B2 bucket rclone-test-dumuwel6fuxaqeq1vinawas7: Waiting for checks to finish 2024/04/18 02:52:04 DEBUG : B2 bucket rclone-test-dumuwel6fuxaqeq1vinawas7: Waiting for transfers to finish 2024/04/18 02:52:04 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/18 02:52:04 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:52:05 DEBUG : B2 bucket rclone-test-dumuwel6fuxaqeq1vinawas7: Purge remote 2024/04/18 02:52:05 INFO : B2 bucket rclone-test-dumuwel6fuxaqeq1vinawas7: cleaning bucket "rclone-test-dumuwel6fuxaqeq1vinawas7" of all files 2024/04/18 02:52:05 DEBUG : sub dir/hello world: Deleting (id "4_z6f424db310edebfb8fe80e1b_f107c7a58a0acbfb6_d20240418_m025204_c001_v0001031_t0025_u01713408724502") --- PASS: TestServerSideCopy (4.87s) === RUN TestCopyAfterDelete run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:52:07 ERROR : : error listing: directory not found 2024/04/18 02:52:08 DEBUG : Local file system at /tmp/rclone401943241: Making directory 2024/04/18 02:52:08 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:52:08 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestCopyAfterDelete (2.43s) === RUN TestCopyRedownload run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:52:10 DEBUG : sub dir: Making directory 2024/04/18 02:52:10 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/18 02:52:10 DEBUG : Local file system at /tmp/rclone401943241: Waiting for checks to finish 2024/04/18 02:52:10 DEBUG : Local file system at /tmp/rclone401943241: Waiting for transfers to finish 2024/04/18 02:52:11 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/18 02:52:11 DEBUG : sub dir/hello world.bewirif5.partial: renamed to: sub dir/hello world 2024/04/18 02:52:11 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestCopyRedownload (2.47s) === RUN TestSyncBasedOnCheckSum run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:52:12 DEBUG : check sum: Need to transfer - File not found at Destination 2024/04/18 02:52:12 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:52:12 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:52:12 DEBUG : check sum: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/04/18 02:52:12 INFO : check sum: Copied (new) 2024/04/18 02:52:12 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:52:12 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:52:12 DEBUG : check sum: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/04/18 02:52:12 DEBUG : check sum: Size and sha1 of src and dst objects identical 2024/04/18 02:52:12 DEBUG : check sum: Unchanged skipping 2024/04/18 02:52:12 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:52:12 DEBUG : Waiting for deletions to finish 2024/04/18 02:52:12 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestSyncBasedOnCheckSum (2.50s) === RUN TestSyncSizeOnly run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:52:14 DEBUG : sizeonly: Need to transfer - File not found at Destination 2024/04/18 02:52:14 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:52:14 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:52:15 DEBUG : sizeonly: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2024/04/18 02:52:15 INFO : sizeonly: Copied (new) 2024/04/18 02:52:15 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:52:15 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:52:15 DEBUG : sizeonly: Sizes identical 2024/04/18 02:52:15 DEBUG : sizeonly: Unchanged skipping 2024/04/18 02:52:15 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:52:15 DEBUG : Waiting for deletions to finish 2024/04/18 02:52:15 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestSyncSizeOnly (2.43s) === RUN TestSyncIgnoreSize run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:52:17 DEBUG : ignore-size: Need to transfer - File not found at Destination 2024/04/18 02:52:17 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:52:17 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:52:17 DEBUG : ignore-size: sha1 = 4a756ca07e9487f482465a99e8286abc86ba4dc7 OK 2024/04/18 02:52:17 INFO : ignore-size: Copied (new) 2024/04/18 02:52:17 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:52:17 DEBUG : ignore-size: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:52:17 DEBUG : ignore-size: Unchanged skipping 2024/04/18 02:52:17 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:52:17 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:52:17 DEBUG : Waiting for deletions to finish 2024/04/18 02:52:17 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestSyncIgnoreSize (2.48s) === RUN TestSyncIgnoreTimes run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:52:20 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:52:20 DEBUG : existing: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:52:20 DEBUG : existing: Unchanged skipping 2024/04/18 02:52:20 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:52:20 DEBUG : Waiting for deletions to finish 2024/04/18 02:52:20 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:52:21 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2024/04/18 02:52:21 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:52:21 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:52:21 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2024/04/18 02:52:21 INFO : existing: Copied (replaced existing) 2024/04/18 02:52:21 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestSyncIgnoreTimes (3.75s) === RUN TestSyncIgnoreExisting run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:52:23 DEBUG : existing: Need to transfer - File not found at Destination 2024/04/18 02:52:23 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:52:23 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:52:23 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2024/04/18 02:52:23 INFO : existing: Copied (new) 2024/04/18 02:52:23 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:52:24 DEBUG : existing: Destination exists, skipping 2024/04/18 02:52:24 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:52:24 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:52:24 DEBUG : Waiting for deletions to finish 2024/04/18 02:52:24 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestSyncIgnoreExisting (2.43s) === RUN TestSyncIgnoreErrors run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:52:26 DEBUG : d: Making directory fstest.go:244: Filtering empty directory "d" 2024/04/18 02:52:27 DEBUG : a: Making directory 2024/04/18 02:52:27 DEBUG : a/potato2: Need to transfer - File not found at Destination 2024/04/18 02:52:27 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/18 02:52:27 DEBUG : c/non empty space: Unchanged skipping 2024/04/18 02:52:27 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:52:27 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:52:27 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/18 02:52:27 INFO : a/potato2: Copied (new) 2024/04/18 02:52:27 DEBUG : Waiting for deletions to finish 2024/04/18 02:52:27 INFO : b/potato: Deleted run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestSyncIgnoreErrors (3.55s) === RUN TestSyncAfterChangingModtimeOnly run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:52:29 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:52:29 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/18 02:52:29 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/04/18 02:52:29 NOTICE: empty space: Skipped update modification time as --dry-run is set (size 1) 2024/04/18 02:52:29 DEBUG : empty space: Unchanged skipping 2024/04/18 02:52:29 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:52:29 DEBUG : Waiting for deletions to finish 2024/04/18 02:52:29 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:52:30 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/18 02:52:30 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:52:30 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/04/18 02:52:30 INFO : empty space: Updated modification time in destination 2024/04/18 02:52:30 DEBUG : empty space: Unchanged skipping 2024/04/18 02:52:30 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:52:30 DEBUG : Waiting for deletions to finish 2024/04/18 02:52:30 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestSyncAfterChangingModtimeOnly (3.38s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:52:33 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/18 02:52:33 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:52:33 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/04/18 02:52:33 DEBUG : empty space: Unchanged skipping 2024/04/18 02:52:33 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:52:33 DEBUG : Waiting for deletions to finish 2024/04/18 02:52:33 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (2.09s) === RUN TestSyncDoesntUpdateModtime run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:52:35 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/18 02:52:35 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:52:35 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 (Local file system at /tmp/rclone401943241) 2024/04/18 02:52:35 DEBUG : foo: sha1 = 62cdb7020ff920e5aa642c3d4066950dd1f01f4d (B2 bucket rclone-test-pozucow4nemibit1qujeraz7) 2024/04/18 02:52:35 DEBUG : foo: sha1 differ 2024/04/18 02:52:35 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:52:35 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 OK 2024/04/18 02:52:35 INFO : foo: Copied (replaced existing) 2024/04/18 02:52:35 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestSyncDoesntUpdateModtime (1.87s) === RUN TestSyncAfterAddingAFile run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:52:37 DEBUG : potato: Need to transfer - File not found at Destination 2024/04/18 02:52:37 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/18 02:52:37 DEBUG : empty space: Unchanged skipping 2024/04/18 02:52:37 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:52:37 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:52:37 DEBUG : potato: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/18 02:52:37 INFO : potato: Copied (new) 2024/04/18 02:52:37 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestSyncAfterAddingAFile (2.75s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:52:39 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:52:39 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2024/04/18 02:52:39 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:52:40 DEBUG : potato: sha1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f OK 2024/04/18 02:52:40 INFO : potato: Copied (replaced existing) 2024/04/18 02:52:40 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestSyncAfterChangingFilesSizeOnly (2.23s) === RUN TestSyncAfterChangingContentsOnly run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:52:42 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:52:42 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/18 02:52:42 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f (Local file system at /tmp/rclone401943241) 2024/04/18 02:52:42 DEBUG : potato: sha1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f (B2 bucket rclone-test-pozucow4nemibit1qujeraz7) 2024/04/18 02:52:42 DEBUG : potato: sha1 differ 2024/04/18 02:52:42 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:52:42 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f OK 2024/04/18 02:52:42 INFO : potato: Copied (replaced existing) 2024/04/18 02:52:42 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestSyncAfterChangingContentsOnly (2.28s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:52:44 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/18 02:52:44 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2024/04/18 02:52:44 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/18 02:52:44 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:52:44 DEBUG : empty space: Unchanged skipping 2024/04/18 02:52:44 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:52:44 DEBUG : Waiting for deletions to finish 2024/04/18 02:52:44 NOTICE: potato: Skipped delete as --dry-run is set (size 21) run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (2.48s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:52:47 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/18 02:52:47 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/18 02:52:47 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:52:47 DEBUG : empty space: Unchanged skipping 2024/04/18 02:52:47 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:52:47 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/18 02:52:47 INFO : potato2: Copied (new) 2024/04/18 02:52:47 DEBUG : Waiting for deletions to finish 2024/04/18 02:52:48 INFO : potato: Deleted run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (3.17s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:52:50 DEBUG : d: Making directory 2024/04/18 02:52:50 DEBUG : d/e: Making directory fstest.go:244: Filtering empty directory "d" fstest.go:244: Filtering empty directory "d/e" 2024/04/18 02:52:50 DEBUG : a: Making directory 2024/04/18 02:52:50 DEBUG : a/potato2: Need to transfer - File not found at Destination 2024/04/18 02:52:50 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/18 02:52:50 DEBUG : c/non empty space: Unchanged skipping 2024/04/18 02:52:51 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:52:51 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:52:51 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/18 02:52:51 INFO : a/potato2: Copied (new) 2024/04/18 02:52:51 DEBUG : Waiting for deletions to finish 2024/04/18 02:52:51 INFO : b/potato: Deleted run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (3.50s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:52:53 DEBUG : d: Making directory fstest.go:244: Filtering empty directory "d" 2024/04/18 02:52:54 DEBUG : a: Making directory 2024/04/18 02:52:54 DEBUG : a/potato2: Need to transfer - File not found at Destination 2024/04/18 02:52:54 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/18 02:52:54 DEBUG : c/non empty space: Unchanged skipping 2024/04/18 02:52:54 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:52:54 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:52:54 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/18 02:52:54 INFO : a/potato2: Copied (new) 2024/04/18 02:52:54 ERROR : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: not deleting files as there were IO errors 2024/04/18 02:52:54 ERROR : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: not deleting directories as there were IO errors run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" fstest.go:244: Filtering empty directory "d" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (3.40s) === RUN TestSyncDeleteAfter --- PASS: TestSyncDeleteAfter (0.00s) === RUN TestSyncDeleteDuring run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:52:57 DEBUG : Waiting for deletions to finish 2024/04/18 02:52:58 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/18 02:52:58 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/18 02:52:58 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:52:58 DEBUG : empty space: Unchanged skipping 2024/04/18 02:52:58 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:52:58 INFO : potato: Deleted 2024/04/18 02:52:58 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/18 02:52:58 INFO : potato2: Copied (new) run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:52:59 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_list_file_names": EOF) 2024/04/18 02:52:59 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2024/04/18 02:52:59 DEBUG : pacer: Reducing sleep to 10ms --- PASS: TestSyncDeleteDuring (4.03s) === RUN TestSyncDeleteBefore run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:53:02 DEBUG : Waiting for deletions to finish 2024/04/18 02:53:02 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:53:02 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:53:02 INFO : potato: Deleted 2024/04/18 02:53:02 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/18 02:53:02 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/18 02:53:02 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:53:02 DEBUG : empty space: Unchanged skipping 2024/04/18 02:53:02 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:53:03 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/18 02:53:03 INFO : potato2: Copied (new) run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestSyncDeleteBefore (4.18s) === RUN TestCopyDeleteBefore run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:53:05 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/18 02:53:05 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:53:05 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:53:06 DEBUG : potato2: sha1 = 810274f0df19dab60a894a562b7a8ff04c072623 OK 2024/04/18 02:53:06 INFO : potato2: Copied (new) run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestCopyDeleteBefore (3.04s) === RUN TestSyncWithExclude run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:53:08 DEBUG : enormous: Excluded (Size Filter) 2024/04/18 02:53:08 DEBUG : enormous: Excluded 2024/04/18 02:53:08 DEBUG : potato2: Excluded (Size Filter) 2024/04/18 02:53:08 DEBUG : potato2: Excluded 2024/04/18 02:53:08 DEBUG : potato2: Excluded (Size Filter) 2024/04/18 02:53:08 DEBUG : potato2: Excluded 2024/04/18 02:53:08 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:53:08 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/18 02:53:08 DEBUG : empty space: Unchanged skipping 2024/04/18 02:53:08 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:53:08 DEBUG : Waiting for deletions to finish 2024/04/18 02:53:08 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:53:08 DEBUG : enormous: Excluded (Size Filter) 2024/04/18 02:53:08 DEBUG : enormous: Excluded 2024/04/18 02:53:08 DEBUG : potato2: Excluded (Size Filter) 2024/04/18 02:53:08 DEBUG : potato2: Excluded 2024/04/18 02:53:09 DEBUG : potato2: Excluded (Size Filter) 2024/04/18 02:53:09 DEBUG : potato2: Excluded 2024/04/18 02:53:09 DEBUG : empty space: Size and modification time the same (differ by 456.789µs, within tolerance 1ms) 2024/04/18 02:53:09 DEBUG : empty space: Unchanged skipping 2024/04/18 02:53:09 DEBUG : Local file system at /tmp/rclone401943241: Waiting for checks to finish 2024/04/18 02:53:09 DEBUG : Local file system at /tmp/rclone401943241: Waiting for transfers to finish 2024/04/18 02:53:09 DEBUG : Waiting for deletions to finish 2024/04/18 02:53:09 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestSyncWithExclude (3.08s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:53:12 DEBUG : enormous: Excluded (Size Filter) 2024/04/18 02:53:12 DEBUG : enormous: Excluded 2024/04/18 02:53:12 DEBUG : potato2: Excluded (Size Filter) 2024/04/18 02:53:12 DEBUG : potato2: Excluded 2024/04/18 02:53:12 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/18 02:53:12 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:53:12 DEBUG : empty space: Unchanged skipping 2024/04/18 02:53:12 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:53:12 DEBUG : Waiting for deletions to finish 2024/04/18 02:53:12 INFO : enormous: Deleted 2024/04/18 02:53:12 INFO : potato2: Deleted 2024/04/18 02:53:12 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:53:12 DEBUG : empty space: Size and modification time the same (differ by 456.789µs, within tolerance 1ms) 2024/04/18 02:53:12 DEBUG : Local file system at /tmp/rclone401943241: Waiting for checks to finish 2024/04/18 02:53:12 DEBUG : empty space: Unchanged skipping 2024/04/18 02:53:12 DEBUG : Local file system at /tmp/rclone401943241: Waiting for transfers to finish 2024/04/18 02:53:12 DEBUG : Waiting for deletions to finish 2024/04/18 02:53:12 INFO : enormous: Deleted 2024/04/18 02:53:12 INFO : potato2: Deleted 2024/04/18 02:53:12 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestSyncWithExcludeAndDeleteExcluded (3.68s) === RUN TestSyncWithUpdateOlder run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:53:16 DEBUG : five: Need to transfer - File not found at Destination 2024/04/18 02:53:16 DEBUG : four: Sizes differ (src 4 vs dst 8) 2024/04/18 02:53:16 DEBUG : one: Destination is newer than source, skipping 2024/04/18 02:53:16 DEBUG : three: Sizes identical 2024/04/18 02:53:16 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:53:16 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b (Local file system at /tmp/rclone401943241) 2024/04/18 02:53:16 DEBUG : two: sha1 = b10e0da85e90399abfec36c7376b20aa4596461b (B2 bucket rclone-test-pozucow4nemibit1qujeraz7) 2024/04/18 02:53:16 DEBUG : two: sha1 differ 2024/04/18 02:53:16 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2024/04/18 02:53:16 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2024/04/18 02:53:16 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:53:16 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2024/04/18 02:53:16 INFO : five: Copied (new) 2024/04/18 02:53:17 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2024/04/18 02:53:17 INFO : four: Copied (replaced existing) 2024/04/18 02:53:17 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2024/04/18 02:53:17 INFO : two: Copied (replaced existing) 2024/04/18 02:53:17 DEBUG : Waiting for deletions to finish 2024/04/18 02:53:17 DEBUG : one: Destination is newer than source, skipping 2024/04/18 02:53:17 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:53:17 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2024/04/18 02:53:17 DEBUG : two: Size and sha1 of src and dst objects identical 2024/04/18 02:53:17 DEBUG : two: Destination mod time is within 1s of source and files identical, skipping 2024/04/18 02:53:17 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2024/04/18 02:53:17 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb (Local file system at /tmp/rclone401943241) 2024/04/18 02:53:17 DEBUG : five: Size and sha1 of src and dst objects identical 2024/04/18 02:53:17 DEBUG : three: sha1 = 03731cad13f4cf7b59703c77529381cdec1632e5 (B2 bucket rclone-test-pozucow4nemibit1qujeraz7) 2024/04/18 02:53:17 DEBUG : five: Destination mod time is within 1s of source and files identical, skipping 2024/04/18 02:53:17 DEBUG : three: sha1 differ 2024/04/18 02:53:17 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2024/04/18 02:53:17 DEBUG : four: Size and sha1 of src and dst objects identical 2024/04/18 02:53:17 DEBUG : three: Destination mod time is within 1s of source but files differ, transferring 2024/04/18 02:53:17 DEBUG : four: Destination mod time is within 1s of source and files identical, skipping 2024/04/18 02:53:17 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:53:18 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2024/04/18 02:53:18 INFO : three: Copied (replaced existing) 2024/04/18 02:53:18 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithUpdateOlder (5.61s) === 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-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" sync_test.go:1327: Can track renames: true 2024/04/18 02:53:20 INFO : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Making map for --track-renames 2024/04/18 02:53:20 INFO : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Finished making map for --track-renames 2024/04/18 02:53:20 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:53:20 DEBUG : potato: Need to transfer - No matching file found at Destination 2024/04/18 02:53:20 DEBUG : yam: Need to transfer - No matching file found at Destination 2024/04/18 02:53:20 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for renames to finish 2024/04/18 02:53:20 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:53:20 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2024/04/18 02:53:20 INFO : potato: Copied (new) 2024/04/18 02:53:21 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/04/18 02:53:21 INFO : yam: Copied (new) 2024/04/18 02:53:21 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:53:21 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:53:21 INFO : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Making map for --track-renames 2024/04/18 02:53:21 INFO : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Finished making map for --track-renames 2024/04/18 02:53:21 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:53:21 DEBUG : potato: Unchanged skipping 2024/04/18 02:53:21 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for renames to finish 2024/04/18 02:53:22 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/04/18 02:53:22 INFO : yam: Copied (server-side copy) to: yaml 2024/04/18 02:53:22 INFO : yam: Deleted 2024/04/18 02:53:22 INFO : yaml: Renamed from "yam" 2024/04/18 02:53:22 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:53:22 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestSyncWithTrackRenames (4.33s) === RUN TestParseRenamesStrategyModtime --- PASS: TestParseRenamesStrategyModtime (0.00s) === RUN TestRenamesStrategyModtime --- PASS: TestRenamesStrategyModtime (0.00s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" sync_test.go:1399: Can track renames: true 2024/04/18 02:53:24 INFO : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Making map for --track-renames 2024/04/18 02:53:24 INFO : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Finished making map for --track-renames 2024/04/18 02:53:24 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:53:24 DEBUG : potato: Need to transfer - No matching file found at Destination 2024/04/18 02:53:24 DEBUG : yam: Need to transfer - No matching file found at Destination 2024/04/18 02:53:24 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for renames to finish 2024/04/18 02:53:24 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:53:24 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/04/18 02:53:24 INFO : yam: Copied (new) 2024/04/18 02:53:25 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2024/04/18 02:53:25 INFO : potato: Copied (new) 2024/04/18 02:53:25 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:53:25 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:53:25 INFO : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Making map for --track-renames 2024/04/18 02:53:25 INFO : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Finished making map for --track-renames 2024/04/18 02:53:25 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:53:25 DEBUG : potato: Unchanged skipping 2024/04/18 02:53:25 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for renames to finish 2024/04/18 02:53:26 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/04/18 02:53:26 INFO : yam: Copied (server-side copy) to: yaml 2024/04/18 02:53:26 INFO : yam: Deleted 2024/04/18 02:53:26 INFO : yaml: Renamed from "yam" 2024/04/18 02:53:26 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:53:26 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestSyncWithTrackRenamesStrategyModtime (3.73s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" sync_test.go:1438: Can track renames: true 2024/04/18 02:53:28 DEBUG : sub: Making directory 2024/04/18 02:53:28 INFO : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Making map for --track-renames 2024/04/18 02:53:28 INFO : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Finished making map for --track-renames 2024/04/18 02:53:28 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:53:28 DEBUG : potato: Need to transfer - No matching file found at Destination 2024/04/18 02:53:28 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2024/04/18 02:53:28 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for renames to finish 2024/04/18 02:53:28 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:53:28 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/04/18 02:53:28 INFO : sub/yam: Copied (new) 2024/04/18 02:53:29 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2024/04/18 02:53:29 INFO : potato: Copied (new) 2024/04/18 02:53:29 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:53:29 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:53:29 DEBUG : potato: Unchanged skipping 2024/04/18 02:53:29 INFO : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Making map for --track-renames 2024/04/18 02:53:29 INFO : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Finished making map for --track-renames 2024/04/18 02:53:29 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:53:29 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for renames to finish 2024/04/18 02:53:30 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/04/18 02:53:30 INFO : sub/yam: Copied (server-side copy) to: yam 2024/04/18 02:53:30 INFO : sub/yam: Deleted 2024/04/18 02:53:30 INFO : yam: Renamed from "sub/yam" 2024/04/18 02:53:30 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:53:30 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestSyncWithTrackRenamesStrategyLeaf (4.40s) === RUN TestServerSideMoveLocal run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:53:32 DEBUG : Creating backend with remote "/tmp/rclone401943241/dir1" 2024/04/18 02:53:32 DEBUG : Config file has changed externally - reloading 2024/04/18 02:53:32 DEBUG : Creating backend with remote "/tmp/rclone401943241/dir2" 2024/04/18 02:53:32 DEBUG : Local file system at /tmp/rclone401943241/dir2: Using server-side directory move 2024/04/18 02:53:32 INFO : Local file system at /tmp/rclone401943241/dir2: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2024/04/18 02:53:32 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/04/18 02:53:32 DEBUG : Local file system at /tmp/rclone401943241/dir2: Waiting for checks to finish 2024/04/18 02:53:32 INFO : file1.txt: Moved (server-side) 2024/04/18 02:53:32 DEBUG : Local file system at /tmp/rclone401943241/dir2: Waiting for transfers to finish --- PASS: TestServerSideMoveLocal (0.38s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:53:32 DEBUG : nested: Making directory 2024/04/18 02:53:32 DEBUG : sub dir: Making directory 2024/04/18 02:53:32 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/18 02:53:32 DEBUG : nested/sub dir: Making directory 2024/04/18 02:53:32 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2024/04/18 02:53:32 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:53:32 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:53:33 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2024/04/18 02:53:33 INFO : nested/sub dir/file: Copied (new) 2024/04/18 02:53:33 INFO : nested/sub dir/file: Deleted 2024/04/18 02:53:33 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/18 02:53:33 INFO : sub dir/hello world: Copied (new) 2024/04/18 02:53:33 INFO : sub dir/hello world: Deleted 2024/04/18 02:53:33 INFO : sub dir: Removing directory 2024/04/18 02:53:33 INFO : nested/sub dir: Removing directory 2024/04/18 02:53:33 INFO : nested: Removing directory 2024/04/18 02:53:33 DEBUG : Local file system at /tmp/rclone401943241: deleted 3 directories run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestMoveWithDeleteEmptySrcDirs (2.32s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:53:35 DEBUG : nested: Making directory 2024/04/18 02:53:35 DEBUG : sub dir: Making directory 2024/04/18 02:53:35 DEBUG : nested/sub dir: Making directory 2024/04/18 02:53:35 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/04/18 02:53:35 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2024/04/18 02:53:35 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:53:35 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:53:35 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2024/04/18 02:53:35 INFO : nested/sub dir/file: Copied (new) 2024/04/18 02:53:35 INFO : nested/sub dir/file: Deleted 2024/04/18 02:53:36 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/04/18 02:53:36 INFO : sub dir/hello world: Copied (new) 2024/04/18 02:53:36 INFO : sub dir/hello world: Deleted run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestMoveWithoutDeleteEmptySrcDirs (2.54s) === RUN TestMoveWithIgnoreExisting run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:53:37 DEBUG : existing: Need to transfer - File not found at Destination 2024/04/18 02:53:37 DEBUG : existing-b: Need to transfer - File not found at Destination 2024/04/18 02:53:37 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:53:37 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:53:38 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2024/04/18 02:53:38 INFO : existing: Copied (new) 2024/04/18 02:53:38 INFO : existing: Deleted 2024/04/18 02:53:38 DEBUG : existing-b: sha1 = 321f6b7e8bf7f29aab89c5e41a555b1b0baa41a9 OK 2024/04/18 02:53:38 INFO : existing-b: Copied (new) 2024/04/18 02:53:38 INFO : existing-b: Deleted 2024/04/18 02:53:38 DEBUG : existing: Destination exists, skipping 2024/04/18 02:53:38 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2024/04/18 02:53:38 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:53:38 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:53:38 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestMoveWithIgnoreExisting (2.67s) === RUN TestServerSideMove run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:53:40 DEBUG : Creating backend with remote "TestB2:rclone-test-pimuyir0pihimod7sevoyuq1" sync_test.go:1494: Server side move (if possible) B2 bucket rclone-test-pozucow4nemibit1qujeraz7 -> B2 bucket rclone-test-pimuyir0pihimod7sevoyuq1 2024/04/18 02:53:45 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/18 02:53:45 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ms) 2024/04/18 02:53:45 DEBUG : empty space: Unchanged skipping 2024/04/18 02:53:45 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2024/04/18 02:53:45 DEBUG : B2 bucket rclone-test-pimuyir0pihimod7sevoyuq1: Waiting for checks to finish 2024/04/18 02:53:46 INFO : empty space: Deleted 2024/04/18 02:53:46 DEBUG : B2 bucket rclone-test-pimuyir0pihimod7sevoyuq1: Waiting for transfers to finish 2024/04/18 02:53:46 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/18 02:53:46 INFO : potato2: Copied (server-side copy) 2024/04/18 02:53:46 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2024/04/18 02:53:46 INFO : potato3: Copied (server-side copy) 2024/04/18 02:53:46 INFO : potato2: Deleted 2024/04/18 02:53:46 INFO : potato3: Deleted 2024/04/18 02:53:47 DEBUG : Creating backend with remote "TestB2:rclone-test-payaheg4loqalow6sowozev6" 2024/04/18 02:53:47 DEBUG : empty space: Need to transfer - File not found at Destination 2024/04/18 02:53:47 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/18 02:53:47 DEBUG : potato3: Need to transfer - File not found at Destination 2024/04/18 02:53:47 DEBUG : B2 bucket rclone-test-payaheg4loqalow6sowozev6: Waiting for checks to finish 2024/04/18 02:53:47 DEBUG : B2 bucket rclone-test-payaheg4loqalow6sowozev6: Waiting for transfers to finish 2024/04/18 02:53:48 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/18 02:53:48 INFO : potato2: Copied (server-side copy) 2024/04/18 02:53:48 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2024/04/18 02:53:48 INFO : potato3: Copied (server-side copy) 2024/04/18 02:53:48 INFO : potato2: Deleted 2024/04/18 02:53:49 INFO : potato3: Deleted 2024/04/18 02:53:49 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/04/18 02:53:49 INFO : empty space: Copied (server-side copy) 2024/04/18 02:53:49 INFO : empty space: Deleted 2024/04/18 02:53:49 DEBUG : B2 bucket rclone-test-payaheg4loqalow6sowozev6: Purge remote 2024/04/18 02:53:49 INFO : B2 bucket rclone-test-payaheg4loqalow6sowozev6: cleaning bucket "rclone-test-payaheg4loqalow6sowozev6" of all files 2024/04/18 02:53:49 DEBUG : empty space: Deleting (id "4_zef12ed1310fdebfb8fe80e1b_f1164170c56932a64_d20240418_m025348_c001_v0001044_t0043_u01713408828397") 2024/04/18 02:53:49 DEBUG : potato2: Deleting (id "4_zef12ed1310fdebfb8fe80e1b_f106bb3f40b24b4bd_d20240418_m025348_c001_v0001179_t0040_u01713408828413") 2024/04/18 02:53:49 DEBUG : potato3: Deleting (id "4_zef12ed1310fdebfb8fe80e1b_f11633639939224e8_d20240418_m025348_c001_v0001120_t0044_u01713408828411") 2024/04/18 02:53:50 DEBUG : B2 bucket rclone-test-pimuyir0pihimod7sevoyuq1: Purge remote 2024/04/18 02:53:50 INFO : B2 bucket rclone-test-pimuyir0pihimod7sevoyuq1: cleaning bucket "rclone-test-pimuyir0pihimod7sevoyuq1" of all files 2024/04/18 02:53:50 DEBUG : empty space: Deleting (id "4_zafa2cde310fdebfb8fe80e1b_f4052cb9125755ad8_d20240418_m025349_c001_v7007000_t0000_u01713408829140") 2024/04/18 02:53:50 DEBUG : empty space: Deleting (id "4_zafa2cde310fdebfb8fe80e1b_f1168c78aa3068c6f_d20240418_m025344_c001_v0001038_t0032_u01713408824144") 2024/04/18 02:53:50 DEBUG : potato2: Deleting (id "4_zafa2cde310fdebfb8fe80e1b_f40065d337a78cc33_d20240418_m025348_c001_v7007000_t0000_u01713408828813") 2024/04/18 02:53:50 DEBUG : potato2: Deleting (id "4_zafa2cde310fdebfb8fe80e1b_f11242b143d8cb755_d20240418_m025345_c001_v0001093_t0001_u01713408825928") 2024/04/18 02:53:50 DEBUG : potato3: Deleting (id "4_zafa2cde310fdebfb8fe80e1b_f4173751f94eda844_d20240418_m025348_c001_v7007000_t0000_u01713408828956") 2024/04/18 02:53:50 DEBUG : potato3: Deleting (id "4_zafa2cde310fdebfb8fe80e1b_f100c19820e5dbf75_d20240418_m025346_c001_v0001092_t0028_u01713408826185") 2024/04/18 02:53:50 DEBUG : potato3: Deleting (id "4_zafa2cde310fdebfb8fe80e1b_f1168c78aa3068c73_d20240418_m025344_c001_v0001038_t0023_u01713408824769") --- PASS: TestServerSideMove (12.11s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:53:52 DEBUG : Creating backend with remote "TestB2:rclone-test-xigaxel2gumocir9haziyun6" sync_test.go:1494: Server side move (if possible) B2 bucket rclone-test-pozucow4nemibit1qujeraz7 -> B2 bucket rclone-test-xigaxel2gumocir9haziyun6 2024/04/18 02:53:57 DEBUG : empty space: Excluded (Size Filter) 2024/04/18 02:53:57 DEBUG : empty space: Excluded 2024/04/18 02:53:57 DEBUG : empty space: Excluded (Size Filter) 2024/04/18 02:53:57 DEBUG : empty space: Excluded 2024/04/18 02:53:57 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/18 02:53:57 DEBUG : B2 bucket rclone-test-xigaxel2gumocir9haziyun6: Waiting for checks to finish 2024/04/18 02:53:57 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2024/04/18 02:53:57 DEBUG : B2 bucket rclone-test-xigaxel2gumocir9haziyun6: Waiting for transfers to finish 2024/04/18 02:53:57 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/18 02:53:57 INFO : potato2: Copied (server-side copy) 2024/04/18 02:53:58 INFO : potato2: Deleted 2024/04/18 02:53:58 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2024/04/18 02:53:58 INFO : potato3: Copied (server-side copy) 2024/04/18 02:53:58 INFO : potato3: Deleted 2024/04/18 02:53:58 DEBUG : Creating backend with remote "TestB2:rclone-test-dakaduv0sejiwup7sejavoc3" 2024/04/18 02:53:59 DEBUG : empty space: Excluded (Size Filter) 2024/04/18 02:53:59 DEBUG : empty space: Excluded 2024/04/18 02:53:59 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/18 02:53:59 DEBUG : potato3: Need to transfer - File not found at Destination 2024/04/18 02:53:59 DEBUG : B2 bucket rclone-test-dakaduv0sejiwup7sejavoc3: Waiting for checks to finish 2024/04/18 02:53:59 DEBUG : B2 bucket rclone-test-dakaduv0sejiwup7sejavoc3: Waiting for transfers to finish 2024/04/18 02:54:01 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/18 02:54:01 INFO : potato2: Copied (server-side copy) 2024/04/18 02:54:01 INFO : potato2: Deleted 2024/04/18 02:54:01 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2024/04/18 02:54:01 INFO : potato3: Copied (server-side copy) 2024/04/18 02:54:01 INFO : potato3: Deleted 2024/04/18 02:54:01 DEBUG : B2 bucket rclone-test-dakaduv0sejiwup7sejavoc3: Purge remote 2024/04/18 02:54:01 INFO : B2 bucket rclone-test-dakaduv0sejiwup7sejavoc3: cleaning bucket "rclone-test-dakaduv0sejiwup7sejavoc3" of all files 2024/04/18 02:54:02 DEBUG : potato2: Deleting (id "4_z7f521d03200debfb8fe80e1b_f119f8043176d27fd_d20240418_m025400_c001_v0001161_t0050_u01713408840464") 2024/04/18 02:54:02 DEBUG : potato3: Deleting (id "4_z7f521d03200debfb8fe80e1b_f117bb998722d5f4a_d20240418_m025400_c001_v0001116_t0056_u01713408840589") 2024/04/18 02:54:02 DEBUG : B2 bucket rclone-test-xigaxel2gumocir9haziyun6: Purge remote 2024/04/18 02:54:02 INFO : B2 bucket rclone-test-xigaxel2gumocir9haziyun6: cleaning bucket "rclone-test-xigaxel2gumocir9haziyun6" of all files 2024/04/18 02:54:03 DEBUG : empty space: Deleting (id "4_z8f12fdf310fdebfb8fe80e1b_f10118d090645bc97_d20240418_m025356_c001_v0001172_t0005_u01713408836422") 2024/04/18 02:54:03 DEBUG : potato2: Deleting (id "4_z8f12fdf310fdebfb8fe80e1b_f406123ddb02b3755_d20240418_m025401_c001_v7007000_t0000_u01713408841252") 2024/04/18 02:54:03 DEBUG : potato2: Deleting (id "4_z8f12fdf310fdebfb8fe80e1b_f1146934a2dde6bcd_d20240418_m025357_c001_v0001042_t0034_u01713408837461") 2024/04/18 02:54:03 DEBUG : potato3: Deleting (id "4_z8f12fdf310fdebfb8fe80e1b_f40404c0475d62374_d20240418_m025401_c001_v7007000_t0000_u01713408841521") 2024/04/18 02:54:03 DEBUG : potato3: Deleting (id "4_z8f12fdf310fdebfb8fe80e1b_f11248c2966102a14_d20240418_m025357_c001_v0001145_t0034_u01713408837534") 2024/04/18 02:54:03 DEBUG : potato3: Deleting (id "4_z8f12fdf310fdebfb8fe80e1b_f10118d090645bc9d_d20240418_m025356_c001_v0001172_t0013_u01713408836787") --- PASS: TestServerSideMoveWithFilter (12.25s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:54:04 DEBUG : Creating backend with remote "TestB2:rclone-test-rasebas2jerurol1nobozis0" 2024/04/18 02:54:08 DEBUG : tomatoDir: Making directory sync_test.go:1494: Server side move (if possible) B2 bucket rclone-test-pozucow4nemibit1qujeraz7 -> B2 bucket rclone-test-rasebas2jerurol1nobozis0 2024/04/18 02:54:10 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/18 02:54:10 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ms) 2024/04/18 02:54:10 DEBUG : empty space: Unchanged skipping 2024/04/18 02:54:10 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2024/04/18 02:54:10 DEBUG : B2 bucket rclone-test-rasebas2jerurol1nobozis0: Waiting for checks to finish 2024/04/18 02:54:10 INFO : empty space: Deleted 2024/04/18 02:54:10 DEBUG : B2 bucket rclone-test-rasebas2jerurol1nobozis0: Waiting for transfers to finish 2024/04/18 02:54:10 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/18 02:54:10 INFO : potato2: Copied (server-side copy) 2024/04/18 02:54:10 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2024/04/18 02:54:10 INFO : potato3: Copied (server-side copy) 2024/04/18 02:54:11 INFO : potato2: Deleted 2024/04/18 02:54:11 INFO : potato3: Deleted 2024/04/18 02:54:11 DEBUG : Creating backend with remote "TestB2:rclone-test-nefaqob6puyuzer1fibenic4" 2024/04/18 02:54:12 DEBUG : tomatoDir: Making directory 2024/04/18 02:54:12 DEBUG : empty space: Need to transfer - File not found at Destination 2024/04/18 02:54:12 DEBUG : potato2: Need to transfer - File not found at Destination 2024/04/18 02:54:12 DEBUG : potato3: Need to transfer - File not found at Destination 2024/04/18 02:54:12 DEBUG : B2 bucket rclone-test-nefaqob6puyuzer1fibenic4: Waiting for checks to finish 2024/04/18 02:54:12 DEBUG : B2 bucket rclone-test-nefaqob6puyuzer1fibenic4: Waiting for transfers to finish 2024/04/18 02:54:13 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/04/18 02:54:13 INFO : empty space: Copied (server-side copy) 2024/04/18 02:54:13 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2024/04/18 02:54:13 INFO : potato3: Copied (server-side copy) 2024/04/18 02:54:13 INFO : empty space: Deleted 2024/04/18 02:54:13 INFO : potato3: Deleted 2024/04/18 02:54:13 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/04/18 02:54:13 INFO : potato2: Copied (server-side copy) 2024/04/18 02:54:13 INFO : potato2: Deleted 2024/04/18 02:54:14 DEBUG : B2 bucket rclone-test-nefaqob6puyuzer1fibenic4: Purge remote 2024/04/18 02:54:14 INFO : B2 bucket rclone-test-nefaqob6puyuzer1fibenic4: cleaning bucket "rclone-test-nefaqob6puyuzer1fibenic4" of all files 2024/04/18 02:54:14 DEBUG : empty space: Deleting (id "4_zafe24d23200debfb8fe80e1b_f1138f8fa37e1a590_d20240418_m025413_c001_v0001180_t0058_u01713408853136") 2024/04/18 02:54:14 DEBUG : potato2: Deleting (id "4_zafe24d23200debfb8fe80e1b_f1181649d72579a3d_d20240418_m025413_c001_v0001157_t0043_u01713408853144") 2024/04/18 02:54:14 DEBUG : potato3: Deleting (id "4_zafe24d23200debfb8fe80e1b_f106d981c4286c774_d20240418_m025413_c001_v0001157_t0022_u01713408853165") 2024/04/18 02:54:15 DEBUG : B2 bucket rclone-test-rasebas2jerurol1nobozis0: Purge remote 2024/04/18 02:54:15 INFO : B2 bucket rclone-test-rasebas2jerurol1nobozis0: cleaning bucket "rclone-test-rasebas2jerurol1nobozis0" of all files 2024/04/18 02:54:15 DEBUG : empty space: Deleting (id "4_zcfb23d13200debfb8fe80e1b_f416683d780b4408e_d20240418_m025413_c001_v7007000_t0000_u01713408853342") 2024/04/18 02:54:15 DEBUG : empty space: Deleting (id "4_zcfb23d13200debfb8fe80e1b_f117c37c05bf36c52_d20240418_m025409_c001_v0001179_t0050_u01713408849397") 2024/04/18 02:54:15 DEBUG : potato2: Deleting (id "4_zcfb23d13200debfb8fe80e1b_f40404c0475d6239d_d20240418_m025413_c001_v7007000_t0000_u01713408853866") 2024/04/18 02:54:15 DEBUG : potato2: Deleting (id "4_zcfb23d13200debfb8fe80e1b_f1078ed86b3094aee_d20240418_m025410_c001_v0001157_t0001_u01713408850406") 2024/04/18 02:54:15 DEBUG : potato3: Deleting (id "4_zcfb23d13200debfb8fe80e1b_f4155a2e15d6545c2_d20240418_m025413_c001_v7007000_t0000_u01713408853511") 2024/04/18 02:54:15 DEBUG : potato3: Deleting (id "4_zcfb23d13200debfb8fe80e1b_f1015a639f3e3b5c5_d20240418_m025410_c001_v0001161_t0055_u01713408850615") 2024/04/18 02:54:15 DEBUG : potato3: Deleting (id "4_zcfb23d13200debfb8fe80e1b_f117c37c05bf36c54_d20240418_m025409_c001_v0001179_t0038_u01713408849610") --- PASS: TestServerSideMoveDeleteEmptySourceDirs (12.45s) === RUN TestServerSideMoveOverlap run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:54:17 DEBUG : Creating backend with remote "TestB2:rclone-test-pozucow4nemibit1qujeraz7/rclone-move-test" --- PASS: TestServerSideMoveOverlap (2.53s) === RUN TestSyncOverlap run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:54:19 DEBUG : Creating backend with remote "TestB2:rclone-test-pozucow4nemibit1qujeraz7/rclone-sync-test" run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestSyncOverlap (2.30s) === RUN TestSyncOverlapWithFilter run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:54:21 DEBUG : Creating backend with remote "TestB2:rclone-test-pozucow4nemibit1qujeraz7/rclone-sync-test" 2024/04/18 02:54:22 DEBUG : Creating backend with remote "TestB2:rclone-test-pozucow4nemibit1qujeraz7/rclone-sync-test-include/layer2" 2024/04/18 02:54:23 DEBUG : Creating backend with remote "TestB2:rclone-test-pozucow4nemibit1qujeraz7/rclone-sync-test-ignore-file" 2024/04/18 02:54:25 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/04/18 02:54:25 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path rclone-sync-test: Waiting for checks to finish 2024/04/18 02:54:25 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path rclone-sync-test: Waiting for transfers to finish 2024/04/18 02:54:25 DEBUG : Waiting for deletions to finish 2024/04/18 02:54:25 INFO : There was nothing to transfer 2024/04/18 02:54:26 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/04/18 02:54:26 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:54:26 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:54:26 DEBUG : Waiting for deletions to finish 2024/04/18 02:54:26 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:54:27 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/04/18 02:54:27 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path rclone-sync-test-include/layer2: Waiting for checks to finish 2024/04/18 02:54:27 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path rclone-sync-test-include/layer2: Waiting for transfers to finish 2024/04/18 02:54:27 DEBUG : Waiting for deletions to finish 2024/04/18 02:54:27 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:54:27 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/04/18 02:54:27 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:54:27 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:54:27 DEBUG : Waiting for deletions to finish 2024/04/18 02:54:27 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:54:27 DEBUG : : Excluded 2024/04/18 02:54:28 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/04/18 02:54:28 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path rclone-sync-test-ignore-file: Waiting for checks to finish 2024/04/18 02:54:28 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path rclone-sync-test-ignore-file: Waiting for transfers to finish 2024/04/18 02:54:28 DEBUG : Waiting for deletions to finish 2024/04/18 02:54:28 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestSyncOverlapWithFilter (13.20s) === RUN TestSyncCompareDest run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:54:35 DEBUG : Creating backend with remote "TestB2:rclone-test-pozucow4nemibit1qujeraz7/dst" 2024/04/18 02:54:36 DEBUG : Creating backend with remote "TestB2:rclone-test-pozucow4nemibit1qujeraz7/CompareDest" 2024/04/18 02:54:37 DEBUG : one: Need to transfer - File not found at Destination 2024/04/18 02:54:37 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for checks to finish 2024/04/18 02:54:37 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for transfers to finish 2024/04/18 02:54:38 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/04/18 02:54:38 INFO : one: Copied (new) 2024/04/18 02:54:38 DEBUG : Waiting for deletions to finish 2024/04/18 02:54:38 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/04/18 02:54:38 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for checks to finish 2024/04/18 02:54:38 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for transfers to finish 2024/04/18 02:54:39 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2024/04/18 02:54:39 INFO : one: Copied (replaced existing) 2024/04/18 02:54:39 DEBUG : Waiting for deletions to finish 2024/04/18 02:54:41 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for checks to finish 2024/04/18 02:54:41 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/04/18 02:54:42 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/18 02:54:42 DEBUG : one: Destination found in --compare-dest, skipping 2024/04/18 02:54:42 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for transfers to finish 2024/04/18 02:54:42 DEBUG : Waiting for deletions to finish 2024/04/18 02:54:42 INFO : There was nothing to transfer 2024/04/18 02:54:43 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/18 02:54:43 DEBUG : two: Destination found in --compare-dest, skipping 2024/04/18 02:54:43 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/04/18 02:54:43 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for checks to finish 2024/04/18 02:54:43 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/18 02:54:43 DEBUG : one: Destination found in --compare-dest, skipping 2024/04/18 02:54:43 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for transfers to finish 2024/04/18 02:54:43 DEBUG : Waiting for deletions to finish 2024/04/18 02:54:43 INFO : There was nothing to transfer 2024/04/18 02:54:44 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/18 02:54:44 DEBUG : two: Destination found in --compare-dest, skipping 2024/04/18 02:54:44 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/04/18 02:54:44 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for checks to finish 2024/04/18 02:54:44 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/18 02:54:44 DEBUG : one: Destination found in --compare-dest, skipping 2024/04/18 02:54:44 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for transfers to finish 2024/04/18 02:54:44 DEBUG : Waiting for deletions to finish 2024/04/18 02:54:44 INFO : There was nothing to transfer 2024/04/18 02:54:45 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/18 02:54:45 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2024/04/18 02:54:45 DEBUG : two: Destination found in --compare-dest, skipping 2024/04/18 02:54:45 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for checks to finish 2024/04/18 02:54:45 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/04/18 02:54:45 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/18 02:54:45 DEBUG : one: Destination found in --compare-dest, skipping 2024/04/18 02:54:45 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for transfers to finish 2024/04/18 02:54:45 DEBUG : Waiting for deletions to finish 2024/04/18 02:54:45 INFO : There was nothing to transfer 2024/04/18 02:54:46 DEBUG : two: Sizes differ (src 5 vs dst 3) 2024/04/18 02:54:46 DEBUG : two: Need to transfer - File not found at Destination 2024/04/18 02:54:46 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/04/18 02:54:46 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for checks to finish 2024/04/18 02:54:46 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/18 02:54:46 DEBUG : one: Destination found in --compare-dest, skipping 2024/04/18 02:54:46 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for transfers to finish 2024/04/18 02:54:46 DEBUG : two: sha1 = a4be8877ad88f3109a6411985a1f359e10e2d930 OK 2024/04/18 02:54:46 INFO : two: Copied (new) 2024/04/18 02:54:46 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (13.07s) === RUN TestSyncMultipleCompareDest run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:54:50 DEBUG : Creating backend with remote "TestB2:rclone-test-pozucow4nemibit1qujeraz7/dest" 2024/04/18 02:54:51 DEBUG : Creating backend with remote "TestB2:rclone-test-pozucow4nemibit1qujeraz7/pre-dest1" 2024/04/18 02:54:51 DEBUG : Creating backend with remote "TestB2:rclone-test-pozucow4nemibit1qujeraz7/pre-dest2" 2024/04/18 02:54:52 DEBUG : 1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:54:52 DEBUG : 1: Destination found in --compare-dest, skipping 2024/04/18 02:54:53 DEBUG : 2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:54:53 DEBUG : 2: Destination found in --compare-dest, skipping 2024/04/18 02:54:53 DEBUG : 3: Need to transfer - File not found at Destination 2024/04/18 02:54:53 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dest: Waiting for checks to finish 2024/04/18 02:54:53 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dest: Waiting for transfers to finish 2024/04/18 02:54:54 DEBUG : 3: sha1 = 77de68daecd823babbb58edb1c8e14d7106e83bb OK 2024/04/18 02:54:54 INFO : 3: Copied (new) 2024/04/18 02:54:54 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (7.31s) === RUN TestSyncCopyDest run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:54:55 DEBUG : Creating backend with remote "TestB2:rclone-test-pozucow4nemibit1qujeraz7/dst" 2024/04/18 02:54:55 DEBUG : Creating backend with remote "TestB2:rclone-test-pozucow4nemibit1qujeraz7/CopyDest" 2024/04/18 02:54:56 DEBUG : one: Need to transfer - File not found at Destination 2024/04/18 02:54:56 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for checks to finish 2024/04/18 02:54:56 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for transfers to finish 2024/04/18 02:54:57 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/04/18 02:54:57 INFO : one: Copied (new) 2024/04/18 02:54:57 DEBUG : Waiting for deletions to finish 2024/04/18 02:54:58 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/04/18 02:54:58 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for checks to finish 2024/04/18 02:54:58 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for transfers to finish 2024/04/18 02:54:58 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2024/04/18 02:54:58 INFO : one: Copied (replaced existing) 2024/04/18 02:54:58 DEBUG : Waiting for deletions to finish 2024/04/18 02:55:01 DEBUG : Creating backend with remote "TestB2:rclone-test-pozucow4nemibit1qujeraz7/BackupDir" 2024/04/18 02:55:02 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/04/18 02:55:02 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for checks to finish 2024/04/18 02:55:02 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/18 02:55:02 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/04/18 02:55:03 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/04/18 02:55:03 INFO : one: Copied (server-side copy) 2024/04/18 02:55:03 INFO : one: Deleted 2024/04/18 02:55:04 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2024/04/18 02:55:04 INFO : one: Copied (server-side copy) 2024/04/18 02:55:04 DEBUG : one: Destination found in --copy-dest, using server-side copy 2024/04/18 02:55:04 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for transfers to finish 2024/04/18 02:55:04 DEBUG : Waiting for deletions to finish 2024/04/18 02:55:06 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/18 02:55:06 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2024/04/18 02:55:06 INFO : two: Copied (server-side copy) 2024/04/18 02:55:06 DEBUG : two: Destination found in --copy-dest, using server-side copy 2024/04/18 02:55:06 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/18 02:55:06 DEBUG : one: Unchanged skipping 2024/04/18 02:55:06 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for checks to finish 2024/04/18 02:55:06 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for transfers to finish 2024/04/18 02:55:06 DEBUG : Waiting for deletions to finish 2024/04/18 02:55:07 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/18 02:55:07 DEBUG : one: Unchanged skipping 2024/04/18 02:55:07 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for checks to finish 2024/04/18 02:55:07 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/18 02:55:07 DEBUG : two: Unchanged skipping 2024/04/18 02:55:07 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for transfers to finish 2024/04/18 02:55:07 DEBUG : Waiting for deletions to finish 2024/04/18 02:55:07 INFO : There was nothing to transfer 2024/04/18 02:55:08 DEBUG : three: Sizes differ (src 7 vs dst 5) 2024/04/18 02:55:08 DEBUG : three: Destination not found in --copy-dest 2024/04/18 02:55:08 DEBUG : three: Need to transfer - File not found at Destination 2024/04/18 02:55:08 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/18 02:55:08 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/04/18 02:55:08 DEBUG : one: Unchanged skipping 2024/04/18 02:55:08 DEBUG : two: Unchanged skipping 2024/04/18 02:55:08 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for checks to finish 2024/04/18 02:55:08 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for transfers to finish 2024/04/18 02:55:09 DEBUG : three: sha1 = 370e613335f3cf2f19b2a2d35a86402f55c659f8 OK 2024/04/18 02:55:09 INFO : three: Copied (new) 2024/04/18 02:55:09 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCopyDest (15.91s) === RUN TestSyncBackupDir run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:55:14 DEBUG : Creating backend with remote "TestB2:rclone-test-pozucow4nemibit1qujeraz7/dst" 2024/04/18 02:55:15 DEBUG : Creating backend with remote "TestB2:rclone-test-pozucow4nemibit1qujeraz7/backup" 2024/04/18 02:55:16 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/04/18 02:55:16 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:55:16 DEBUG : two: Unchanged skipping 2024/04/18 02:55:16 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for checks to finish 2024/04/18 02:55:17 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/04/18 02:55:17 INFO : one: Copied (server-side copy) 2024/04/18 02:55:17 INFO : one: Deleted 2024/04/18 02:55:17 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for transfers to finish 2024/04/18 02:55:18 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/18 02:55:18 INFO : one: Copied (new) 2024/04/18 02:55:18 DEBUG : Waiting for deletions to finish 2024/04/18 02:55:18 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2024/04/18 02:55:18 INFO : three.txt: Copied (server-side copy) 2024/04/18 02:55:18 INFO : three.txt: Deleted 2024/04/18 02:55:18 INFO : three.txt: Moved into backup dir 2024/04/18 02:55:20 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/04/18 02:55:20 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:55:20 DEBUG : two: Unchanged skipping 2024/04/18 02:55:20 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for checks to finish 2024/04/18 02:55:21 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/18 02:55:21 INFO : one: Copied (server-side copy) 2024/04/18 02:55:21 INFO : one: Deleted 2024/04/18 02:55:21 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for transfers to finish 2024/04/18 02:55:21 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2024/04/18 02:55:21 INFO : one: Copied (new) 2024/04/18 02:55:21 DEBUG : Waiting for deletions to finish 2024/04/18 02:55:22 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/04/18 02:55:22 INFO : three.txt: Copied (server-side copy) 2024/04/18 02:55:22 INFO : three.txt: Deleted 2024/04/18 02:55:22 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (12.68s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:55:27 DEBUG : Creating backend with remote "TestB2:rclone-test-pozucow4nemibit1qujeraz7/dst" 2024/04/18 02:55:28 DEBUG : Creating backend with remote "TestB2:rclone-test-pozucow4nemibit1qujeraz7/backup" 2024/04/18 02:55:29 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for checks to finish 2024/04/18 02:55:29 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/04/18 02:55:29 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:55:29 DEBUG : two: Unchanged skipping 2024/04/18 02:55:30 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/04/18 02:55:30 INFO : one: Copied (server-side copy) to: one.bak 2024/04/18 02:55:30 INFO : one: Deleted 2024/04/18 02:55:30 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for transfers to finish 2024/04/18 02:55:31 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/18 02:55:31 INFO : one: Copied (new) 2024/04/18 02:55:31 DEBUG : Waiting for deletions to finish 2024/04/18 02:55:31 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2024/04/18 02:55:31 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/04/18 02:55:32 INFO : three.txt: Deleted 2024/04/18 02:55:32 INFO : three.txt: Moved into backup dir 2024/04/18 02:55:33 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/04/18 02:55:33 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:55:33 DEBUG : two: Unchanged skipping 2024/04/18 02:55:33 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for checks to finish 2024/04/18 02:55:33 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/18 02:55:33 INFO : one: Copied (server-side copy) to: one.bak 2024/04/18 02:55:34 INFO : one: Deleted 2024/04/18 02:55:34 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for transfers to finish 2024/04/18 02:55:34 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2024/04/18 02:55:34 INFO : one: Copied (new) 2024/04/18 02:55:34 DEBUG : Waiting for deletions to finish 2024/04/18 02:55:35 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/04/18 02:55:35 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/04/18 02:55:35 INFO : three.txt: Deleted 2024/04/18 02:55:35 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (12.80s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:55:39 DEBUG : Creating backend with remote "TestB2:rclone-test-pozucow4nemibit1qujeraz7/dst" 2024/04/18 02:55:40 DEBUG : Creating backend with remote "TestB2:rclone-test-pozucow4nemibit1qujeraz7/backup" 2024/04/18 02:55:41 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for checks to finish 2024/04/18 02:55:41 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/04/18 02:55:41 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:55:41 DEBUG : two: Unchanged skipping 2024/04/18 02:55:42 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/04/18 02:55:42 INFO : one: Copied (server-side copy) to: one-2019-01-01 2024/04/18 02:55:42 INFO : one: Deleted 2024/04/18 02:55:42 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for transfers to finish 2024/04/18 02:55:43 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/18 02:55:43 INFO : one: Copied (new) 2024/04/18 02:55:43 DEBUG : Waiting for deletions to finish 2024/04/18 02:55:45 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2024/04/18 02:55:45 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2024/04/18 02:55:45 INFO : three.txt: Deleted 2024/04/18 02:55:45 INFO : three.txt: Moved into backup dir 2024/04/18 02:55:46 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/04/18 02:55:46 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:55:46 DEBUG : two: Unchanged skipping 2024/04/18 02:55:46 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for checks to finish 2024/04/18 02:55:47 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/18 02:55:47 INFO : one: Copied (server-side copy) to: one-2019-01-01 2024/04/18 02:55:47 INFO : one: Deleted 2024/04/18 02:55:47 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for transfers to finish 2024/04/18 02:55:48 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2024/04/18 02:55:48 INFO : one: Copied (new) 2024/04/18 02:55:48 DEBUG : Waiting for deletions to finish 2024/04/18 02:55:48 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/04/18 02:55:48 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2024/04/18 02:55:48 INFO : three.txt: Deleted 2024/04/18 02:55:48 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (13.42s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:55:53 DEBUG : Creating backend with remote "TestB2:rclone-test-pozucow4nemibit1qujeraz7/dst" 2024/04/18 02:55:54 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/04/18 02:55:54 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for checks to finish 2024/04/18 02:55:54 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:55:54 DEBUG : two: Unchanged skipping 2024/04/18 02:55:55 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/04/18 02:55:55 INFO : one: Copied (server-side copy) to: one.bak 2024/04/18 02:55:55 INFO : one: Deleted 2024/04/18 02:55:55 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for transfers to finish 2024/04/18 02:55:56 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/18 02:55:56 INFO : one: Copied (new) 2024/04/18 02:55:56 DEBUG : Waiting for deletions to finish 2024/04/18 02:55:57 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2024/04/18 02:55:57 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/04/18 02:55:57 INFO : three.txt: Deleted 2024/04/18 02:55:57 INFO : three.txt: Moved into backup dir 2024/04/18 02:55:58 DEBUG : one.bak: Excluded (Path Filter) 2024/04/18 02:55:58 DEBUG : one.bak: Excluded 2024/04/18 02:55:58 DEBUG : three.txt.bak: Excluded (Path Filter) 2024/04/18 02:55:58 DEBUG : three.txt.bak: Excluded 2024/04/18 02:55:58 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/04/18 02:55:58 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:55:58 DEBUG : two: Unchanged skipping 2024/04/18 02:55:58 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for checks to finish 2024/04/18 02:55:59 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/18 02:55:59 INFO : one: Copied (server-side copy) to: one.bak 2024/04/18 02:55:59 INFO : one: Deleted 2024/04/18 02:55:59 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7 path dst: Waiting for transfers to finish 2024/04/18 02:55:59 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2024/04/18 02:55:59 INFO : one: Copied (new) 2024/04/18 02:55:59 DEBUG : Waiting for deletions to finish 2024/04/18 02:56:00 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/04/18 02:56:00 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/04/18 02:56:00 INFO : three.txt: Deleted 2024/04/18 02:56:00 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (11.85s) === RUN TestSyncSuffix run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:56:06 DEBUG : Creating backend with remote "TestB2:rclone-test-pozucow4nemibit1qujeraz7/dst" 2024/04/18 02:56:07 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/04/18 02:56:08 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/04/18 02:56:08 INFO : one: Copied (server-side copy) to: one.bak 2024/04/18 02:56:08 INFO : one: Deleted 2024/04/18 02:56:09 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/18 02:56:09 INFO : one: Copied (new) 2024/04/18 02:56:10 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:56:10 DEBUG : two: Unchanged skipping 2024/04/18 02:56:10 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2024/04/18 02:56:10 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2024/04/18 02:56:10 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/04/18 02:56:10 INFO : three.txt: Deleted 2024/04/18 02:56:11 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/04/18 02:56:11 INFO : three.txt: Copied (new) 2024/04/18 02:56:11 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/04/18 02:56:12 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/18 02:56:12 INFO : one: Copied (server-side copy) to: one.bak 2024/04/18 02:56:12 INFO : one: Deleted 2024/04/18 02:56:12 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2024/04/18 02:56:12 INFO : one: Copied (new) 2024/04/18 02:56:12 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:56:12 DEBUG : two: Unchanged skipping 2024/04/18 02:56:13 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2024/04/18 02:56:13 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/04/18 02:56:13 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/04/18 02:56:13 INFO : three.txt: Deleted 2024/04/18 02:56:14 DEBUG : three.txt: sha1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK 2024/04/18 02:56:14 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (13.72s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:56:18 DEBUG : Creating backend with remote "TestB2:rclone-test-pozucow4nemibit1qujeraz7/dst" 2024/04/18 02:56:20 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/04/18 02:56:21 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/04/18 02:56:21 INFO : one: Copied (server-side copy) to: one-2019-01-01 2024/04/18 02:56:21 INFO : one: Deleted 2024/04/18 02:56:22 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/18 02:56:22 INFO : one: Copied (new) 2024/04/18 02:56:22 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:56:22 DEBUG : two: Unchanged skipping 2024/04/18 02:56:22 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2024/04/18 02:56:23 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2024/04/18 02:56:23 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2024/04/18 02:56:23 INFO : three.txt: Deleted 2024/04/18 02:56:24 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/04/18 02:56:24 INFO : three.txt: Copied (new) 2024/04/18 02:56:25 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/04/18 02:56:26 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/04/18 02:56:26 INFO : one: Copied (server-side copy) to: one-2019-01-01 2024/04/18 02:56:26 INFO : one: Deleted 2024/04/18 02:56:27 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2024/04/18 02:56:27 INFO : one: Copied (new) 2024/04/18 02:56:27 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:56:27 DEBUG : two: Unchanged skipping 2024/04/18 02:56:27 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2024/04/18 02:56:28 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/04/18 02:56:28 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2024/04/18 02:56:28 INFO : three.txt: Deleted 2024/04/18 02:56:30 DEBUG : three.txt: sha1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK 2024/04/18 02:56:30 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (15.79s) === RUN TestSyncUTFNorm run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:56:33 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:56:33 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2024/04/18 02:56:33 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:56:34 DEBUG : Testêé: sha1 = a54d88e06612d820bc3be72877c74f257b561b19 OK 2024/04/18 02:56:34 INFO : Testêé: Copied (replaced existing) to: Testêé 2024/04/18 02:56:34 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (3.20s) === RUN TestSyncImmutable run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:56:35 DEBUG : existing: Need to transfer - File not found at Destination 2024/04/18 02:56:35 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:56:35 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:56:36 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2024/04/18 02:56:36 INFO : existing: Copied (new) 2024/04/18 02:56:36 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:56:36 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2024/04/18 02:56:36 ERROR : existing: Source and destination exist but do not match: immutable file modified 2024/04/18 02:56:36 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:56:36 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:56:36 ERROR : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: not deleting files as there were IO errors 2024/04/18 02:56:36 ERROR : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: not deleting directories as there were IO errors run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestSyncImmutable (3.57s) === RUN TestSyncIgnoreCase run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:56:39 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:56:39 DEBUG : existing: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:56:39 DEBUG : existing: Unchanged skipping 2024/04/18 02:56:39 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:56:39 DEBUG : Waiting for deletions to finish 2024/04/18 02:56:39 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (2.24s) === RUN TestFixCase run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" sync_test.go:2420: Skipping test as local or remote are case-sensitive --- SKIP: TestFixCase (0.37s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" sync_test.go:2459: This test only runs on local === RUN TestMaxTransfer/Soft run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" sync_test.go:2459: This test only runs on local === RUN TestMaxTransfer/Cautious run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" sync_test.go:2459: This test only runs on local --- PASS: TestMaxTransfer (1.16s) --- SKIP: TestMaxTransfer/Hard (0.41s) --- SKIP: TestMaxTransfer/Soft (0.38s) --- SKIP: TestMaxTransfer/Cautious (0.38s) === RUN TestSyncConcurrentDelete run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:57:05 DEBUG : both0: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:05 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:57:05 DEBUG : both1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:05 DEBUG : both10: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:05 DEBUG : both11: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:05 DEBUG : both0: Unchanged skipping 2024/04/18 02:57:05 DEBUG : both12: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:05 DEBUG : both1: Unchanged skipping 2024/04/18 02:57:05 DEBUG : both13: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:05 DEBUG : both13: Unchanged skipping 2024/04/18 02:57:05 DEBUG : both14: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:05 DEBUG : both14: Unchanged skipping 2024/04/18 02:57:05 DEBUG : both15: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:05 DEBUG : both15: Unchanged skipping 2024/04/18 02:57:05 DEBUG : both16: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:05 DEBUG : both16: Unchanged skipping 2024/04/18 02:57:05 DEBUG : both17: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:05 DEBUG : both17: Unchanged skipping 2024/04/18 02:57:05 DEBUG : both18: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:05 DEBUG : both18: Unchanged skipping 2024/04/18 02:57:05 DEBUG : both19: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:05 DEBUG : both19: Unchanged skipping 2024/04/18 02:57:05 DEBUG : both2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:05 DEBUG : both2: Unchanged skipping 2024/04/18 02:57:05 DEBUG : both3: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:05 DEBUG : both3: Unchanged skipping 2024/04/18 02:57:05 DEBUG : both4: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:05 DEBUG : both4: Unchanged skipping 2024/04/18 02:57:05 DEBUG : both5: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:05 DEBUG : both5: Unchanged skipping 2024/04/18 02:57:05 DEBUG : both6: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:05 DEBUG : both6: Unchanged skipping 2024/04/18 02:57:05 DEBUG : both7: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:05 DEBUG : both7: Unchanged skipping 2024/04/18 02:57:05 DEBUG : both8: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:05 DEBUG : both8: Unchanged skipping 2024/04/18 02:57:05 DEBUG : both9: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:05 DEBUG : both9: Unchanged skipping 2024/04/18 02:57:05 DEBUG : both10: Unchanged skipping 2024/04/18 02:57:05 DEBUG : both11: Unchanged skipping 2024/04/18 02:57:05 DEBUG : both12: Unchanged skipping 2024/04/18 02:57:05 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:57:05 DEBUG : Waiting for deletions to finish 2024/04/18 02:57:05 INFO : only15: Deleted 2024/04/18 02:57:05 INFO : only17: Deleted 2024/04/18 02:57:06 INFO : only18: Deleted 2024/04/18 02:57:06 INFO : only7: Deleted 2024/04/18 02:57:06 INFO : only6: Deleted 2024/04/18 02:57:06 INFO : only0: Deleted 2024/04/18 02:57:06 INFO : only10: Deleted 2024/04/18 02:57:06 INFO : only2: Deleted 2024/04/18 02:57:06 INFO : only11: Deleted 2024/04/18 02:57:06 INFO : only4: Deleted 2024/04/18 02:57:06 INFO : only13: Deleted 2024/04/18 02:57:06 INFO : only14: Deleted 2024/04/18 02:57:06 INFO : only16: Deleted 2024/04/18 02:57:06 INFO : only9: Deleted 2024/04/18 02:57:06 INFO : only12: Deleted 2024/04/18 02:57:06 INFO : only19: Deleted 2024/04/18 02:57:06 INFO : only8: Deleted 2024/04/18 02:57:06 INFO : only1: Deleted 2024/04/18 02:57:06 INFO : only3: Deleted 2024/04/18 02:57:06 INFO : only5: Deleted 2024/04/18 02:57:06 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestSyncConcurrentDelete (29.55s) === RUN TestSyncConcurrentTruncate run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:57:38 DEBUG : both0: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:38 DEBUG : both0: Unchanged skipping 2024/04/18 02:57:38 DEBUG : both1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:38 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for checks to finish 2024/04/18 02:57:38 DEBUG : both10: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:38 DEBUG : both11: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:38 DEBUG : both1: Unchanged skipping 2024/04/18 02:57:38 DEBUG : both12: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:38 DEBUG : both12: Unchanged skipping 2024/04/18 02:57:38 DEBUG : both13: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:38 DEBUG : both13: Unchanged skipping 2024/04/18 02:57:38 DEBUG : both14: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:38 DEBUG : both14: Unchanged skipping 2024/04/18 02:57:38 DEBUG : both15: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:38 DEBUG : both15: Unchanged skipping 2024/04/18 02:57:38 DEBUG : both16: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:38 DEBUG : both16: Unchanged skipping 2024/04/18 02:57:38 DEBUG : both17: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:38 DEBUG : both17: Unchanged skipping 2024/04/18 02:57:38 DEBUG : both18: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:38 DEBUG : both18: Unchanged skipping 2024/04/18 02:57:38 DEBUG : both19: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:38 DEBUG : both19: Unchanged skipping 2024/04/18 02:57:38 DEBUG : both2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:38 DEBUG : both2: Unchanged skipping 2024/04/18 02:57:38 DEBUG : both3: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:38 DEBUG : both3: Unchanged skipping 2024/04/18 02:57:38 DEBUG : both4: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:38 DEBUG : both4: Unchanged skipping 2024/04/18 02:57:38 DEBUG : both5: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:38 DEBUG : both5: Unchanged skipping 2024/04/18 02:57:38 DEBUG : both6: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:38 DEBUG : both6: Unchanged skipping 2024/04/18 02:57:38 DEBUG : both7: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:38 DEBUG : both7: Unchanged skipping 2024/04/18 02:57:38 DEBUG : both8: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:38 DEBUG : both8: Unchanged skipping 2024/04/18 02:57:38 DEBUG : both9: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/04/18 02:57:38 DEBUG : both9: Unchanged skipping 2024/04/18 02:57:38 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2024/04/18 02:57:38 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2024/04/18 02:57:38 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2024/04/18 02:57:38 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2024/04/18 02:57:38 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2024/04/18 02:57:38 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2024/04/18 02:57:38 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2024/04/18 02:57:38 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2024/04/18 02:57:38 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2024/04/18 02:57:38 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2024/04/18 02:57:38 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2024/04/18 02:57:38 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2024/04/18 02:57:38 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2024/04/18 02:57:38 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2024/04/18 02:57:38 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2024/04/18 02:57:38 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2024/04/18 02:57:38 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2024/04/18 02:57:38 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2024/04/18 02:57:38 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2024/04/18 02:57:38 DEBUG : both10: Unchanged skipping 2024/04/18 02:57:38 DEBUG : both11: Unchanged skipping 2024/04/18 02:57:38 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2024/04/18 02:57:38 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Waiting for transfers to finish 2024/04/18 02:57:38 DEBUG : only0: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/18 02:57:38 INFO : only0: Copied (replaced existing) 2024/04/18 02:57:38 DEBUG : only1: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/18 02:57:38 INFO : only1: Copied (replaced existing) 2024/04/18 02:57:38 DEBUG : only10: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/18 02:57:38 INFO : only10: Copied (replaced existing) 2024/04/18 02:57:38 DEBUG : only12: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/18 02:57:38 INFO : only12: Copied (replaced existing) 2024/04/18 02:57:38 DEBUG : only14: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/18 02:57:38 INFO : only14: Copied (replaced existing) 2024/04/18 02:57:38 DEBUG : only13: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/18 02:57:38 INFO : only13: Copied (replaced existing) 2024/04/18 02:57:38 DEBUG : only15: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/18 02:57:38 INFO : only15: Copied (replaced existing) 2024/04/18 02:57:38 DEBUG : only16: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/18 02:57:38 INFO : only16: Copied (replaced existing) 2024/04/18 02:57:38 DEBUG : only17: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/18 02:57:38 INFO : only17: Copied (replaced existing) 2024/04/18 02:57:38 DEBUG : only18: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/18 02:57:38 INFO : only18: Copied (replaced existing) 2024/04/18 02:57:38 DEBUG : only19: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/18 02:57:38 INFO : only19: Copied (replaced existing) 2024/04/18 02:57:38 DEBUG : only2: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/18 02:57:38 INFO : only2: Copied (replaced existing) 2024/04/18 02:57:38 DEBUG : only11: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/18 02:57:38 INFO : only11: Copied (replaced existing) 2024/04/18 02:57:38 DEBUG : only3: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/18 02:57:38 INFO : only3: Copied (replaced existing) 2024/04/18 02:57:38 DEBUG : only4: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/18 02:57:38 INFO : only4: Copied (replaced existing) 2024/04/18 02:57:39 DEBUG : only5: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/18 02:57:39 INFO : only5: Copied (replaced existing) 2024/04/18 02:57:39 DEBUG : only6: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/18 02:57:39 INFO : only6: Copied (replaced existing) 2024/04/18 02:57:39 DEBUG : only9: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/18 02:57:39 INFO : only9: Copied (replaced existing) 2024/04/18 02:57:39 DEBUG : only8: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/18 02:57:39 INFO : only8: Copied (replaced existing) 2024/04/18 02:57:39 DEBUG : only7: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/04/18 02:57:39 INFO : only7: Copied (replaced existing) 2024/04/18 02:57:39 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestSyncConcurrentTruncate (36.19s) === RUN TestNothingToTransfer run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" 2024/04/18 02:57:47 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/04/18 02:57:47 DEBUG : sub dir: Making directory 2024/04/18 02:57:47 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-pozucow4nemibit1qujeraz7", Local "Local file system at /tmp/rclone401943241", Modify Window "1ms" --- PASS: TestNothingToTransfer (5.24s) PASS 2024/04/18 02:57:53 DEBUG : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: Purge remote 2024/04/18 02:57:53 INFO : B2 bucket rclone-test-pozucow4nemibit1qujeraz7: cleaning bucket "rclone-test-pozucow4nemibit1qujeraz7" of all files 2024/04/18 02:57:54 DEBUG : BackupDir/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd262_d20240418_m025509_c001_v7007000_t0000_u01713408909967") 2024/04/18 02:57:54 DEBUG : BackupDir/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1129993a43718c49_d20240418_m025503_c001_v0001180_t0024_u01713408903431") 2024/04/18 02:57:54 DEBUG : CompareDest/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4036c57b123971d2_d20240418_m025447_c001_v7007000_t0000_u01713408887317") 2024/04/18 02:57:54 DEBUG : CompareDest/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c684c_d20240418_m025440_c001_v0001145_t0018_u01713408880469") 2024/04/18 02:57:54 DEBUG : CompareDest/two: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4036c57b123971d3_d20240418_m025447_c001_v7007000_t0000_u01713408887497") 2024/04/18 02:57:54 DEBUG : CompareDest/two: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece219a_d20240418_m025442_c001_v0001157_t0051_u01713408882662") 2024/04/18 02:57:54 DEBUG : CopyDest/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd263_d20240418_m025510_c001_v7007000_t0000_u01713408910155") 2024/04/18 02:57:54 DEBUG : CopyDest/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d417cc_d20240418_m025500_c001_v0001023_t0018_u01713408900916") 2024/04/18 02:57:54 DEBUG : CopyDest/three: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd266_d20240418_m025510_c001_v7007000_t0000_u01713408910336") 2024/04/18 02:57:54 DEBUG : CopyDest/three: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece2252_d20240418_m025507_c001_v0001157_t0024_u01713408907815") 2024/04/18 02:57:54 DEBUG : CopyDest/two: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd267_d20240418_m025510_c001_v7007000_t0000_u01713408910529") 2024/04/18 02:57:54 DEBUG : CopyDest/two: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c68ae_d20240418_m025504_c001_v0001145_t0018_u01713408904736") 2024/04/18 02:57:54 DEBUG : EXISTING: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f410e34a255e2df21_d20240418_m025640_c001_v7007000_t0000_u01713409000374") 2024/04/18 02:57:54 DEBUG : EXISTING: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6a16_d20240418_m025638_c001_v0001145_t0057_u01713408998877") 2024/04/18 02:57:54 DEBUG : Testêé: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f410e34a255e2df18_d20240418_m025634_c001_v7007000_t0000_u01713408994545") 2024/04/18 02:57:55 DEBUG : Testêé: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece249e_d20240418_m025633_c001_v0001157_t0038_u01713408993526") 2024/04/18 02:57:55 DEBUG : Testêé: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c69f2_d20240418_m025632_c001_v0001145_t0025_u01713408992109") 2024/04/18 02:57:55 DEBUG : a/potato2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f405c3359571bb85e_d20240418_m025255_c001_v7007000_t0000_u01713408775235") 2024/04/18 02:57:55 DEBUG : a/potato2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1e9a_d20240418_m025254_c001_v0001157_t0010_u01713408774280") 2024/04/18 02:57:55 DEBUG : a/potato2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f401fc33db36f4274_d20240418_m025251_c001_v7007000_t0000_u01713408771989") 2024/04/18 02:57:55 DEBUG : a/potato2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1e7e_d20240418_m025250_c001_v0001157_t0027_u01713408770871") 2024/04/18 02:57:55 DEBUG : a/potato2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f405c3359571bb814_d20240418_m025228_c001_v7007000_t0000_u01713408748213") 2024/04/18 02:57:55 DEBUG : a/potato2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1da2_d20240418_m025227_c001_v0001157_t0015_u01713408747112") 2024/04/18 02:57:55 DEBUG : b/potato: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f405c3359571bb85f_d20240418_m025255_c001_v7007000_t0000_u01713408775417") 2024/04/18 02:57:55 DEBUG : b/potato: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1e8a_d20240418_m025252_c001_v0001157_t0015_u01713408772924") 2024/04/18 02:57:55 DEBUG : b/potato: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f401fc33db36f426c_d20240418_m025251_c001_v7007000_t0000_u01713408771437") 2024/04/18 02:57:55 DEBUG : b/potato: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1e6a_d20240418_m025249_c001_v0001157_t0051_u01713408769456") 2024/04/18 02:57:55 DEBUG : b/potato: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f405c3359571bb812_d20240418_m025227_c001_v7007000_t0000_u01713408747663") 2024/04/18 02:57:55 DEBUG : b/potato: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1d90_d20240418_m025225_c001_v0001157_t0032_u01713408745621") 2024/04/18 02:57:55 DEBUG : backup/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd2a4_d20240418_m025523_c001_v7007000_t0000_u01713408923224") 2024/04/18 02:57:55 DEBUG : backup/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1023dcb14a2a29a1_d20240418_m025520_c001_v0001025_t0012_u01713408920590") 2024/04/18 02:57:55 DEBUG : backup/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f110fea406ae39444_d20240418_m025516_c001_v0001178_t0002_u01713408916962") 2024/04/18 02:57:55 DEBUG : backup/one-2019-01-01: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd2eb_d20240418_m025549_c001_v7007000_t0000_u01713408949392") 2024/04/18 02:57:55 DEBUG : backup/one-2019-01-01: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1155c3301106920a_d20240418_m025547_c001_v0001181_t0008_u01713408947098") 2024/04/18 02:57:55 DEBUG : backup/one-2019-01-01: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f103deeadc9f7eeed_d20240418_m025542_c001_v0001136_t0023_u01713408942173") 2024/04/18 02:57:56 DEBUG : backup/one.bak: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd2d6_d20240418_m025535_c001_v7007000_t0000_u01713408935977") 2024/04/18 02:57:56 DEBUG : backup/one.bak: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f101e46fb315a9af1_d20240418_m025533_c001_v0001165_t0041_u01713408933740") 2024/04/18 02:57:56 DEBUG : backup/one.bak: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1138f8fa37e1ab2a_d20240418_m025529_c001_v0001180_t0056_u01713408929941") 2024/04/18 02:57:56 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd2ec_d20240418_m025549_c001_v7007000_t0000_u01713408949628") 2024/04/18 02:57:56 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1166f54242294259_d20240418_m025548_c001_v0001039_t0036_u01713408948358") 2024/04/18 02:57:56 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1050cc424ed8a356_d20240418_m025544_c001_v0001116_t0045_u01713408944076") 2024/04/18 02:57:56 DEBUG : backup/three.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd2a8_d20240418_m025523_c001_v7007000_t0000_u01713408923404") 2024/04/18 02:57:56 DEBUG : backup/three.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1112ad11348214a7_d20240418_m025522_c001_v0001181_t0033_u01713408922295") 2024/04/18 02:57:56 DEBUG : backup/three.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f118e4a7c3856dbee_d20240418_m025518_c001_v0001172_t0004_u01713408918416") 2024/04/18 02:57:56 DEBUG : backup/three.txt.bak: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd2d7_d20240418_m025536_c001_v7007000_t0000_u01713408936157") 2024/04/18 02:57:56 DEBUG : backup/three.txt.bak: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f119c0b83c119aa68_d20240418_m025535_c001_v0001091_t0046_u01713408935072") 2024/04/18 02:57:56 DEBUG : backup/three.txt.bak: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f10782ca9f5101602_d20240418_m025531_c001_v0001179_t0053_u01713408931744") 2024/04/18 02:57:56 DEBUG : both0: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9a3_d20240418_m025739_c001_v7007000_t0000_u01713409059815") 2024/04/18 02:57:56 DEBUG : both0: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d4197b_d20240418_m025712_c001_v0001023_t0005_u01713409032187") 2024/04/18 02:57:56 DEBUG : both0: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d624a5_d20240418_m025707_c001_v7007000_t0000_u01713409027442") 2024/04/18 02:57:56 DEBUG : both0: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece24d6_d20240418_m025642_c001_v0001157_t0025_u01713409002657") 2024/04/18 02:57:56 DEBUG : both1: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9a4_d20240418_m025739_c001_v7007000_t0000_u01713409059997") 2024/04/18 02:57:56 DEBUG : both1: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece25c4_d20240418_m025713_c001_v0001157_t0028_u01713409033918") 2024/04/18 02:57:57 DEBUG : both1: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d624a6_d20240418_m025707_c001_v7007000_t0000_u01713409027636") 2024/04/18 02:57:57 DEBUG : both1: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6a2a_d20240418_m025644_c001_v0001145_t0009_u01713409004235") 2024/04/18 02:57:57 DEBUG : both10: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9a5_d20240418_m025740_c001_v7007000_t0000_u01713409060196") 2024/04/18 02:57:57 DEBUG : both10: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece2614_d20240418_m025727_c001_v0001157_t0050_u01713409047051") 2024/04/18 02:57:57 DEBUG : both10: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d624a8_d20240418_m025707_c001_v7007000_t0000_u01713409027818") 2024/04/18 02:57:57 DEBUG : both10: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6a51_d20240418_m025653_c001_v0001145_t0048_u01713409013488") 2024/04/18 02:57:57 DEBUG : both11: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9a7_d20240418_m025740_c001_v7007000_t0000_u01713409060380") 2024/04/18 02:57:57 DEBUG : both11: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6ac7_d20240418_m025728_c001_v0001145_t0047_u01713409048011") 2024/04/18 02:57:57 DEBUG : both11: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d624a9_d20240418_m025708_c001_v7007000_t0000_u01713409028011") 2024/04/18 02:57:57 DEBUG : both11: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d41932_d20240418_m025654_c001_v0001023_t0015_u01713409014733") 2024/04/18 02:57:57 DEBUG : both12: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9a8_d20240418_m025740_c001_v7007000_t0000_u01713409060564") 2024/04/18 02:57:57 DEBUG : both12: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d419b5_d20240418_m025729_c001_v0001023_t0041_u01713409049139") 2024/04/18 02:57:57 DEBUG : both12: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d624aa_d20240418_m025708_c001_v7007000_t0000_u01713409028193") 2024/04/18 02:57:57 DEBUG : both12: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece2556_d20240418_m025655_c001_v0001157_t0003_u01713409015997") 2024/04/18 02:57:57 DEBUG : both13: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9a9_d20240418_m025740_c001_v7007000_t0000_u01713409060763") 2024/04/18 02:57:57 DEBUG : both13: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece262c_d20240418_m025729_c001_v0001157_t0025_u01713409049868") 2024/04/18 02:57:57 DEBUG : both13: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d624ae_d20240418_m025708_c001_v7007000_t0000_u01713409028391") 2024/04/18 02:57:57 DEBUG : both13: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6a5f_d20240418_m025656_c001_v0001145_t0034_u01713409016809") 2024/04/18 02:57:57 DEBUG : both14: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9ab_d20240418_m025740_c001_v7007000_t0000_u01713409060947") 2024/04/18 02:57:57 DEBUG : both14: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6acf_d20240418_m025730_c001_v0001145_t0011_u01713409050825") 2024/04/18 02:57:58 DEBUG : both14: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d624af_d20240418_m025708_c001_v7007000_t0000_u01713409028582") 2024/04/18 02:57:58 DEBUG : both14: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d41944_d20240418_m025658_c001_v0001023_t0000_u01713409018291") 2024/04/18 02:57:58 DEBUG : both15: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9ac_d20240418_m025741_c001_v7007000_t0000_u01713409061132") 2024/04/18 02:57:58 DEBUG : both15: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d419c1_d20240418_m025731_c001_v0001023_t0004_u01713409051725") 2024/04/18 02:57:58 DEBUG : both15: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d624b0_d20240418_m025708_c001_v7007000_t0000_u01713409028777") 2024/04/18 02:57:58 DEBUG : both15: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece256c_d20240418_m025659_c001_v0001157_t0007_u01713409019310") 2024/04/18 02:57:58 DEBUG : both16: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9ad_d20240418_m025741_c001_v7007000_t0000_u01713409061377") 2024/04/18 02:57:58 DEBUG : both16: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece264a_d20240418_m025732_c001_v0001157_t0047_u01713409052975") 2024/04/18 02:57:58 DEBUG : both16: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d624b1_d20240418_m025708_c001_v7007000_t0000_u01713409028958") 2024/04/18 02:57:58 DEBUG : both16: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6a6f_d20240418_m025700_c001_v0001145_t0011_u01713409020115") 2024/04/18 02:57:58 DEBUG : both17: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9af_d20240418_m025741_c001_v7007000_t0000_u01713409061561") 2024/04/18 02:57:58 DEBUG : both17: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6ad7_d20240418_m025733_c001_v0001145_t0034_u01713409053939") 2024/04/18 02:57:58 DEBUG : both17: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d624b2_d20240418_m025709_c001_v7007000_t0000_u01713409029152") 2024/04/18 02:57:58 DEBUG : both17: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d41950_d20240418_m025701_c001_v0001023_t0007_u01713409021239") 2024/04/18 02:57:58 DEBUG : both18: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9b0_d20240418_m025741_c001_v7007000_t0000_u01713409061761") 2024/04/18 02:57:58 DEBUG : both18: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d419cb_d20240418_m025735_c001_v0001023_t0037_u01713409055045") 2024/04/18 02:57:58 DEBUG : both18: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d624b3_d20240418_m025709_c001_v7007000_t0000_u01713409029343") 2024/04/18 02:57:59 DEBUG : both18: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece257e_d20240418_m025702_c001_v0001157_t0012_u01713409022654") 2024/04/18 02:57:59 DEBUG : both19: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9b1_d20240418_m025741_c001_v7007000_t0000_u01713409061980") 2024/04/18 02:57:59 DEBUG : both19: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece2666_d20240418_m025736_c001_v0001157_t0036_u01713409056471") 2024/04/18 02:57:59 DEBUG : both19: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d624b4_d20240418_m025709_c001_v7007000_t0000_u01713409029525") 2024/04/18 02:57:59 DEBUG : both19: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6a77_d20240418_m025703_c001_v0001145_t0000_u01713409023539") 2024/04/18 02:57:59 DEBUG : both2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9b4_d20240418_m025742_c001_v7007000_t0000_u01713409062164") 2024/04/18 02:57:59 DEBUG : both2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6aa1_d20240418_m025714_c001_v0001145_t0025_u01713409034809") 2024/04/18 02:57:59 DEBUG : both2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d624b5_d20240418_m025709_c001_v7007000_t0000_u01713409029708") 2024/04/18 02:57:59 DEBUG : both2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d41906_d20240418_m025645_c001_v0001023_t0000_u01713409005178") 2024/04/18 02:57:59 DEBUG : both3: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9b5_d20240418_m025742_c001_v7007000_t0000_u01713409062346") 2024/04/18 02:57:59 DEBUG : both3: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d4198b_d20240418_m025715_c001_v0001023_t0024_u01713409035792") 2024/04/18 02:57:59 DEBUG : both3: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d624b6_d20240418_m025709_c001_v7007000_t0000_u01713409029919") 2024/04/18 02:57:59 DEBUG : both3: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece24f2_d20240418_m025646_c001_v0001157_t0005_u01713409006209") 2024/04/18 02:57:59 DEBUG : both4: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9b7_d20240418_m025742_c001_v7007000_t0000_u01713409062541") 2024/04/18 02:57:59 DEBUG : both4: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece25d4_d20240418_m025717_c001_v0001157_t0022_u01713409037231") 2024/04/18 02:57:59 DEBUG : both4: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d624b7_d20240418_m025710_c001_v7007000_t0000_u01713409030118") 2024/04/18 02:57:59 DEBUG : both4: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6a35_d20240418_m025647_c001_v0001145_t0021_u01713409007240") 2024/04/18 02:57:59 DEBUG : both5: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9b8_d20240418_m025742_c001_v7007000_t0000_u01713409062725") 2024/04/18 02:57:59 DEBUG : both5: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6aab_d20240418_m025718_c001_v0001145_t0026_u01713409038166") 2024/04/18 02:58:00 DEBUG : both5: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d624b8_d20240418_m025710_c001_v7007000_t0000_u01713409030344") 2024/04/18 02:58:00 DEBUG : both5: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d4190e_d20240418_m025648_c001_v0001023_t0039_u01713409008021") 2024/04/18 02:58:00 DEBUG : both6: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9ba_d20240418_m025742_c001_v7007000_t0000_u01713409062923") 2024/04/18 02:58:00 DEBUG : both6: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d4199f_d20240418_m025720_c001_v0001023_t0010_u01713409040589") 2024/04/18 02:58:00 DEBUG : both6: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d624b9_d20240418_m025710_c001_v7007000_t0000_u01713409030527") 2024/04/18 02:58:00 DEBUG : both6: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece2510_d20240418_m025649_c001_v0001157_t0028_u01713409009094") 2024/04/18 02:58:00 DEBUG : both7: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9bb_d20240418_m025743_c001_v7007000_t0000_u01713409063111") 2024/04/18 02:58:00 DEBUG : both7: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece25fc_d20240418_m025722_c001_v0001157_t0030_u01713409042700") 2024/04/18 02:58:00 DEBUG : both7: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d624ba_d20240418_m025710_c001_v7007000_t0000_u01713409030708") 2024/04/18 02:58:00 DEBUG : both7: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6a3d_d20240418_m025650_c001_v0001145_t0009_u01713409010091") 2024/04/18 02:58:00 DEBUG : both8: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9bc_d20240418_m025743_c001_v7007000_t0000_u01713409063296") 2024/04/18 02:58:00 DEBUG : both8: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6abf_d20240418_m025724_c001_v0001145_t0008_u01713409044174") 2024/04/18 02:58:00 DEBUG : both8: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d624bb_d20240418_m025710_c001_v7007000_t0000_u01713409030890") 2024/04/18 02:58:00 DEBUG : both8: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d41922_d20240418_m025651_c001_v0001023_t0032_u01713409011169") 2024/04/18 02:58:00 DEBUG : both9: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9be_d20240418_m025743_c001_v7007000_t0000_u01713409063516") 2024/04/18 02:58:00 DEBUG : both9: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d419a5_d20240418_m025725_c001_v0001023_t0002_u01713409045200") 2024/04/18 02:58:00 DEBUG : both9: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d624bc_d20240418_m025711_c001_v7007000_t0000_u01713409031071") 2024/04/18 02:58:00 DEBUG : both9: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece2538_d20240418_m025652_c001_v0001157_t0026_u01713409012417") 2024/04/18 02:58:01 DEBUG : c/non empty space: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f405c3359571bb860_d20240418_m025255_c001_v7007000_t0000_u01713408775598") 2024/04/18 02:58:01 DEBUG : c/non empty space: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1e8e_d20240418_m025253_c001_v0001157_t0011_u01713408773327") 2024/04/18 02:58:01 DEBUG : c/non empty space: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f401fc33db36f4276_d20240418_m025252_c001_v7007000_t0000_u01713408772171") 2024/04/18 02:58:01 DEBUG : c/non empty space: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1e74_d20240418_m025250_c001_v0001157_t0028_u01713408770069") 2024/04/18 02:58:01 DEBUG : c/non empty space: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f405c3359571bb815_d20240418_m025228_c001_v7007000_t0000_u01713408748394") 2024/04/18 02:58:01 DEBUG : c/non empty space: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1d92_d20240418_m025226_c001_v0001157_t0011_u01713408746139") 2024/04/18 02:58:01 DEBUG : check sum: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda75f_d20240418_m025213_c001_v7007000_t0000_u01713408733450") 2024/04/18 02:58:01 DEBUG : check sum: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1d1e_d20240418_m025212_c001_v0001157_t0036_u01713408732217") 2024/04/18 02:58:01 DEBUG : dest/3: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4036c57b123971e4_d20240418_m025454_c001_v7007000_t0000_u01713408894820") 2024/04/18 02:58:01 DEBUG : dest/3: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f414f8a9d218b83ad_d20240418_m025454_c001_v0001181_t0059_u01713408894010") 2024/04/18 02:58:01 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f410e34a255e2df0f_d20240418_m025630_c001_v7007000_t0000_u01713408990587") 2024/04/18 02:58:01 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f107e876212821d4c_d20240418_m025626_c001_v0001030_t0038_u01713408986586") 2024/04/18 02:58:01 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f410e34a255e2df09_d20240418_m025626_c001_v7007000_t0000_u01713408986379") 2024/04/18 02:58:01 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f107e876212821d34_d20240418_m025621_c001_v0001030_t0009_u01713408981919") 2024/04/18 02:58:01 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f410e34a255e2defe_d20240418_m025621_c001_v7007000_t0000_u01713408981184") 2024/04/18 02:58:01 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c69ba_d20240418_m025616_c001_v0001145_t0035_u01713408976307") 2024/04/18 02:58:01 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f410e34a255e2def6_d20240418_m025614_c001_v7007000_t0000_u01713408974798") 2024/04/18 02:58:01 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1007a68d833bf4af_d20240418_m025612_c001_v0001137_t0059_u01713408972513") 2024/04/18 02:58:01 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f410e34a255e2deef_d20240418_m025612_c001_v7007000_t0000_u01713408972332") 2024/04/18 02:58:02 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1007a68d833bf4a9_d20240418_m025609_c001_v0001137_t0049_u01713408969589") 2024/04/18 02:58:02 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f410e34a255e2deea_d20240418_m025608_c001_v7007000_t0000_u01713408968830") 2024/04/18 02:58:02 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6982_d20240418_m025602_c001_v0001145_t0039_u01713408962588") 2024/04/18 02:58:02 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f410e34a255e2ded8_d20240418_m025601_c001_v7007000_t0000_u01713408961298") 2024/04/18 02:58:02 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f117c37c05bf37a9b_d20240418_m025559_c001_v0001179_t0015_u01713408959559") 2024/04/18 02:58:02 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd2ff_d20240418_m025559_c001_v7007000_t0000_u01713408959378") 2024/04/18 02:58:02 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f117c37c05bf37a27_d20240418_m025556_c001_v0001179_t0039_u01713408956390") 2024/04/18 02:58:02 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd2f8_d20240418_m025555_c001_v7007000_t0000_u01713408955631") 2024/04/18 02:58:02 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d4183e_d20240418_m025550_c001_v0001023_t0036_u01713408950736") 2024/04/18 02:58:02 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd2ed_d20240418_m025549_c001_v7007000_t0000_u01713408949809") 2024/04/18 02:58:02 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1074e05f60ce1ad3_d20240418_m025547_c001_v0001025_t0013_u01713408947596") 2024/04/18 02:58:02 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd2e7_d20240418_m025547_c001_v7007000_t0000_u01713408947401") 2024/04/18 02:58:02 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1074e05f60ce1ac9_d20240418_m025543_c001_v0001025_t0034_u01713408943263") 2024/04/18 02:58:02 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd2dd_d20240418_m025542_c001_v7007000_t0000_u01713408942546") 2024/04/18 02:58:02 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece2324_d20240418_m025537_c001_v0001157_t0010_u01713408937317") 2024/04/18 02:58:02 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd2d8_d20240418_m025536_c001_v7007000_t0000_u01713408936387") 2024/04/18 02:58:02 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1077ca3fd3850ae8_d20240418_m025534_c001_v0001116_t0020_u01713408934152") 2024/04/18 02:58:02 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd2d0_d20240418_m025533_c001_v7007000_t0000_u01713408933951") 2024/04/18 02:58:02 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1077ca3fd3850ada_d20240418_m025530_c001_v0001116_t0032_u01713408930902") 2024/04/18 02:58:03 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd2c8_d20240418_m025530_c001_v7007000_t0000_u01713408930157") 2024/04/18 02:58:03 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c68fa_d20240418_m025524_c001_v0001145_t0023_u01713408924515") 2024/04/18 02:58:03 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd2aa_d20240418_m025523_c001_v7007000_t0000_u01713408923584") 2024/04/18 02:58:03 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f10893ef348d527f3_d20240418_m025521_c001_v0001181_t0019_u01713408921478") 2024/04/18 02:58:03 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd29c_d20240418_m025521_c001_v7007000_t0000_u01713408921264") 2024/04/18 02:58:03 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f10893ef348d52763_d20240418_m025517_c001_v0001181_t0009_u01713408917917") 2024/04/18 02:58:03 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd286_d20240418_m025517_c001_v7007000_t0000_u01713408917173") 2024/04/18 02:58:03 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d417e0_d20240418_m025511_c001_v0001023_t0020_u01713408911829") 2024/04/18 02:58:03 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd268_d20240418_m025510_c001_v7007000_t0000_u01713408910711") 2024/04/18 02:58:03 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f108d59a03e4caa99_d20240418_m025503_c001_v0001172_t0012_u01713408903843") 2024/04/18 02:58:03 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4036c57b123971f1_d20240418_m025503_c001_v7007000_t0000_u01713408903628") 2024/04/18 02:58:03 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece2214_d20240418_m025459_c001_v0001157_t0031_u01713408899606") 2024/04/18 02:58:03 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f11787473891af53c_d20240418_m025458_c001_v0001161_t0012_u01713408898596") 2024/04/18 02:58:03 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f11787473891af530_d20240418_m025457_c001_v0001161_t0059_u01713408897478") 2024/04/18 02:58:03 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4036c57b123971d5_d20240418_m025447_c001_v7007000_t0000_u01713408887686") 2024/04/18 02:58:03 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d41796_d20240418_m025439_c001_v0001023_t0029_u01713408879758") 2024/04/18 02:58:03 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1046d0b0c1eaf40d_d20240418_m025438_c001_v0001179_t0024_u01713408878928") 2024/04/18 02:58:03 DEBUG : dst/one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1046d0b0c1eaf3e3_d20240418_m025437_c001_v0001179_t0036_u01713408877898") 2024/04/18 02:58:04 DEBUG : dst/one-2019-01-01: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f410e34a255e2df10_d20240418_m025630_c001_v7007000_t0000_u01713408990770") 2024/04/18 02:58:04 DEBUG : dst/one-2019-01-01: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f10333be0c8474a25_d20240418_m025625_c001_v0001157_t0003_u01713408985502") 2024/04/18 02:58:04 DEBUG : dst/one-2019-01-01: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f102c971751802fe0_d20240418_m025620_c001_v0001179_t0037_u01713408980978") 2024/04/18 02:58:04 DEBUG : dst/one.bak: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f410e34a255e2def7_d20240418_m025614_c001_v7007000_t0000_u01713408974994") 2024/04/18 02:58:04 DEBUG : dst/one.bak: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f106bb3f40b24c748_d20240418_m025612_c001_v0001179_t0023_u01713408972108") 2024/04/18 02:58:04 DEBUG : dst/one.bak: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1137e8cd89643c6c_d20240418_m025608_c001_v0001179_t0051_u01713408968565") 2024/04/18 02:58:04 DEBUG : dst/one.bak: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f410e34a255e2ded9_d20240418_m025601_c001_v7007000_t0000_u01713408961479") 2024/04/18 02:58:04 DEBUG : dst/one.bak: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f10767f55b81285d1_d20240418_m025559_c001_v0001042_t0013_u01713408959012") 2024/04/18 02:58:04 DEBUG : dst/one.bak: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f108d59a03e4cad65_d20240418_m025555_c001_v0001172_t0051_u01713408955281") 2024/04/18 02:58:04 DEBUG : dst/three: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd26a_d20240418_m025510_c001_v7007000_t0000_u01713408910895") 2024/04/18 02:58:04 DEBUG : dst/three: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f11787473891af588_d20240418_m025509_c001_v0001161_t0032_u01713408909195") 2024/04/18 02:58:04 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f410e34a255e2df12_d20240418_m025630_c001_v7007000_t0000_u01713408990963") 2024/04/18 02:58:04 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1193636ecc173faf_d20240418_m025627_c001_v0001157_t0026_u01713408987853") 2024/04/18 02:58:04 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f106058ac07ff3dce_d20240418_m025623_c001_v0001153_t0011_u01713408983069") 2024/04/18 02:58:04 DEBUG : dst/three.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f410e34a255e2df13_d20240418_m025631_c001_v7007000_t0000_u01713408991172") 2024/04/18 02:58:04 DEBUG : dst/three.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f107e876212821d56_d20240418_m025628_c001_v0001030_t0019_u01713408988528") 2024/04/18 02:58:04 DEBUG : dst/three.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f410e34a255e2df0b_d20240418_m025628_c001_v7007000_t0000_u01713408988335") 2024/04/18 02:58:04 DEBUG : dst/three.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f107e876212821d44_d20240418_m025623_c001_v0001030_t0014_u01713408983656") 2024/04/18 02:58:04 DEBUG : dst/three.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f410e34a255e2df02_d20240418_m025623_c001_v7007000_t0000_u01713408983469") 2024/04/18 02:58:04 DEBUG : dst/three.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d418a2_d20240418_m025617_c001_v0001023_t0005_u01713408977898") 2024/04/18 02:58:04 DEBUG : dst/three.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f410e34a255e2def8_d20240418_m025615_c001_v7007000_t0000_u01713408975178") 2024/04/18 02:58:05 DEBUG : dst/three.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1007a68d833bf4b5_d20240418_m025614_c001_v0001137_t0013_u01713408974014") 2024/04/18 02:58:05 DEBUG : dst/three.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f410e34a255e2def4_d20240418_m025613_c001_v7007000_t0000_u01713408973833") 2024/04/18 02:58:05 DEBUG : dst/three.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1007a68d833bf4ab_d20240418_m025611_c001_v0001137_t0024_u01713408971048") 2024/04/18 02:58:05 DEBUG : dst/three.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f410e34a255e2deee_d20240418_m025610_c001_v7007000_t0000_u01713408970865") 2024/04/18 02:58:05 DEBUG : dst/three.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d41874_d20240418_m025605_c001_v0001023_t0041_u01713408965842") 2024/04/18 02:58:05 DEBUG : dst/three.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd301_d20240418_m025600_c001_v7007000_t0000_u01713408960369") 2024/04/18 02:58:05 DEBUG : dst/three.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d41856_d20240418_m025557_c001_v0001023_t0000_u01713408957978") 2024/04/18 02:58:05 DEBUG : dst/three.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd2fa_d20240418_m025557_c001_v7007000_t0000_u01713408957254") 2024/04/18 02:58:05 DEBUG : dst/three.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece238e_d20240418_m025552_c001_v0001157_t0001_u01713408952779") 2024/04/18 02:58:05 DEBUG : dst/three.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd2e9_d20240418_m025548_c001_v7007000_t0000_u01713408948800") 2024/04/18 02:58:05 DEBUG : dst/three.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece236a_d20240418_m025546_c001_v0001157_t0027_u01713408946180") 2024/04/18 02:58:05 DEBUG : dst/three.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd2e2_d20240418_m025545_c001_v7007000_t0000_u01713408945404") 2024/04/18 02:58:05 DEBUG : dst/three.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6926_d20240418_m025539_c001_v0001145_t0042_u01713408939121") 2024/04/18 02:58:05 DEBUG : dst/three.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd2d4_d20240418_m025535_c001_v7007000_t0000_u01713408935429") 2024/04/18 02:58:05 DEBUG : dst/three.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6914_d20240418_m025532_c001_v0001145_t0032_u01713408932710") 2024/04/18 02:58:05 DEBUG : dst/three.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd2ce_d20240418_m025531_c001_v7007000_t0000_u01713408931969") 2024/04/18 02:58:05 DEBUG : dst/three.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d41800_d20240418_m025526_c001_v0001023_t0006_u01713408926568") 2024/04/18 02:58:06 DEBUG : dst/three.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd2a3_d20240418_m025522_c001_v7007000_t0000_u01713408922680") 2024/04/18 02:58:06 DEBUG : dst/three.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d417f4_d20240418_m025519_c001_v0001023_t0024_u01713408919558") 2024/04/18 02:58:06 DEBUG : dst/three.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd28c_d20240418_m025518_c001_v7007000_t0000_u01713408918828") 2024/04/18 02:58:06 DEBUG : dst/three.txt: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece2280_d20240418_m025513_c001_v0001157_t0036_u01713408913883") 2024/04/18 02:58:06 DEBUG : dst/three.txt.bak: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f410e34a255e2def9_d20240418_m025615_c001_v7007000_t0000_u01713408975360") 2024/04/18 02:58:06 DEBUG : dst/three.txt.bak: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f10276661e5ea4322_d20240418_m025613_c001_v0001093_t0016_u01713408973478") 2024/04/18 02:58:06 DEBUG : dst/three.txt.bak: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f102c971751802e2d_d20240418_m025610_c001_v0001179_t0024_u01713408970496") 2024/04/18 02:58:06 DEBUG : dst/three.txt.bak: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f410e34a255e2dedb_d20240418_m025601_c001_v7007000_t0000_u01713408961660") 2024/04/18 02:58:06 DEBUG : dst/three.txt.bak: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f107fe7cb92e8a843_d20240418_m025559_c001_v0001098_t0056_u01713408959965") 2024/04/18 02:58:06 DEBUG : dst/three.txt.bak: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1173fd683451f10b_d20240418_m025556_c001_v0001181_t0034_u01713408956964") 2024/04/18 02:58:06 DEBUG : dst/two: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f410e34a255e2df15_d20240418_m025631_c001_v7007000_t0000_u01713408991353") 2024/04/18 02:58:06 DEBUG : dst/two: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece2428_d20240418_m025616_c001_v0001157_t0029_u01713408976946") 2024/04/18 02:58:06 DEBUG : dst/two: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f410e34a255e2defa_d20240418_m025615_c001_v7007000_t0000_u01713408975566") 2024/04/18 02:58:06 DEBUG : dst/two: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece23dc_d20240418_m025603_c001_v0001157_t0038_u01713408963695") 2024/04/18 02:58:06 DEBUG : dst/two: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f410e34a255e2dedc_d20240418_m025601_c001_v7007000_t0000_u01713408961842") 2024/04/18 02:58:06 DEBUG : dst/two: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6952_d20240418_m025551_c001_v0001145_t0003_u01713408951575") 2024/04/18 02:58:06 DEBUG : dst/two: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd2ee_d20240418_m025549_c001_v7007000_t0000_u01713408949995") 2024/04/18 02:58:06 DEBUG : dst/two: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d4181a_d20240418_m025538_c001_v0001023_t0021_u01713408938255") 2024/04/18 02:58:06 DEBUG : dst/two: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd2d9_d20240418_m025536_c001_v7007000_t0000_u01713408936569") 2024/04/18 02:58:06 DEBUG : dst/two: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece22d8_d20240418_m025525_c001_v0001157_t0008_u01713408925454") 2024/04/18 02:58:07 DEBUG : dst/two: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd2ac_d20240418_m025523_c001_v7007000_t0000_u01713408923776") 2024/04/18 02:58:07 DEBUG : dst/two: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c68cc_d20240418_m025512_c001_v0001145_t0042_u01713408912946") 2024/04/18 02:58:07 DEBUG : dst/two: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a8737755cd26e_d20240418_m025511_c001_v7007000_t0000_u01713408911077") 2024/04/18 02:58:07 DEBUG : dst/two: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f10973eed492aa83b_d20240418_m025506_c001_v0001165_t0057_u01713408906573") 2024/04/18 02:58:07 DEBUG : dst/two: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4036c57b123971d6_d20240418_m025447_c001_v7007000_t0000_u01713408887866") 2024/04/18 02:58:07 DEBUG : dst/two: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1046d0b0c1eaf565_d20240418_m025446_c001_v0001179_t0056_u01713408886755") 2024/04/18 02:58:07 DEBUG : empty space: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f416683d780b4408a_d20240418_m025410_c001_v7007000_t0000_u01713408850389") 2024/04/18 02:58:07 DEBUG : empty space: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece20aa_d20240418_m025406_c001_v0001157_t0007_u01713408846497") 2024/04/18 02:58:07 DEBUG : empty space: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d62379_d20240418_m025404_c001_v7007000_t0000_u01713408844306") 2024/04/18 02:58:07 DEBUG : empty space: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece2062_d20240418_m025353_c001_v0001157_t0038_u01713408833795") 2024/04/18 02:58:07 DEBUG : empty space: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4052cb9125755ad5_d20240418_m025345_c001_v7007000_t0000_u01713408825914") 2024/04/18 02:58:07 DEBUG : empty space: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece2004_d20240418_m025341_c001_v0001157_t0051_u01713408821786") 2024/04/18 02:58:07 DEBUG : empty space: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d622e0_d20240418_m025313_c001_v7007000_t0000_u01713408793242") 2024/04/18 02:58:07 DEBUG : empty space: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1f20_d20240418_m025311_c001_v0001157_t0018_u01713408791037") 2024/04/18 02:58:07 DEBUG : empty space: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d622d9_d20240418_m025309_c001_v7007000_t0000_u01713408789345") 2024/04/18 02:58:07 DEBUG : empty space: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1f06_d20240418_m025308_c001_v0001157_t0005_u01713408788039") 2024/04/18 02:58:07 DEBUG : empty space: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d622d1_d20240418_m025303_c001_v7007000_t0000_u01713408783623") 2024/04/18 02:58:07 DEBUG : empty space: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1ecc_d20240418_m025301_c001_v0001157_t0007_u01713408781111") 2024/04/18 02:58:07 DEBUG : empty space: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f405c3359571bb864_d20240418_m025258_c001_v7007000_t0000_u01713408778963") 2024/04/18 02:58:08 DEBUG : empty space: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1eb2_d20240418_m025257_c001_v0001157_t0032_u01713408777075") 2024/04/18 02:58:08 DEBUG : empty space: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f405c3359571bb836_d20240418_m025248_c001_v7007000_t0000_u01713408768514") 2024/04/18 02:58:08 DEBUG : empty space: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1e56_d20240418_m025246_c001_v0001157_t0042_u01713408766671") 2024/04/18 02:58:08 DEBUG : empty space: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f405c3359571bb82c_d20240418_m025245_c001_v7007000_t0000_u01713408765350") 2024/04/18 02:58:08 DEBUG : empty space: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1e38_d20240418_m025244_c001_v0001157_t0047_u01713408764224") 2024/04/18 02:58:08 DEBUG : empty space: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f405c3359571bb822_d20240418_m025238_c001_v7007000_t0000_u01713408758348") 2024/04/18 02:58:08 DEBUG : empty space: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1dee_d20240418_m025236_c001_v0001157_t0053_u01713408756513") 2024/04/18 02:58:08 DEBUG : empty space: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f405c3359571bb81c_d20240418_m025233_c001_v7007000_t0000_u01713408753847") 2024/04/18 02:58:08 DEBUG : empty space: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1dc4_d20240418_m025232_c001_v0001157_t0003_u01713408752549") 2024/04/18 02:58:08 DEBUG : empty space: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f405c3359571bb81b_d20240418_m025231_c001_v7007000_t0000_u01713408751447") 2024/04/18 02:58:08 DEBUG : empty space: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f11478ba641fcca0c_d20240418_m025230_c001_v0001179_t0045_u01713408750883") 2024/04/18 02:58:08 DEBUG : empty space: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1dae_d20240418_m025229_c001_v0001157_t0025_u01713408749194") 2024/04/18 02:58:08 DEBUG : enormous: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d622dc_d20240418_m025312_c001_v7007000_t0000_u01713408792326") 2024/04/18 02:58:08 DEBUG : enormous: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1f24_d20240418_m025311_c001_v0001157_t0008_u01713408791474") 2024/04/18 02:58:08 DEBUG : existing: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f410e34a255e2df1c_d20240418_m025637_c001_v7007000_t0000_u01713408997369") 2024/04/18 02:58:08 DEBUG : existing: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d418d6_d20240418_m025635_c001_v0001023_t0005_u01713408995673") 2024/04/18 02:58:08 DEBUG : existing: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40065d337a78cc20_d20240418_m025339_c001_v7007000_t0000_u01713408819391") 2024/04/18 02:58:08 DEBUG : existing: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1fde_d20240418_m025337_c001_v0001157_t0045_u01713408817833") 2024/04/18 02:58:09 DEBUG : existing: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda766_d20240418_m025224_c001_v7007000_t0000_u01713408744526") 2024/04/18 02:58:09 DEBUG : existing: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1d7a_d20240418_m025223_c001_v0001157_t0031_u01713408743385") 2024/04/18 02:58:09 DEBUG : existing: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda765_d20240418_m025222_c001_v7007000_t0000_u01713408742079") 2024/04/18 02:58:09 DEBUG : existing: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1d6c_d20240418_m025221_c001_v0001157_t0027_u01713408741206") 2024/04/18 02:58:09 DEBUG : existing: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1d5a_d20240418_m025219_c001_v0001157_t0053_u01713408739448") 2024/04/18 02:58:09 DEBUG : existing-b: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40065d337a78cc21_d20240418_m025339_c001_v7007000_t0000_u01713408819576") 2024/04/18 02:58:09 DEBUG : existing-b: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d416f0_d20240418_m025337_c001_v0001023_t0028_u01713408817844") 2024/04/18 02:58:09 DEBUG : five: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d622ee_d20240418_m025318_c001_v7007000_t0000_u01713408798841") 2024/04/18 02:58:09 DEBUG : five: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f409be555bece1f42_d20240418_m025316_c001_v0001157_t0045_u01713408796523") 2024/04/18 02:58:09 DEBUG : foo: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f405c3359571bb820_d20240418_m025235_c001_v7007000_t0000_u01713408755790") 2024/04/18 02:58:09 DEBUG : foo: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f409be555bece1de6_d20240418_m025235_c001_v0001157_t0045_u01713408755212") 2024/04/18 02:58:09 DEBUG : foo: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f409be555bece1dde_d20240418_m025234_c001_v0001157_t0045_u01713408754639") 2024/04/18 02:58:09 DEBUG : four: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d622ef_d20240418_m025319_c001_v7007000_t0000_u01713408799021") 2024/04/18 02:58:09 DEBUG : four: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4197b1f683d416ac_d20240418_m025317_c001_v0001023_t0040_u01713408797080") 2024/04/18 02:58:09 DEBUG : four: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1f3e_d20240418_m025315_c001_v0001157_t0056_u01713408795152") 2024/04/18 02:58:09 DEBUG : hello world2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40770e92035577d0_d20240418_m025150_c001_v7007000_t0000_u01713408710759") 2024/04/18 02:58:09 DEBUG : hello world2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1c72_d20240418_m025149_c001_v0001157_t0047_u01713408709644") 2024/04/18 02:58:09 DEBUG : ignore-size: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda762_d20240418_m025218_c001_v7007000_t0000_u01713408738294") 2024/04/18 02:58:09 DEBUG : ignore-size: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1d44_d20240418_m025217_c001_v0001157_t0056_u01713408737146") 2024/04/18 02:58:09 DEBUG : nested/sub dir/file: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40065d337a78cc1d_d20240418_m025336_c001_v7007000_t0000_u01713408816718") 2024/04/18 02:58:10 DEBUG : nested/sub dir/file: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d416e2_d20240418_m025335_c001_v0001023_t0034_u01713408815306") 2024/04/18 02:58:10 DEBUG : nested/sub dir/file: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40065d337a78cc1a_d20240418_m025334_c001_v7007000_t0000_u01713408814177") 2024/04/18 02:58:10 DEBUG : nested/sub dir/file: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d416dc_d20240418_m025332_c001_v0001023_t0027_u01713408812991") 2024/04/18 02:58:10 DEBUG : one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d622f0_d20240418_m025319_c001_v7007000_t0000_u01713408799202") 2024/04/18 02:58:10 DEBUG : one: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f409be555bece1f30_d20240418_m025314_c001_v0001157_t0045_u01713408794354") 2024/04/18 02:58:10 DEBUG : only0: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9bf_d20240418_m025743_c001_v7007000_t0000_u01713409063705") 2024/04/18 02:58:10 DEBUG : only0: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f413d90a09e9c6ae9_d20240418_m025738_c001_v0001145_t0043_u01713409058107") 2024/04/18 02:58:10 DEBUG : only0: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6a99_d20240418_m025712_c001_v0001145_t0011_u01713409032899") 2024/04/18 02:58:10 DEBUG : only0: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d6249f_d20240418_m025706_c001_v7007000_t0000_u01713409026080") 2024/04/18 02:58:10 DEBUG : only0: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d418fe_d20240418_m025643_c001_v0001023_t0028_u01713409003538") 2024/04/18 02:58:10 DEBUG : only1: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9c0_d20240418_m025743_c001_v7007000_t0000_u01713409063891") 2024/04/18 02:58:10 DEBUG : only1: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f409be555bece2674_d20240418_m025738_c001_v0001157_t0045_u01713409058115") 2024/04/18 02:58:10 DEBUG : only1: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d41987_d20240418_m025714_c001_v0001023_t0003_u01713409034307") 2024/04/18 02:58:10 DEBUG : only1: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40065d337a78ce3c_d20240418_m025706_c001_v7007000_t0000_u01713409026673") 2024/04/18 02:58:10 DEBUG : only1: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece24ec_d20240418_m025644_c001_v0001157_t0042_u01713409004789") 2024/04/18 02:58:10 DEBUG : only10: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9c1_d20240418_m025744_c001_v7007000_t0000_u01713409064077") 2024/04/18 02:58:10 DEBUG : only10: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4197b1f683d419d9_d20240418_m025738_c001_v0001023_t0040_u01713409058126") 2024/04/18 02:58:10 DEBUG : only10: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d419a9_d20240418_m025727_c001_v0001023_t0031_u01713409047463") 2024/04/18 02:58:10 DEBUG : only10: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a710203d3b329_d20240418_m025706_c001_v7007000_t0000_u01713409026249") 2024/04/18 02:58:10 DEBUG : only10: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece2546_d20240418_m025654_c001_v0001157_t0013_u01713409014286") 2024/04/18 02:58:11 DEBUG : only11: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9c2_d20240418_m025744_c001_v7007000_t0000_u01713409064261") 2024/04/18 02:58:11 DEBUG : only11: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4010c852dd36b3f7_d20240418_m025738_c001_v0001181_t0008_u01713409058687") 2024/04/18 02:58:11 DEBUG : only11: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece2622_d20240418_m025728_c001_v0001157_t0040_u01713409048565") 2024/04/18 02:58:11 DEBUG : only11: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f401fc33db36f44bc_d20240418_m025706_c001_v7007000_t0000_u01713409026258") 2024/04/18 02:58:11 DEBUG : only11: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6a57_d20240418_m025655_c001_v0001145_t0014_u01713409015196") 2024/04/18 02:58:11 DEBUG : only12: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9c3_d20240418_m025744_c001_v7007000_t0000_u01713409064445") 2024/04/18 02:58:11 DEBUG : only12: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f413d90a09e9c6aeb_d20240418_m025738_c001_v0001145_t0043_u01713409058328") 2024/04/18 02:58:11 DEBUG : only12: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6acb_d20240418_m025729_c001_v0001145_t0007_u01713409049558") 2024/04/18 02:58:11 DEBUG : only12: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a710203d3b32b_d20240418_m025706_c001_v7007000_t0000_u01713409026613") 2024/04/18 02:58:11 DEBUG : only12: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d4193a_d20240418_m025656_c001_v0001023_t0002_u01713409016406") 2024/04/18 02:58:11 DEBUG : only13: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9c5_d20240418_m025744_c001_v7007000_t0000_u01713409064626") 2024/04/18 02:58:11 DEBUG : only13: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f409be555bece267a_d20240418_m025738_c001_v0001157_t0045_u01713409058336") 2024/04/18 02:58:11 DEBUG : only13: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d419b9_d20240418_m025730_c001_v0001023_t0011_u01713409050323") 2024/04/18 02:58:11 DEBUG : only13: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a710203d3b32a_d20240418_m025706_c001_v7007000_t0000_u01713409026431") 2024/04/18 02:58:11 DEBUG : only13: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece2560_d20240418_m025657_c001_v0001157_t0041_u01713409017679") 2024/04/18 02:58:11 DEBUG : only14: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9c6_d20240418_m025744_c001_v7007000_t0000_u01713409064808") 2024/04/18 02:58:11 DEBUG : only14: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4197b1f683d419db_d20240418_m025738_c001_v0001023_t0040_u01713409058346") 2024/04/18 02:58:11 DEBUG : only14: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece2640_d20240418_m025731_c001_v0001157_t0055_u01713409051348") 2024/04/18 02:58:11 DEBUG : only14: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d624a2_d20240418_m025706_c001_v7007000_t0000_u01713409026448") 2024/04/18 02:58:12 DEBUG : only14: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6a65_d20240418_m025658_c001_v0001145_t0024_u01713409018778") 2024/04/18 02:58:12 DEBUG : only15: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9c7_d20240418_m025745_c001_v7007000_t0000_u01713409065003") 2024/04/18 02:58:12 DEBUG : only15: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f413d90a09e9c6aed_d20240418_m025738_c001_v0001145_t0043_u01713409058512") 2024/04/18 02:58:12 DEBUG : only15: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6ad1_d20240418_m025732_c001_v0001145_t0010_u01713409052352") 2024/04/18 02:58:12 DEBUG : only15: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a710203d3b326_d20240418_m025705_c001_v7007000_t0000_u01713409025688") 2024/04/18 02:58:12 DEBUG : only15: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d4194a_d20240418_m025659_c001_v0001023_t0012_u01713409019654") 2024/04/18 02:58:12 DEBUG : only16: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9c8_d20240418_m025745_c001_v7007000_t0000_u01713409065191") 2024/04/18 02:58:12 DEBUG : only16: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4197b1f683d419df_d20240418_m025738_c001_v0001023_t0040_u01713409058528") 2024/04/18 02:58:12 DEBUG : only16: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d419c7_d20240418_m025733_c001_v0001023_t0016_u01713409053421") 2024/04/18 02:58:12 DEBUG : only16: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f401fc33db36f44bd_d20240418_m025706_c001_v7007000_t0000_u01713409026459") 2024/04/18 02:58:12 DEBUG : only16: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece2574_d20240418_m025700_c001_v0001157_t0045_u01713409020757") 2024/04/18 02:58:12 DEBUG : only17: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9c9_d20240418_m025745_c001_v7007000_t0000_u01713409065373") 2024/04/18 02:58:12 DEBUG : only17: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f409be555bece267e_d20240418_m025738_c001_v0001157_t0045_u01713409058538") 2024/04/18 02:58:12 DEBUG : only17: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece265a_d20240418_m025734_c001_v0001157_t0006_u01713409054610") 2024/04/18 02:58:12 DEBUG : only17: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a710203d3b327_d20240418_m025705_c001_v7007000_t0000_u01713409025872") 2024/04/18 02:58:12 DEBUG : only17: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6a73_d20240418_m025701_c001_v0001145_t0058_u01713409021848") 2024/04/18 02:58:12 DEBUG : only18: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9ca_d20240418_m025745_c001_v7007000_t0000_u01713409065567") 2024/04/18 02:58:12 DEBUG : only18: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f413d90a09e9c6aef_d20240418_m025738_c001_v0001145_t0043_u01713409058698") 2024/04/18 02:58:12 DEBUG : only18: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6ae1_d20240418_m025735_c001_v0001145_t0027_u01713409055664") 2024/04/18 02:58:12 DEBUG : only18: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a710203d3b328_d20240418_m025706_c001_v7007000_t0000_u01713409026068") 2024/04/18 02:58:13 DEBUG : only18: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d4195a_d20240418_m025703_c001_v0001023_t0040_u01713409023041") 2024/04/18 02:58:13 DEBUG : only19: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9cb_d20240418_m025745_c001_v7007000_t0000_u01713409065760") 2024/04/18 02:58:13 DEBUG : only19: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4197b1f683d419e1_d20240418_m025738_c001_v0001023_t0040_u01713409058715") 2024/04/18 02:58:13 DEBUG : only19: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d419d1_d20240418_m025736_c001_v0001023_t0027_u01713409056850") 2024/04/18 02:58:13 DEBUG : only19: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d624a3_d20240418_m025706_c001_v7007000_t0000_u01713409026630") 2024/04/18 02:58:13 DEBUG : only19: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece258c_d20240418_m025704_c001_v0001157_t0034_u01713409024283") 2024/04/18 02:58:13 DEBUG : only2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9cd_d20240418_m025745_c001_v7007000_t0000_u01713409065941") 2024/04/18 02:58:13 DEBUG : only2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f409be555bece2680_d20240418_m025738_c001_v0001157_t0045_u01713409058731") 2024/04/18 02:58:13 DEBUG : only2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece25c8_d20240418_m025715_c001_v0001157_t0042_u01713409035431") 2024/04/18 02:58:13 DEBUG : only2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d624a1_d20240418_m025706_c001_v7007000_t0000_u01713409026268") 2024/04/18 02:58:13 DEBUG : only2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6a31_d20240418_m025645_c001_v0001145_t0037_u01713409005939") 2024/04/18 02:58:13 DEBUG : only3: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9ce_d20240418_m025746_c001_v7007000_t0000_u01713409066135") 2024/04/18 02:58:13 DEBUG : only3: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f413d90a09e9c6af1_d20240418_m025738_c001_v0001145_t0043_u01713409058892") 2024/04/18 02:58:13 DEBUG : only3: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6aa9_d20240418_m025716_c001_v0001145_t0056_u01713409036380") 2024/04/18 02:58:13 DEBUG : only3: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f402a710203d3b32c_d20240418_m025706_c001_v7007000_t0000_u01713409026795") 2024/04/18 02:58:13 DEBUG : only3: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d4190c_d20240418_m025646_c001_v0001023_t0026_u01713409006678") 2024/04/18 02:58:13 DEBUG : only4: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9cf_d20240418_m025746_c001_v7007000_t0000_u01713409066316") 2024/04/18 02:58:13 DEBUG : only4: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4197b1f683d419e3_d20240418_m025738_c001_v0001023_t0040_u01713409058900") 2024/04/18 02:58:14 DEBUG : only4: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d4198f_d20240418_m025717_c001_v0001023_t0010_u01713409037657") 2024/04/18 02:58:14 DEBUG : only4: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40065d337a78ce39_d20240418_m025706_c001_v7007000_t0000_u01713409026280") 2024/04/18 02:58:14 DEBUG : only4: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece2500_d20240418_m025647_c001_v0001157_t0000_u01713409007606") 2024/04/18 02:58:14 DEBUG : only5: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9d1_d20240418_m025746_c001_v7007000_t0000_u01713409066497") 2024/04/18 02:58:14 DEBUG : only5: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f409be555bece2684_d20240418_m025738_c001_v0001157_t0045_u01713409058912") 2024/04/18 02:58:14 DEBUG : only5: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece25e4_d20240418_m025720_c001_v0001157_t0005_u01713409040213") 2024/04/18 02:58:14 DEBUG : only5: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d624a4_d20240418_m025706_c001_v7007000_t0000_u01713409026812") 2024/04/18 02:58:14 DEBUG : only5: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6a37_d20240418_m025648_c001_v0001145_t0048_u01713409008459") 2024/04/18 02:58:14 DEBUG : only6: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9d2_d20240418_m025746_c001_v7007000_t0000_u01713409066713") 2024/04/18 02:58:14 DEBUG : only6: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4010c852dd36b403_d20240418_m025738_c001_v0001181_t0008_u01713409058995") 2024/04/18 02:58:14 DEBUG : only6: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6ab5_d20240418_m025721_c001_v0001145_t0019_u01713409041312") 2024/04/18 02:58:14 DEBUG : only6: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f401fc33db36f44ba_d20240418_m025706_c001_v7007000_t0000_u01713409026073") 2024/04/18 02:58:14 DEBUG : only6: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d4191a_d20240418_m025649_c001_v0001023_t0004_u01713409009549") 2024/04/18 02:58:14 DEBUG : only7: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9d3_d20240418_m025746_c001_v7007000_t0000_u01713409066897") 2024/04/18 02:58:14 DEBUG : only7: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f413d90a09e9c6af3_d20240418_m025739_c001_v0001145_t0043_u01713409059075") 2024/04/18 02:58:14 DEBUG : only7: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d419a3_d20240418_m025723_c001_v0001023_t0031_u01713409043516") 2024/04/18 02:58:14 DEBUG : only7: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40065d337a78ce38_d20240418_m025706_c001_v7007000_t0000_u01713409026073") 2024/04/18 02:58:14 DEBUG : only7: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece2524_d20240418_m025650_c001_v0001157_t0018_u01713409010796") 2024/04/18 02:58:14 DEBUG : only8: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9d4_d20240418_m025747_c001_v7007000_t0000_u01713409067080") 2024/04/18 02:58:14 DEBUG : only8: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4197b1f683d419e7_d20240418_m025739_c001_v0001023_t0040_u01713409059083") 2024/04/18 02:58:15 DEBUG : only8: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece260a_d20240418_m025724_c001_v0001157_t0042_u01713409044804") 2024/04/18 02:58:15 DEBUG : only8: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f401fc33db36f44be_d20240418_m025706_c001_v7007000_t0000_u01713409026641") 2024/04/18 02:58:15 DEBUG : only8: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6a45_d20240418_m025651_c001_v0001145_t0057_u01713409011605") 2024/04/18 02:58:15 DEBUG : only9: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9d5_d20240418_m025747_c001_v7007000_t0000_u01713409067262") 2024/04/18 02:58:15 DEBUG : only9: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f409be555bece2686_d20240418_m025739_c001_v0001157_t0045_u01713409059093") 2024/04/18 02:58:15 DEBUG : only9: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6ac5_d20240418_m025726_c001_v0001145_t0028_u01713409046174") 2024/04/18 02:58:15 DEBUG : only9: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40065d337a78ce3a_d20240418_m025706_c001_v7007000_t0000_u01713409026472") 2024/04/18 02:58:15 DEBUG : only9: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d4192a_d20240418_m025653_c001_v0001023_t0016_u01713409013087") 2024/04/18 02:58:15 DEBUG : potato: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d62312_d20240418_m025330_c001_v7007000_t0000_u01713408810727") 2024/04/18 02:58:15 DEBUG : potato: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6754_d20240418_m025328_c001_v0001145_t0013_u01713408808574") 2024/04/18 02:58:15 DEBUG : potato: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d62303_d20240418_m025326_c001_v7007000_t0000_u01713408806728") 2024/04/18 02:58:15 DEBUG : potato: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1f76_d20240418_m025324_c001_v0001157_t0038_u01713408804851") 2024/04/18 02:58:15 DEBUG : potato: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d622fc_d20240418_m025323_c001_v7007000_t0000_u01713408803001") 2024/04/18 02:58:15 DEBUG : potato: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d416b8_d20240418_m025320_c001_v0001023_t0022_u01713408800149") 2024/04/18 02:58:15 DEBUG : potato: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d622d5_d20240418_m025306_c001_v7007000_t0000_u01713408786634") 2024/04/18 02:58:15 DEBUG : potato: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1ee4_d20240418_m025304_c001_v0001157_t0012_u01713408784533") 2024/04/18 02:58:15 DEBUG : potato: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d622ce_d20240418_m025302_c001_v7007000_t0000_u01713408782345") 2024/04/18 02:58:15 DEBUG : potato: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1ec6_d20240418_m025300_c001_v0001157_t0056_u01713408780354") 2024/04/18 02:58:16 DEBUG : potato: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f405c3359571bb863_d20240418_m025258_c001_v7007000_t0000_u01713408778212") 2024/04/18 02:58:16 DEBUG : potato: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1eac_d20240418_m025256_c001_v0001157_t0011_u01713408776326") 2024/04/18 02:58:16 DEBUG : potato: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f405c3359571bb835_d20240418_m025247_c001_v7007000_t0000_u01713408767929") 2024/04/18 02:58:16 DEBUG : potato: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1e52_d20240418_m025246_c001_v0001157_t0034_u01713408766253") 2024/04/18 02:58:16 DEBUG : potato: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f405c3359571bb82e_d20240418_m025245_c001_v7007000_t0000_u01713408765530") 2024/04/18 02:58:16 DEBUG : potato: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1e32_d20240418_m025243_c001_v0001157_t0036_u01713408763768") 2024/04/18 02:58:16 DEBUG : potato: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f405c3359571bb829_d20240418_m025243_c001_v7007000_t0000_u01713408763044") 2024/04/18 02:58:16 DEBUG : potato: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1e20_d20240418_m025242_c001_v0001157_t0038_u01713408762290") 2024/04/18 02:58:16 DEBUG : potato: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1e1e_d20240418_m025241_c001_v0001157_t0055_u01713408761493") 2024/04/18 02:58:16 DEBUG : potato: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f405c3359571bb828_d20240418_m025240_c001_v7007000_t0000_u01713408760768") 2024/04/18 02:58:16 DEBUG : potato: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1e10_d20240418_m025239_c001_v0001157_t0032_u01713408759995") 2024/04/18 02:58:16 DEBUG : potato: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1e0a_d20240418_m025239_c001_v0001157_t0014_u01713408759263") 2024/04/18 02:58:16 DEBUG : potato: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f405c3359571bb823_d20240418_m025238_c001_v7007000_t0000_u01713408758538") 2024/04/18 02:58:16 DEBUG : potato: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1df8_d20240418_m025237_c001_v0001157_t0046_u01713408757319") 2024/04/18 02:58:16 DEBUG : potato2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4036c57b123970c4_d20240418_m025419_c001_v7007000_t0000_u01713408859294") 2024/04/18 02:58:16 DEBUG : potato2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6804_d20240418_m025418_c001_v0001145_t0002_u01713408858239") 2024/04/18 02:58:16 DEBUG : potato2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d62392_d20240418_m025410_c001_v7007000_t0000_u01713408850945") 2024/04/18 02:58:17 DEBUG : potato2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c67d2_d20240418_m025405_c001_v0001145_t0050_u01713408845662") 2024/04/18 02:58:17 DEBUG : potato2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d6236f_d20240418_m025358_c001_v7007000_t0000_u01713408838028") 2024/04/18 02:58:17 DEBUG : potato2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c67b0_d20240418_m025353_c001_v0001145_t0049_u01713408833033") 2024/04/18 02:58:17 DEBUG : potato2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40065d337a78cc30_d20240418_m025346_c001_v7007000_t0000_u01713408826467") 2024/04/18 02:58:17 DEBUG : potato2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6784_d20240418_m025340_c001_v0001145_t0048_u01713408820898") 2024/04/18 02:58:17 DEBUG : potato2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d622dd_d20240418_m025312_c001_v7007000_t0000_u01713408792507") 2024/04/18 02:58:17 DEBUG : potato2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1f1c_d20240418_m025310_c001_v0001157_t0044_u01713408790658") 2024/04/18 02:58:17 DEBUG : potato2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d622da_d20240418_m025309_c001_v7007000_t0000_u01713408789527") 2024/04/18 02:58:17 DEBUG : potato2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1efe_d20240418_m025307_c001_v0001157_t0055_u01713408787588") 2024/04/18 02:58:17 DEBUG : potato2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d622d6_d20240418_m025306_c001_v7007000_t0000_u01713408786826") 2024/04/18 02:58:17 DEBUG : potato2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1ef2_d20240418_m025305_c001_v0001157_t0059_u01713408785679") 2024/04/18 02:58:17 DEBUG : potato2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d622d2_d20240418_m025303_c001_v7007000_t0000_u01713408783806") 2024/04/18 02:58:17 DEBUG : potato2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1ed4_d20240418_m025302_c001_v0001157_t0010_u01713408782716") 2024/04/18 02:58:17 DEBUG : potato2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f405c3359571bb865_d20240418_m025259_c001_v7007000_t0000_u01713408779145") 2024/04/18 02:58:17 DEBUG : potato2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1eba_d20240418_m025258_c001_v0001157_t0009_u01713408778225") 2024/04/18 02:58:17 DEBUG : potato2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f405c3359571bb837_d20240418_m025248_c001_v7007000_t0000_u01713408768695") 2024/04/18 02:58:17 DEBUG : potato2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1e5a_d20240418_m025247_c001_v0001157_t0053_u01713408767502") 2024/04/18 02:58:17 DEBUG : potato2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40770e92035577ef_d20240418_m025154_c001_v7007000_t0000_u01713408714740") 2024/04/18 02:58:17 DEBUG : potato2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1c96_d20240418_m025153_c001_v0001157_t0053_u01713408713790") 2024/04/18 02:58:18 DEBUG : potato2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40770e92035577e1_d20240418_m025152_c001_v7007000_t0000_u01713408712443") 2024/04/18 02:58:18 DEBUG : potato2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1c80_d20240418_m025151_c001_v0001157_t0055_u01713408711703") 2024/04/18 02:58:18 DEBUG : potato3: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f416683d780b4408b_d20240418_m025411_c001_v7007000_t0000_u01713408851082") 2024/04/18 02:58:18 DEBUG : potato3: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d4173a_d20240418_m025407_c001_v0001023_t0010_u01713408847240") 2024/04/18 02:58:18 DEBUG : potato3: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f406123ddb02b3754_d20240418_m025358_c001_v7007000_t0000_u01713408838324") 2024/04/18 02:58:18 DEBUG : potato3: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d4171a_d20240418_m025354_c001_v0001023_t0020_u01713408834871") 2024/04/18 02:58:18 DEBUG : potato3: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4052cb9125755ad6_d20240418_m025346_c001_v7007000_t0000_u01713408826557") 2024/04/18 02:58:18 DEBUG : potato3: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d41700_d20240418_m025342_c001_v0001023_t0013_u01713408822312") 2024/04/18 02:58:18 DEBUG : pre-dest1/1: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4036c57b123971e5_d20240418_m025455_c001_v7007000_t0000_u01713408895000") 2024/04/18 02:58:18 DEBUG : pre-dest1/1: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d417ac_d20240418_m025448_c001_v0001023_t0006_u01713408888601") 2024/04/18 02:58:18 DEBUG : pre-dest2/2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4036c57b123971e6_d20240418_m025455_c001_v7007000_t0000_u01713408895181") 2024/04/18 02:58:18 DEBUG : pre-dest2/2: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6874_d20240418_m025449_c001_v0001145_t0001_u01713408889862") 2024/04/18 02:58:18 DEBUG : rclone-sync-test-ignore-file/.ignore: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4036c57b123970cf_d20240418_m025428_c001_v7007000_t0000_u01713408868383") 2024/04/18 02:58:18 DEBUG : rclone-sync-test-ignore-file/.ignore: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece2118_d20240418_m025424_c001_v0001157_t0040_u01713408864717") 2024/04/18 02:58:18 DEBUG : sizeonly: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda761_d20240418_m025215_c001_v7007000_t0000_u01713408735869") 2024/04/18 02:58:18 DEBUG : sizeonly: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1d30_d20240418_m025214_c001_v0001157_t0016_u01713408734719") 2024/04/18 02:58:18 DEBUG : sub dir/hello world: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9d8_d20240418_m025751_c001_v7007000_t0000_u01713409071915") 2024/04/18 02:58:18 DEBUG : sub dir/hello world: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece26c4_d20240418_m025748_c001_v0001157_t0021_u01713409068612") 2024/04/18 02:58:18 DEBUG : sub dir/hello world: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40065d337a78cc1e_d20240418_m025336_c001_v7007000_t0000_u01713408816908") 2024/04/18 02:58:18 DEBUG : sub dir/hello world: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6778_d20240418_m025335_c001_v0001145_t0034_u01713408815710") 2024/04/18 02:58:19 DEBUG : sub dir/hello world: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40065d337a78cc1b_d20240418_m025334_c001_v7007000_t0000_u01713408814360") 2024/04/18 02:58:19 DEBUG : sub dir/hello world: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1faa_d20240418_m025333_c001_v0001157_t0025_u01713408813355") 2024/04/18 02:58:19 DEBUG : sub dir/hello world: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda75d_d20240418_m025211_c001_v7007000_t0000_u01713408731304") 2024/04/18 02:58:19 DEBUG : sub dir/hello world: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1d04_d20240418_m025209_c001_v0001157_t0010_u01713408729564") 2024/04/18 02:58:19 DEBUG : sub dir/hello world: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda757_d20240418_m025208_c001_v7007000_t0000_u01713408728836") 2024/04/18 02:58:19 DEBUG : sub dir/hello world: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1cfc_d20240418_m025207_c001_v0001157_t0025_u01713408727140") 2024/04/18 02:58:19 DEBUG : sub dir/hello world: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40770e920355780b_d20240418_m025206_c001_v7007000_t0000_u01713408726302") 2024/04/18 02:58:19 DEBUG : sub dir/hello world: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1cd2_d20240418_m025202_c001_v0001157_t0011_u01713408722261") 2024/04/18 02:58:19 DEBUG : sub dir/hello world: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40770e9203557803_d20240418_m025201_c001_v7007000_t0000_u01713408721171") 2024/04/18 02:58:19 DEBUG : sub dir/hello world: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1cca_d20240418_m025200_c001_v0001157_t0024_u01713408720058") 2024/04/18 02:58:19 DEBUG : sub dir/hello world: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40770e9203557800_d20240418_m025158_c001_v7007000_t0000_u01713408718771") 2024/04/18 02:58:19 DEBUG : sub dir/hello world: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1cae_d20240418_m025157_c001_v0001157_t0007_u01713408717822") 2024/04/18 02:58:19 DEBUG : sub dir/hello world: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40770e92035577f3_d20240418_m025156_c001_v7007000_t0000_u01713408716913") 2024/04/18 02:58:19 DEBUG : sub dir/hello world: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1ca0_d20240418_m025155_c001_v0001157_t0008_u01713408715669") 2024/04/18 02:58:19 DEBUG : sub dir/hello world: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40770e92035577cc_d20240418_m025148_c001_v7007000_t0000_u01713408708733") 2024/04/18 02:58:19 DEBUG : sub dir/hello world: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1c60_d20240418_m025148_c001_v0001157_t0010_u01713408708022") 2024/04/18 02:58:19 DEBUG : sub dir/hello world: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40770e92035577c7_d20240418_m025147_c001_v7007000_t0000_u01713408707085") 2024/04/18 02:58:19 DEBUG : sub dir/hello world: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1c4c_d20240418_m025146_c001_v0001157_t0004_u01713408706268") 2024/04/18 02:58:20 DEBUG : sub dir/hello world: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40770e92035577c5_d20240418_m025145_c001_v7007000_t0000_u01713408705351") 2024/04/18 02:58:20 DEBUG : sub dir/hello world: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1c36_d20240418_m025144_c001_v0001157_t0019_u01713408704217") 2024/04/18 02:58:20 DEBUG : sub dir/hello world: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40770e92035577c1_d20240418_m025141_c001_v7007000_t0000_u01713408701665") 2024/04/18 02:58:20 DEBUG : sub dir/hello world: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1c22_d20240418_m025140_c001_v0001157_t0041_u01713408700905") 2024/04/18 02:58:20 DEBUG : sub dir2/very/very/very/very/very/nested/subdir/hello world: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f4173751f94eda9da_d20240418_m025752_c001_v7007000_t0000_u01713409072112") 2024/04/18 02:58:20 DEBUG : sub dir2/very/very/very/very/very/nested/subdir/hello world: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1010c852dd36b562_d20240418_m025748_c001_v0001181_t0056_u01713409068594") 2024/04/18 02:58:20 DEBUG : sub/yam: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d6230e_d20240418_m025330_c001_v7007000_t0000_u01713408810181") 2024/04/18 02:58:20 DEBUG : sub/yam: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d416ce_d20240418_m025328_c001_v0001023_t0003_u01713408808209") 2024/04/18 02:58:20 DEBUG : three: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d622f2_d20240418_m025319_c001_v7007000_t0000_u01713408799400") 2024/04/18 02:58:20 DEBUG : three: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1f4a_d20240418_m025317_c001_v0001157_t0044_u01713408797875") 2024/04/18 02:58:20 DEBUG : three: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109be555bece1f38_d20240418_m025314_c001_v0001157_t0034_u01713408794729") 2024/04/18 02:58:20 DEBUG : two: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d622f3_d20240418_m025319_c001_v7007000_t0000_u01713408799585") 2024/04/18 02:58:20 DEBUG : two: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f413d90a09e9c673c_d20240418_m025317_c001_v0001145_t0043_u01713408797283") 2024/04/18 02:58:20 DEBUG : two: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f409be555bece1f32_d20240418_m025314_c001_v0001157_t0045_u01713408794535") 2024/04/18 02:58:20 DEBUG : yam: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d62316_d20240418_m025330_c001_v7007000_t0000_u01713408810908") 2024/04/18 02:58:20 DEBUG : yam: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f104bb9e9585fba32_d20240418_m025329_c001_v0001165_t0059_u01713408809872") 2024/04/18 02:58:20 DEBUG : yam: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d62302_d20240418_m025326_c001_v7007000_t0000_u01713408806176") 2024/04/18 02:58:20 DEBUG : yam: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f1197b1f683d416c8_d20240418_m025324_c001_v0001023_t0027_u01713408804508") 2024/04/18 02:58:20 DEBUG : yam: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d622f9_d20240418_m025322_c001_v7007000_t0000_u01713408802455") 2024/04/18 02:58:20 DEBUG : yam: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113d90a09e9c6744_d20240418_m025320_c001_v0001145_t0032_u01713408800151") 2024/04/18 02:58:21 DEBUG : yaml: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d62304_d20240418_m025326_c001_v7007000_t0000_u01713408806920") 2024/04/18 02:58:21 DEBUG : yaml: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f113ef6357289a36a_d20240418_m025325_c001_v0001091_t0032_u01713408805800") 2024/04/18 02:58:21 DEBUG : yaml: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f40404c0475d622fe_d20240418_m025323_c001_v7007000_t0000_u01713408803183") 2024/04/18 02:58:21 DEBUG : yaml: Deleting (id "4_zcfd2ed8310ddebfb8fe80e1b_f109a8eaa1e05fb0f_d20240418_m025322_c001_v0001099_t0055_u01713408802134") "./sync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Finished OK in 6m46.356307147s (try 1/5)