"./sync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -fast-list" - Starting (try 1/5) 2024/11/14 18:41:20 DEBUG : Creating backend with remote "TestB2:rclone-test-jaderac3cuvu" 2024/11/14 18:41:20 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/11/14 18:41:20 DEBUG : Creating backend with remote "/tmp/rclone1983136226" === RUN TestPipe --- PASS: TestPipe (0.00s) === RUN TestPipeConcurrent --- PASS: TestPipeConcurrent (0.03s) === 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-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:41:22 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/14 18:41:22 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) 2024/11/14 18:41:22 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:41:22 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestCopyWithDryRun (2.14s) === RUN TestCopy run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:41:23 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/11/14 18:41:23 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/14 18:41:23 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:41:23 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:41:24 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/11/14 18:41:24 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:41:24 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopy (2.15s) === RUN TestCopyMetadata run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" sync_test.go:97: Skipping as metadata not supported --- SKIP: TestCopyMetadata (0.36s) === RUN TestCopyMetadataNoEmptyDirs run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" sync_test.go:97: Skipping as metadata not supported --- SKIP: TestCopyMetadataNoEmptyDirs (0.36s) === RUN TestCopyMissingDirectory run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:41:25 DEBUG : Creating backend with remote "/non-existing" 2024/11/14 18:41:26 ERROR : Local file system at /non-existing: error reading source root directory: directory not found 2024/11/14 18:41:26 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:41:26 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestCopyMissingDirectory (0.90s) === RUN TestCopyNoTraverse run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:41:27 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/14 18:41:27 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:41:27 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:41:27 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/11/14 18:41:27 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestCopyNoTraverse (1.92s) === RUN TestCopyCheckFirst run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:41:28 INFO : B2 bucket rclone-test-jaderac3cuvu: Running all checks before starting transfers 2024/11/14 18:41:28 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/14 18:41:28 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:41:28 INFO : B2 bucket rclone-test-jaderac3cuvu: Checks finished, now starting transfers 2024/11/14 18:41:28 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:41:29 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/11/14 18:41:29 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestCopyCheckFirst (1.71s) === RUN TestSyncNoTraverse run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:41:30 ERROR : Ignoring --no-traverse with sync 2024/11/14 18:41:30 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/14 18:41:30 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:41:30 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:41:31 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/11/14 18:41:31 INFO : sub dir/hello world: Copied (new) 2024/11/14 18:41:31 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestSyncNoTraverse (1.72s) === RUN TestCopyWithDepth run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:41:32 DEBUG : hello world2: Need to transfer - File not found at Destination 2024/11/14 18:41:32 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:41:32 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:41:32 DEBUG : hello world2: sha1 = c0bf117f9c93d02c894fe8ffd6e5cecf3545c209 OK 2024/11/14 18:41:32 INFO : hello world2: Copied (new) run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestCopyWithDepth (1.63s) === RUN TestCopyWithFilesFrom run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:41:33 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/14 18:41:33 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:41:33 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:41:34 DEBUG : potato2: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/11/14 18:41:34 INFO : potato2: Copied (new) run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestCopyWithFilesFrom (1.68s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:41:36 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/14 18:41:36 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:41:36 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:41:36 DEBUG : potato2: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/11/14 18:41:36 INFO : potato2: Copied (new) run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestCopyWithFilesFromAndNoTraverse (1.91s) === RUN TestCopyEmptyDirectories run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:41:37 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2024/11/14 18:41:37 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2024/11/14 18:41:37 INFO : sub dir2: Set directory modification time (using DirSetModTime) 2024/11/14 18:41:37 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/11/14 18:41:37 DEBUG : sub dir: Making directory 2024/11/14 18:41:37 DEBUG : sub dir2: Making directory 2024/11/14 18:41:37 DEBUG : sub dir2/sub sub dir2: Making directory 2024/11/14 18:41:37 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/14 18:41:37 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:41:37 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:41:37 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/11/14 18:41:37 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" fstest.go:244: Filtering empty directory "sub dir2" fstest.go:244: Filtering empty directory "sub dir2/sub sub dir2" 2024/11/14 18:41:38 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopyEmptyDirectories (1.61s) === RUN TestCopyNoEmptyDirectories run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:41:39 DEBUG : sub dir2: Making directory 2024/11/14 18:41:39 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2024/11/14 18:41:39 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2024/11/14 18:41:39 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/14 18:41:39 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:41:39 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:41:39 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/11/14 18:41:39 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoEmptyDirectories (1.27s) === RUN TestMoveEmptyDirectories run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:41:40 DEBUG : sub dir2: Making directory with metadata 2024/11/14 18:41:40 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2024/11/14 18:41:40 DEBUG : sub dir: Making directory 2024/11/14 18:41:40 DEBUG : sub dir2: Making directory 2024/11/14 18:41:40 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/14 18:41:40 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:41:40 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:41:40 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/11/14 18:41:40 INFO : sub dir/hello world: Copied (new) 2024/11/14 18:41:40 INFO : sub dir/hello world: Deleted run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" fstest.go:244: Filtering empty directory "sub dir2" 2024/11/14 18:41:40 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata 2024/11/14 18:41:41 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestMoveEmptyDirectories (1.75s) === RUN TestSyncNoUpdateDirModtime run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" sync_test.go:408: Skipping test as backend does not support DirSetModTime --- SKIP: TestSyncNoUpdateDirModtime (0.36s) === RUN TestMoveNoEmptyDirectories run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:41:42 DEBUG : sub dir2: Making directory 2024/11/14 18:41:42 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/14 18:41:42 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:41:42 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:41:42 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/11/14 18:41:42 INFO : sub dir/hello world: Copied (new) 2024/11/14 18:41:42 INFO : sub dir/hello world: Deleted --- PASS: TestMoveNoEmptyDirectories (1.24s) === RUN TestSyncEmptyDirectories run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:41:43 DEBUG : sub dir2: Making directory with metadata 2024/11/14 18:41:43 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2024/11/14 18:41:43 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/11/14 18:41:43 DEBUG : sub dir: Making directory 2024/11/14 18:41:43 DEBUG : sub dir2: Making directory 2024/11/14 18:41:43 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/14 18:41:43 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:41:43 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:41:44 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/11/14 18:41:44 INFO : sub dir/hello world: Copied (new) 2024/11/14 18:41:44 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" fstest.go:244: Filtering empty directory "sub dir2" 2024/11/14 18:41:44 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestSyncEmptyDirectories (1.75s) === RUN TestSyncSetDelayedModTimes run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" sync_test.go:507: Backend doesn't have DirModTimeUpdatesOnWrite set --- SKIP: TestSyncSetDelayedModTimes (0.36s) === RUN TestSyncNoEmptyDirectories run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:41:45 DEBUG : sub dir2: Making directory 2024/11/14 18:41:46 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/14 18:41:46 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:41:46 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:41:46 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/11/14 18:41:46 INFO : sub dir/hello world: Copied (new) 2024/11/14 18:41:46 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoEmptyDirectories (1.73s) === RUN TestServerSideCopy run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:41:48 DEBUG : Creating backend with remote "TestB2:rclone-test-xobepiz8vewe" sync_test.go:590: Server side copy (if possible) B2 bucket rclone-test-jaderac3cuvu -> B2 bucket rclone-test-xobepiz8vewe 2024/11/14 18:41:49 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/14 18:41:49 DEBUG : B2 bucket rclone-test-xobepiz8vewe: Waiting for checks to finish 2024/11/14 18:41:49 DEBUG : B2 bucket rclone-test-xobepiz8vewe: Waiting for transfers to finish 2024/11/14 18:41:51 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/11/14 18:41:51 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:41:51 DEBUG : B2 bucket rclone-test-xobepiz8vewe: Purge remote 2024/11/14 18:41:51 INFO : B2 bucket rclone-test-xobepiz8vewe: cleaning bucket "rclone-test-xobepiz8vewe" of all files 2024/11/14 18:41:52 DEBUG : sub dir/hello world: Deleting (id "4_z0f925d03f0bd2bbb9f380e1b_f101e8f36ec59795f_d20241114_m184151_c001_v0001161_t0044_u01731609711508") --- PASS: TestServerSideCopy (6.44s) === RUN TestCopyAfterDelete run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:41:54 ERROR : : error listing: directory not found 2024/11/14 18:41:54 DEBUG : Local file system at /tmp/rclone1983136226: Making directory 2024/11/14 18:41:54 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:41:54 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestCopyAfterDelete (2.15s) === RUN TestCopyRedownload run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:41:56 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/14 18:41:56 DEBUG : Local file system at /tmp/rclone1983136226: Waiting for checks to finish 2024/11/14 18:41:56 DEBUG : Local file system at /tmp/rclone1983136226: Waiting for transfers to finish 2024/11/14 18:41:57 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/11/14 18:41:57 DEBUG : sub dir/hello world.655e7eb.partial: renamed to: sub dir/hello world 2024/11/14 18:41:57 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestCopyRedownload (2.30s) === RUN TestSyncBasedOnCheckSum run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:41:58 DEBUG : check sum: Need to transfer - File not found at Destination 2024/11/14 18:41:58 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:41:58 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:41:58 DEBUG : check sum: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/11/14 18:41:58 INFO : check sum: Copied (new) 2024/11/14 18:41:58 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:41:59 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:41:59 DEBUG : check sum: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/11/14 18:41:59 DEBUG : check sum: Size and sha1 of src and dst objects identical 2024/11/14 18:41:59 DEBUG : check sum: Unchanged skipping 2024/11/14 18:41:59 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:41:59 DEBUG : Waiting for deletions to finish 2024/11/14 18:41:59 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestSyncBasedOnCheckSum (2.42s) === RUN TestSyncSizeOnly run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:42:00 DEBUG : sizeonly: Need to transfer - File not found at Destination 2024/11/14 18:42:00 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:42:00 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:42:01 DEBUG : sizeonly: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2024/11/14 18:42:01 INFO : sizeonly: Copied (new) 2024/11/14 18:42:01 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:42:01 DEBUG : sizeonly: Sizes identical 2024/11/14 18:42:01 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:42:01 DEBUG : sizeonly: Unchanged skipping 2024/11/14 18:42:01 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:42:01 DEBUG : Waiting for deletions to finish 2024/11/14 18:42:01 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestSyncSizeOnly (2.27s) === RUN TestSyncIgnoreSize run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:42:03 DEBUG : ignore-size: Need to transfer - File not found at Destination 2024/11/14 18:42:03 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:42:03 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:42:03 DEBUG : ignore-size: sha1 = 4a756ca07e9487f482465a99e8286abc86ba4dc7 OK 2024/11/14 18:42:03 INFO : ignore-size: Copied (new) 2024/11/14 18:42:03 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:42:03 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:42:03 DEBUG : ignore-size: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:42:03 DEBUG : ignore-size: Unchanged skipping 2024/11/14 18:42:03 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:42:03 DEBUG : Waiting for deletions to finish 2024/11/14 18:42:03 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestSyncIgnoreSize (2.37s) === RUN TestSyncIgnoreTimes run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:42:06 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:42:06 DEBUG : existing: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:42:06 DEBUG : existing: Unchanged skipping 2024/11/14 18:42:06 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:42:06 DEBUG : Waiting for deletions to finish 2024/11/14 18:42:06 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:42:06 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2024/11/14 18:42:06 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:42:06 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:42:06 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2024/11/14 18:42:06 INFO : existing: Copied (replaced existing) 2024/11/14 18:42:06 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestSyncIgnoreTimes (2.61s) === RUN TestSyncIgnoreExisting run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:42:08 DEBUG : existing: Need to transfer - File not found at Destination 2024/11/14 18:42:08 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:42:08 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:42:08 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2024/11/14 18:42:08 INFO : existing: Copied (new) 2024/11/14 18:42:08 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:42:08 DEBUG : existing: Destination exists, skipping 2024/11/14 18:42:08 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:42:08 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:42:08 DEBUG : Waiting for deletions to finish 2024/11/14 18:42:08 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestSyncIgnoreExisting (2.27s) === RUN TestSyncIgnoreErrors run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:42:11 DEBUG : d: Making directory fstest.go:244: Filtering empty directory "d" 2024/11/14 18:42:11 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/11/14 18:42:11 DEBUG : a/potato2: Need to transfer - File not found at Destination 2024/11/14 18:42:11 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:42:11 DEBUG : c/non empty space: Unchanged skipping 2024/11/14 18:42:11 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:42:11 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/11/14 18:42:11 INFO : a/potato2: Copied (new) 2024/11/14 18:42:11 DEBUG : Waiting for deletions to finish 2024/11/14 18:42:11 INFO : b/potato: Deleted run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestSyncIgnoreErrors (2.81s) === RUN TestSyncAfterChangingModtimeOnly run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:42:13 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:42:13 DEBUG : empty space: Modification times differ by -95456h54m52.624456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499 +0000 UTC 2024/11/14 18:42:13 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/11/14 18:42:13 NOTICE: empty space: Skipped update modification time as --dry-run is set (size 1) 2024/11/14 18:42:13 DEBUG : empty space: Unchanged skipping 2024/11/14 18:42:13 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:42:13 DEBUG : Waiting for deletions to finish 2024/11/14 18:42:13 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:42:14 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/11/14 18:42:14 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:42:14 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/11/14 18:42:15 INFO : empty space: Updated modification time in destination 2024/11/14 18:42:15 DEBUG : empty space: Unchanged skipping 2024/11/14 18:42:15 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:42:15 DEBUG : Waiting for deletions to finish 2024/11/14 18:42:15 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestSyncAfterChangingModtimeOnly (4.00s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:42:17 DEBUG : empty space: Modification times differ by -95456h54m52.624456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499 +0000 UTC 2024/11/14 18:42:17 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:42:17 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/11/14 18:42:17 DEBUG : empty space: Unchanged skipping 2024/11/14 18:42:17 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:42:17 DEBUG : Waiting for deletions to finish 2024/11/14 18:42:17 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (1.88s) === RUN TestSyncDoesntUpdateModtime run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:42:19 DEBUG : foo: Modification times differ by -95456h54m52.624456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499 +0000 UTC 2024/11/14 18:42:19 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:42:19 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 (Local file system at /tmp/rclone1983136226) 2024/11/14 18:42:19 DEBUG : foo: sha1 = 62cdb7020ff920e5aa642c3d4066950dd1f01f4d (B2 bucket rclone-test-jaderac3cuvu) 2024/11/14 18:42:19 DEBUG : foo: sha1 differ 2024/11/14 18:42:19 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:42:19 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 OK 2024/11/14 18:42:19 INFO : foo: Copied (replaced existing) 2024/11/14 18:42:19 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestSyncDoesntUpdateModtime (1.86s) === RUN TestSyncAfterAddingAFile run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:42:21 DEBUG : potato: Need to transfer - File not found at Destination 2024/11/14 18:42:21 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/11/14 18:42:21 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:42:21 DEBUG : empty space: Unchanged skipping 2024/11/14 18:42:21 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:42:21 DEBUG : potato: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/11/14 18:42:21 INFO : potato: Copied (new) 2024/11/14 18:42:21 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestSyncAfterAddingAFile (2.40s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:42:24 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2024/11/14 18:42:24 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:42:24 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:42:24 DEBUG : potato: sha1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f OK 2024/11/14 18:42:24 INFO : potato: Copied (replaced existing) 2024/11/14 18:42:24 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestSyncAfterChangingFilesSizeOnly (2.12s) === RUN TestSyncAfterChangingContentsOnly run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:42:25 DEBUG : potato: Modification times differ by 119h59m59.876543211s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2011-12-30 12:59:59 +0000 UTC 2024/11/14 18:42:25 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:42:25 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f (Local file system at /tmp/rclone1983136226) 2024/11/14 18:42:25 DEBUG : potato: sha1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f (B2 bucket rclone-test-jaderac3cuvu) 2024/11/14 18:42:25 DEBUG : potato: sha1 differ 2024/11/14 18:42:25 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:42:26 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f OK 2024/11/14 18:42:26 INFO : potato: Copied (replaced existing) 2024/11/14 18:42:26 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestSyncAfterChangingContentsOnly (2.09s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:42:28 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/14 18:42:28 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2024/11/14 18:42:28 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:42:28 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/11/14 18:42:28 DEBUG : empty space: Unchanged skipping 2024/11/14 18:42:28 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:42:28 DEBUG : Waiting for deletions to finish 2024/11/14 18:42:28 NOTICE: potato: Skipped delete as --dry-run is set (size 21) run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (2.04s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:42:30 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/14 18:42:30 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/11/14 18:42:30 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:42:30 DEBUG : empty space: Unchanged skipping 2024/11/14 18:42:30 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:42:30 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/11/14 18:42:30 INFO : potato2: Copied (new) 2024/11/14 18:42:30 DEBUG : Waiting for deletions to finish 2024/11/14 18:42:31 INFO : potato: Deleted run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (2.83s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:42:33 DEBUG : d: Making directory 2024/11/14 18:42:33 DEBUG : d/e: Making directory fstest.go:244: Filtering empty directory "d" fstest.go:244: Filtering empty directory "d/e" 2024/11/14 18:42:33 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/11/14 18:42:33 DEBUG : a/potato2: Need to transfer - File not found at Destination 2024/11/14 18:42:33 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:42:33 DEBUG : c/non empty space: Unchanged skipping 2024/11/14 18:42:33 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:42:33 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/11/14 18:42:33 INFO : a/potato2: Copied (new) 2024/11/14 18:42:33 DEBUG : Waiting for deletions to finish 2024/11/14 18:42:33 INFO : b/potato: Deleted run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (2.92s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:42:36 DEBUG : d: Making directory fstest.go:244: Filtering empty directory "d" 2024/11/14 18:42:36 DEBUG : c/non empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/11/14 18:42:36 DEBUG : a/potato2: Need to transfer - File not found at Destination 2024/11/14 18:42:36 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:42:36 DEBUG : c/non empty space: Unchanged skipping 2024/11/14 18:42:36 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:42:36 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/11/14 18:42:36 INFO : a/potato2: Copied (new) 2024/11/14 18:42:36 ERROR : B2 bucket rclone-test-jaderac3cuvu: not deleting files as there were IO errors 2024/11/14 18:42:36 ERROR : B2 bucket rclone-test-jaderac3cuvu: not deleting directories as there were IO errors run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" fstest.go:244: Filtering empty directory "d" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (2.91s) === RUN TestSyncDeleteAfter --- PASS: TestSyncDeleteAfter (0.00s) === RUN TestSyncDeleteDuring run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:42:38 DEBUG : Waiting for deletions to finish 2024/11/14 18:42:39 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/14 18:42:39 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:42:39 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/11/14 18:42:39 DEBUG : empty space: Unchanged skipping 2024/11/14 18:42:39 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:42:39 INFO : potato: Deleted 2024/11/14 18:42:39 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/11/14 18:42:39 INFO : potato2: Copied (new) run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestSyncDeleteDuring (2.52s) === RUN TestSyncDeleteBefore run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:42:41 DEBUG : Waiting for deletions to finish 2024/11/14 18:42:41 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:42:41 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:42:41 INFO : potato: Deleted 2024/11/14 18:42:41 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/14 18:42:41 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/11/14 18:42:41 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:42:41 DEBUG : empty space: Unchanged skipping 2024/11/14 18:42:41 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:42:42 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/11/14 18:42:42 INFO : potato2: Copied (new) run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestSyncDeleteBefore (3.32s) === RUN TestCopyDeleteBefore run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:42:44 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/14 18:42:44 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:42:44 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:42:45 DEBUG : potato2: sha1 = 810274f0df19dab60a894a562b7a8ff04c072623 OK 2024/11/14 18:42:45 INFO : potato2: Copied (new) run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestCopyDeleteBefore (2.36s) === RUN TestSyncWithExclude run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:42:47 DEBUG : enormous: Excluded (Size Filter) 2024/11/14 18:42:47 DEBUG : enormous: Excluded 2024/11/14 18:42:47 DEBUG : potato2: Excluded (Size Filter) 2024/11/14 18:42:47 DEBUG : potato2: Excluded 2024/11/14 18:42:47 DEBUG : potato2: Excluded (Size Filter) 2024/11/14 18:42:47 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/11/14 18:42:47 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:42:47 DEBUG : empty space: Unchanged skipping 2024/11/14 18:42:47 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:42:47 DEBUG : Waiting for deletions to finish 2024/11/14 18:42:47 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:42:47 DEBUG : enormous: Excluded (Size Filter) 2024/11/14 18:42:47 DEBUG : enormous: Excluded 2024/11/14 18:42:47 DEBUG : potato2: Excluded (Size Filter) 2024/11/14 18:42:47 DEBUG : potato2: Excluded 2024/11/14 18:42:47 DEBUG : potato2: Excluded (Size Filter) 2024/11/14 18:42:47 DEBUG : empty space: Size and modification time the same (differ by 456.789µs, within tolerance 1ms) 2024/11/14 18:42:47 DEBUG : empty space: Unchanged skipping 2024/11/14 18:42:47 DEBUG : Local file system at /tmp/rclone1983136226: Waiting for checks to finish 2024/11/14 18:42:47 DEBUG : Local file system at /tmp/rclone1983136226: Waiting for transfers to finish 2024/11/14 18:42:47 DEBUG : Waiting for deletions to finish 2024/11/14 18:42:47 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestSyncWithExclude (2.89s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:42:50 DEBUG : enormous: Excluded (Size Filter) 2024/11/14 18:42:50 DEBUG : enormous: Excluded 2024/11/14 18:42:50 DEBUG : potato2: Excluded (Size Filter) 2024/11/14 18:42:50 DEBUG : potato2: Excluded 2024/11/14 18:42:50 DEBUG : empty space: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/11/14 18:42:50 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:42:50 DEBUG : empty space: Unchanged skipping 2024/11/14 18:42:50 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:42:50 DEBUG : Waiting for deletions to finish 2024/11/14 18:42:50 INFO : enormous: Deleted 2024/11/14 18:42:50 INFO : potato2: Deleted 2024/11/14 18:42:50 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:42:51 DEBUG : empty space: Size and modification time the same (differ by 456.789µs, within tolerance 1ms) 2024/11/14 18:42:51 DEBUG : empty space: Unchanged skipping 2024/11/14 18:42:51 DEBUG : Local file system at /tmp/rclone1983136226: Waiting for checks to finish 2024/11/14 18:42:51 DEBUG : Local file system at /tmp/rclone1983136226: Waiting for transfers to finish 2024/11/14 18:42:51 DEBUG : Waiting for deletions to finish 2024/11/14 18:42:51 INFO : enormous: Deleted 2024/11/14 18:42:51 INFO : potato2: Deleted 2024/11/14 18:42:51 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestSyncWithExcludeAndDeleteExcluded (3.31s) === RUN TestSyncWithUpdateOlder run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:42:53 DEBUG : five: Need to transfer - File not found at Destination 2024/11/14 18:42:53 DEBUG : four: Sizes differ (src 4 vs dst 8) 2024/11/14 18:42:53 DEBUG : one: Destination is newer than source, skipping 2024/11/14 18:42:53 DEBUG : three: Sizes identical 2024/11/14 18:42:53 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:42:53 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2024/11/14 18:42:53 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2024/11/14 18:42:53 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b (Local file system at /tmp/rclone1983136226) 2024/11/14 18:42:53 DEBUG : two: sha1 = b10e0da85e90399abfec36c7376b20aa4596461b (B2 bucket rclone-test-jaderac3cuvu) 2024/11/14 18:42:53 DEBUG : two: sha1 differ 2024/11/14 18:42:53 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:42:54 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2024/11/14 18:42:54 INFO : five: Copied (new) 2024/11/14 18:42:54 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2024/11/14 18:42:54 INFO : four: Copied (replaced existing) 2024/11/14 18:42:54 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2024/11/14 18:42:54 INFO : two: Copied (replaced existing) 2024/11/14 18:42:54 DEBUG : Waiting for deletions to finish 2024/11/14 18:42:55 DEBUG : one: Destination is newer than source, skipping 2024/11/14 18:42:55 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:42:55 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2024/11/14 18:42:55 DEBUG : four: Size and sha1 of src and dst objects identical 2024/11/14 18:42:55 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2024/11/14 18:42:55 DEBUG : four: Destination mod time is within 1s of source and files identical, skipping 2024/11/14 18:42:55 DEBUG : two: Size and sha1 of src and dst objects identical 2024/11/14 18:42:55 DEBUG : two: Destination mod time is within 1s of source and files identical, skipping 2024/11/14 18:42:55 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb (Local file system at /tmp/rclone1983136226) 2024/11/14 18:42:55 DEBUG : three: sha1 = 03731cad13f4cf7b59703c77529381cdec1632e5 (B2 bucket rclone-test-jaderac3cuvu) 2024/11/14 18:42:55 DEBUG : three: sha1 differ 2024/11/14 18:42:55 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2024/11/14 18:42:55 DEBUG : five: Size and sha1 of src and dst objects identical 2024/11/14 18:42:55 DEBUG : three: Destination mod time is within 1s of source but files differ, transferring 2024/11/14 18:42:55 DEBUG : five: Destination mod time is within 1s of source and files identical, skipping 2024/11/14 18:42:55 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:42:55 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2024/11/14 18:42:55 INFO : three: Copied (replaced existing) 2024/11/14 18:42:55 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithUpdateOlder (4.56s) === RUN TestSyncWithMaxDuration === RUN TestSyncWithMaxDuration/Hard sync_test.go:1364: Skipping test on non local remote === RUN TestSyncWithMaxDuration/Soft sync_test.go:1364: 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-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" sync_test.go:1436: Can track renames: true 2024/11/14 18:42:57 INFO : B2 bucket rclone-test-jaderac3cuvu: Making map for --track-renames 2024/11/14 18:42:57 INFO : B2 bucket rclone-test-jaderac3cuvu: Finished making map for --track-renames 2024/11/14 18:42:57 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:42:57 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for renames to finish 2024/11/14 18:42:57 DEBUG : potato: Need to transfer - No matching file found at Destination 2024/11/14 18:42:57 DEBUG : yam: Need to transfer - No matching file found at Destination 2024/11/14 18:42:57 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:42:57 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/11/14 18:42:57 INFO : yam: Copied (new) 2024/11/14 18:42:57 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2024/11/14 18:42:57 INFO : potato: Copied (new) 2024/11/14 18:42:57 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:42:57 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:42:57 INFO : B2 bucket rclone-test-jaderac3cuvu: Making map for --track-renames 2024/11/14 18:42:57 INFO : B2 bucket rclone-test-jaderac3cuvu: Finished making map for --track-renames 2024/11/14 18:42:57 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:42:57 DEBUG : potato: Unchanged skipping 2024/11/14 18:42:57 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for renames to finish 2024/11/14 18:43:01 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/11/14 18:43:01 INFO : yam: Copied (server-side copy) to: yaml 2024/11/14 18:43:01 INFO : yam: Deleted 2024/11/14 18:43:01 INFO : yaml: Renamed from "yam" 2024/11/14 18:43:01 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:43:01 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestSyncWithTrackRenames (5.79s) === RUN TestParseRenamesStrategyModtime --- PASS: TestParseRenamesStrategyModtime (0.00s) === RUN TestRenamesStrategyModtime --- PASS: TestRenamesStrategyModtime (0.00s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" sync_test.go:1508: Can track renames: true 2024/11/14 18:43:03 INFO : B2 bucket rclone-test-jaderac3cuvu: Making map for --track-renames 2024/11/14 18:43:03 INFO : B2 bucket rclone-test-jaderac3cuvu: Finished making map for --track-renames 2024/11/14 18:43:03 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:43:03 DEBUG : potato: Need to transfer - No matching file found at Destination 2024/11/14 18:43:03 DEBUG : yam: Need to transfer - No matching file found at Destination 2024/11/14 18:43:03 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for renames to finish 2024/11/14 18:43:03 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:43:03 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/11/14 18:43:03 INFO : yam: Copied (new) 2024/11/14 18:43:03 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2024/11/14 18:43:03 INFO : potato: Copied (new) 2024/11/14 18:43:03 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:43:04 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:43:04 INFO : B2 bucket rclone-test-jaderac3cuvu: Making map for --track-renames 2024/11/14 18:43:04 INFO : B2 bucket rclone-test-jaderac3cuvu: Finished making map for --track-renames 2024/11/14 18:43:04 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:43:04 DEBUG : potato: Unchanged skipping 2024/11/14 18:43:04 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for renames to finish 2024/11/14 18:43:04 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/11/14 18:43:04 INFO : yam: Copied (server-side copy) to: yaml 2024/11/14 18:43:05 INFO : yam: Deleted 2024/11/14 18:43:05 INFO : yaml: Renamed from "yam" 2024/11/14 18:43:05 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:43:05 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestSyncWithTrackRenamesStrategyModtime (3.90s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" sync_test.go:1547: Can track renames: true 2024/11/14 18:43:07 INFO : B2 bucket rclone-test-jaderac3cuvu: Making map for --track-renames 2024/11/14 18:43:07 INFO : B2 bucket rclone-test-jaderac3cuvu: Finished making map for --track-renames 2024/11/14 18:43:07 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:43:07 DEBUG : potato: Need to transfer - No matching file found at Destination 2024/11/14 18:43:07 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2024/11/14 18:43:07 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for renames to finish 2024/11/14 18:43:07 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:43:07 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/11/14 18:43:07 INFO : sub/yam: Copied (new) 2024/11/14 18:43:07 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2024/11/14 18:43:07 INFO : potato: Copied (new) 2024/11/14 18:43:07 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:43:07 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:43:07 DEBUG : potato: Unchanged skipping 2024/11/14 18:43:07 INFO : B2 bucket rclone-test-jaderac3cuvu: Making map for --track-renames 2024/11/14 18:43:07 INFO : B2 bucket rclone-test-jaderac3cuvu: Finished making map for --track-renames 2024/11/14 18:43:07 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:43:07 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for renames to finish 2024/11/14 18:43:08 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2024/11/14 18:43:08 INFO : sub/yam: Copied (server-side copy) to: yam 2024/11/14 18:43:08 INFO : sub/yam: Deleted 2024/11/14 18:43:08 INFO : yam: Renamed from "sub/yam" 2024/11/14 18:43:08 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:43:08 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestSyncWithTrackRenamesStrategyLeaf (3.38s) === RUN TestServerSideMoveLocal run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:43:10 DEBUG : Creating backend with remote "/tmp/rclone1983136226/dir1" 2024/11/14 18:43:10 DEBUG : Config file has changed externally - reloading 2024/11/14 18:43:10 DEBUG : Creating backend with remote "/tmp/rclone1983136226/dir2" 2024/11/14 18:43:10 DEBUG : Local file system at /tmp/rclone1983136226/dir2: Using server-side directory move 2024/11/14 18:43:10 INFO : Local file system at /tmp/rclone1983136226/dir2: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2024/11/14 18:43:10 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/11/14 18:43:10 DEBUG : Local file system at /tmp/rclone1983136226/dir2: Waiting for checks to finish 2024/11/14 18:43:10 DEBUG : Local file system at /tmp/rclone1983136226/dir2: Waiting for transfers to finish 2024/11/14 18:43:10 INFO : file1.txt: Moved (server-side) --- PASS: TestServerSideMoveLocal (0.37s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:43:10 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/14 18:43:10 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2024/11/14 18:43:10 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:43:10 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:43:10 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2024/11/14 18:43:10 INFO : nested/sub dir/file: Copied (new) 2024/11/14 18:43:10 INFO : nested/sub dir/file: Deleted 2024/11/14 18:43:11 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/11/14 18:43:11 INFO : sub dir/hello world: Copied (new) 2024/11/14 18:43:11 INFO : sub dir/hello world: Deleted 2024/11/14 18:43:11 INFO : sub dir: Removing directory 2024/11/14 18:43:11 INFO : nested/sub dir: Removing directory 2024/11/14 18:43:11 INFO : nested: Removing directory 2024/11/14 18:43:11 DEBUG : Local file system at /tmp/rclone1983136226: deleted 3 directories run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestMoveWithDeleteEmptySrcDirs (2.68s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:43:13 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/14 18:43:13 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2024/11/14 18:43:13 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:43:13 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:43:13 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2024/11/14 18:43:13 INFO : nested/sub dir/file: Copied (new) 2024/11/14 18:43:13 INFO : nested/sub dir/file: Deleted 2024/11/14 18:43:14 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2024/11/14 18:43:14 INFO : sub dir/hello world: Copied (new) 2024/11/14 18:43:14 INFO : sub dir/hello world: Deleted run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestMoveWithoutDeleteEmptySrcDirs (2.05s) === RUN TestMoveWithIgnoreExisting run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:43:15 DEBUG : existing: Need to transfer - File not found at Destination 2024/11/14 18:43:15 DEBUG : existing-b: Need to transfer - File not found at Destination 2024/11/14 18:43:15 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:43:15 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:43:15 DEBUG : existing-b: sha1 = 321f6b7e8bf7f29aab89c5e41a555b1b0baa41a9 OK 2024/11/14 18:43:15 INFO : existing-b: Copied (new) 2024/11/14 18:43:15 INFO : existing-b: Deleted 2024/11/14 18:43:15 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2024/11/14 18:43:15 INFO : existing: Copied (new) 2024/11/14 18:43:15 INFO : existing: Deleted 2024/11/14 18:43:16 DEBUG : existing: Destination exists, skipping 2024/11/14 18:43:16 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2024/11/14 18:43:16 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:43:16 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:43:16 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestMoveWithIgnoreExisting (2.15s) === RUN TestServerSideMove run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:43:17 DEBUG : Creating backend with remote "TestB2:rclone-test-fugehiw5zuye" sync_test.go:1603: Server side move (if possible) B2 bucket rclone-test-jaderac3cuvu -> B2 bucket rclone-test-fugehiw5zuye 2024/11/14 18:43:21 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/14 18:43:21 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ms) 2024/11/14 18:43:21 DEBUG : empty space: Unchanged skipping 2024/11/14 18:43:21 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2024/11/14 18:43:21 DEBUG : B2 bucket rclone-test-fugehiw5zuye: Waiting for checks to finish 2024/11/14 18:43:21 INFO : empty space: Deleted 2024/11/14 18:43:21 DEBUG : B2 bucket rclone-test-fugehiw5zuye: Waiting for transfers to finish 2024/11/14 18:43:21 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/11/14 18:43:21 INFO : potato2: Copied (server-side copy) 2024/11/14 18:43:22 INFO : potato2: Deleted 2024/11/14 18:43:22 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2024/11/14 18:43:22 INFO : potato3: Copied (server-side copy) 2024/11/14 18:43:22 INFO : potato3: Deleted 2024/11/14 18:43:22 DEBUG : Creating backend with remote "TestB2:rclone-test-sasiluq6tonu" 2024/11/14 18:43:23 DEBUG : empty space: Need to transfer - File not found at Destination 2024/11/14 18:43:23 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/14 18:43:23 DEBUG : potato3: Need to transfer - File not found at Destination 2024/11/14 18:43:23 DEBUG : B2 bucket rclone-test-sasiluq6tonu: Waiting for checks to finish 2024/11/14 18:43:23 DEBUG : B2 bucket rclone-test-sasiluq6tonu: Waiting for transfers to finish 2024/11/14 18:43:25 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/11/14 18:43:25 INFO : potato2: Copied (server-side copy) 2024/11/14 18:43:25 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/11/14 18:43:25 INFO : empty space: Copied (server-side copy) 2024/11/14 18:43:25 INFO : potato2: Deleted 2024/11/14 18:43:25 INFO : empty space: Deleted 2024/11/14 18:43:26 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2024/11/14 18:43:26 INFO : potato3: Copied (server-side copy) 2024/11/14 18:43:26 INFO : potato3: Deleted 2024/11/14 18:43:26 DEBUG : B2 bucket rclone-test-sasiluq6tonu: Purge remote 2024/11/14 18:43:26 INFO : B2 bucket rclone-test-sasiluq6tonu: cleaning bucket "rclone-test-sasiluq6tonu" of all files 2024/11/14 18:43:26 DEBUG : empty space: Deleting (id "4_z7f42bdd3f0cd2bbb9f380e1b_f106c7c72b1aa310c_d20241114_m184324_c001_v0001146_t0016_u01731609804720") 2024/11/14 18:43:26 DEBUG : potato2: Deleting (id "4_z7f42bdd3f0cd2bbb9f380e1b_f11096ea46d9962ba_d20241114_m184325_c001_v0001165_t0051_u01731609805087") 2024/11/14 18:43:26 DEBUG : potato3: Deleting (id "4_z7f42bdd3f0cd2bbb9f380e1b_f118078a4bec04d2e_d20241114_m184325_c001_v0001144_t0000_u01731609805116") 2024/11/14 18:43:27 DEBUG : B2 bucket rclone-test-fugehiw5zuye: Purge remote 2024/11/14 18:43:27 INFO : B2 bucket rclone-test-fugehiw5zuye: cleaning bucket "rclone-test-fugehiw5zuye" of all files 2024/11/14 18:43:28 DEBUG : empty space: Deleting (id "4_z6fd2adb3f0cd2bbb9f380e1b_f4105f111ddf47a0e_d20241114_m184325_c001_v7007000_t0000_u01731609805412") 2024/11/14 18:43:28 DEBUG : empty space: Deleting (id "4_z6fd2adb3f0cd2bbb9f380e1b_f113ba0f016dc9db2_d20241114_m184320_c001_v0001161_t0047_u01731609800494") 2024/11/14 18:43:28 DEBUG : potato2: Deleting (id "4_z6fd2adb3f0cd2bbb9f380e1b_f409715789058c37f_d20241114_m184325_c001_v7007000_t0000_u01731609805382") 2024/11/14 18:43:28 DEBUG : potato2: Deleting (id "4_z6fd2adb3f0cd2bbb9f380e1b_f1077d9f7947e8948_d20241114_m184321_c001_v0001176_t0049_u01731609801746") 2024/11/14 18:43:28 DEBUG : potato3: Deleting (id "4_z6fd2adb3f0cd2bbb9f380e1b_f4105f111ddf47a13_d20241114_m184326_c001_v7007000_t0000_u01731609806142") 2024/11/14 18:43:28 DEBUG : potato3: Deleting (id "4_z6fd2adb3f0cd2bbb9f380e1b_f101b9c93713bb0be_d20241114_m184322_c001_v0001181_t0039_u01731609802087") 2024/11/14 18:43:28 DEBUG : potato3: Deleting (id "4_z6fd2adb3f0cd2bbb9f380e1b_f113ba0f016dc9db4_d20241114_m184321_c001_v0001161_t0059_u01731609801001") --- PASS: TestServerSideMove (12.51s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:43:29 DEBUG : Creating backend with remote "TestB2:rclone-test-juwivuq6lopi" sync_test.go:1603: Server side move (if possible) B2 bucket rclone-test-jaderac3cuvu -> B2 bucket rclone-test-juwivuq6lopi 2024/11/14 18:43:34 DEBUG : empty space: Excluded (Size Filter) 2024/11/14 18:43:34 DEBUG : empty space: Excluded (Size Filter) 2024/11/14 18:43:34 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/14 18:43:34 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2024/11/14 18:43:34 DEBUG : B2 bucket rclone-test-juwivuq6lopi: Waiting for checks to finish 2024/11/14 18:43:34 DEBUG : B2 bucket rclone-test-juwivuq6lopi: Waiting for transfers to finish 2024/11/14 18:43:35 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/11/14 18:43:35 INFO : potato2: Copied (server-side copy) 2024/11/14 18:43:35 INFO : potato2: Deleted 2024/11/14 18:43:35 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2024/11/14 18:43:35 INFO : potato3: Copied (server-side copy) 2024/11/14 18:43:35 INFO : potato3: Deleted 2024/11/14 18:43:36 DEBUG : Creating backend with remote "TestB2:rclone-test-firugot4wowi" 2024/11/14 18:43:36 DEBUG : empty space: Excluded (Size Filter) 2024/11/14 18:43:37 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/14 18:43:37 DEBUG : potato3: Need to transfer - File not found at Destination 2024/11/14 18:43:37 DEBUG : B2 bucket rclone-test-firugot4wowi: Waiting for checks to finish 2024/11/14 18:43:37 DEBUG : B2 bucket rclone-test-firugot4wowi: Waiting for transfers to finish 2024/11/14 18:43:38 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/11/14 18:43:38 INFO : potato2: Copied (server-side copy) 2024/11/14 18:43:38 INFO : potato2: Deleted 2024/11/14 18:43:38 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2024/11/14 18:43:38 INFO : potato3: Copied (server-side copy) 2024/11/14 18:43:38 INFO : potato3: Deleted 2024/11/14 18:43:38 DEBUG : B2 bucket rclone-test-firugot4wowi: Purge remote 2024/11/14 18:43:38 INFO : B2 bucket rclone-test-firugot4wowi: cleaning bucket "rclone-test-firugot4wowi" of all files 2024/11/14 18:43:39 DEBUG : potato2: Deleting (id "4_z6fa2fd13f0cd2bbb9f380e1b_f109b26066999ff02_d20241114_m184337_c001_v0001181_t0052_u01731609817928") 2024/11/14 18:43:39 DEBUG : potato3: Deleting (id "4_z6fa2fd13f0cd2bbb9f380e1b_f110f023feb9c9690_d20241114_m184338_c001_v0001033_t0019_u01731609818162") 2024/11/14 18:43:39 DEBUG : B2 bucket rclone-test-juwivuq6lopi: Purge remote 2024/11/14 18:43:39 INFO : B2 bucket rclone-test-juwivuq6lopi: cleaning bucket "rclone-test-juwivuq6lopi" of all files 2024/11/14 18:43:40 DEBUG : empty space: Deleting (id "4_z2f82ed03f0cd2bbb9f380e1b_f1066a643a4f7a829_d20241114_m184334_c001_v0001150_t0029_u01731609814058") 2024/11/14 18:43:40 DEBUG : potato2: Deleting (id "4_z2f82ed03f0cd2bbb9f380e1b_f4105f111ddf47a23_d20241114_m184338_c001_v7007000_t0000_u01731609818137") 2024/11/14 18:43:40 DEBUG : potato2: Deleting (id "4_z2f82ed03f0cd2bbb9f380e1b_f1039127fe2523f1a_d20241114_m184334_c001_v0001098_t0027_u01731609814979") 2024/11/14 18:43:40 DEBUG : potato3: Deleting (id "4_z2f82ed03f0cd2bbb9f380e1b_f4105f111ddf47a24_d20241114_m184338_c001_v7007000_t0000_u01731609818548") 2024/11/14 18:43:40 DEBUG : potato3: Deleting (id "4_z2f82ed03f0cd2bbb9f380e1b_f108104f7f617c48d_d20241114_m184335_c001_v0001157_t0009_u01731609815328") 2024/11/14 18:43:40 DEBUG : potato3: Deleting (id "4_z2f82ed03f0cd2bbb9f380e1b_f1066a643a4f7a82b_d20241114_m184334_c001_v0001150_t0033_u01731609814338") --- PASS: TestServerSideMoveWithFilter (12.21s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:43:42 DEBUG : Creating backend with remote "TestB2:rclone-test-kunijul9kosa" 2024/11/14 18:43:44 DEBUG : tomatoDir: Making directory sync_test.go:1603: Server side move (if possible) B2 bucket rclone-test-jaderac3cuvu -> B2 bucket rclone-test-kunijul9kosa 2024/11/14 18:43:46 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/14 18:43:46 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ms) 2024/11/14 18:43:46 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2024/11/14 18:43:46 DEBUG : empty space: Unchanged skipping 2024/11/14 18:43:46 DEBUG : B2 bucket rclone-test-kunijul9kosa: Waiting for checks to finish 2024/11/14 18:43:47 INFO : empty space: Deleted 2024/11/14 18:43:47 DEBUG : B2 bucket rclone-test-kunijul9kosa: Waiting for transfers to finish 2024/11/14 18:43:47 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/11/14 18:43:47 INFO : potato2: Copied (server-side copy) 2024/11/14 18:43:47 INFO : potato2: Deleted 2024/11/14 18:43:47 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2024/11/14 18:43:47 INFO : potato3: Copied (server-side copy) 2024/11/14 18:43:47 INFO : potato3: Deleted 2024/11/14 18:43:48 DEBUG : Creating backend with remote "TestB2:rclone-test-jiredet5biba" 2024/11/14 18:43:48 DEBUG : tomatoDir: Making directory 2024/11/14 18:43:49 DEBUG : empty space: Need to transfer - File not found at Destination 2024/11/14 18:43:49 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/14 18:43:49 DEBUG : potato3: Need to transfer - File not found at Destination 2024/11/14 18:43:49 DEBUG : B2 bucket rclone-test-jiredet5biba: Waiting for checks to finish 2024/11/14 18:43:49 DEBUG : B2 bucket rclone-test-jiredet5biba: Waiting for transfers to finish 2024/11/14 18:43:50 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2024/11/14 18:43:50 INFO : empty space: Copied (server-side copy) 2024/11/14 18:43:50 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2024/11/14 18:43:50 INFO : potato2: Copied (server-side copy) 2024/11/14 18:43:50 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK 2024/11/14 18:43:50 INFO : potato3: Copied (server-side copy) 2024/11/14 18:43:50 INFO : empty space: Deleted 2024/11/14 18:43:50 INFO : potato2: Deleted 2024/11/14 18:43:51 INFO : potato3: Deleted 2024/11/14 18:43:51 DEBUG : B2 bucket rclone-test-jiredet5biba: Purge remote 2024/11/14 18:43:51 INFO : B2 bucket rclone-test-jiredet5biba: cleaning bucket "rclone-test-jiredet5biba" of all files 2024/11/14 18:43:51 DEBUG : empty space: Deleting (id "4_z4fd22d13f0dd2bbb9f380e1b_f116e84c6fc628cd5_d20241114_m184350_c001_v0001104_t0009_u01731609830212") 2024/11/14 18:43:51 DEBUG : potato2: Deleting (id "4_z4fd22d13f0dd2bbb9f380e1b_f1137182ea54cf4b6_d20241114_m184350_c001_v0001100_t0030_u01731609830584") 2024/11/14 18:43:51 DEBUG : potato3: Deleting (id "4_z4fd22d13f0dd2bbb9f380e1b_f11416817b894f4b9_d20241114_m184350_c001_v0001157_t0031_u01731609830592") 2024/11/14 18:43:53 DEBUG : B2 bucket rclone-test-kunijul9kosa: Purge remote 2024/11/14 18:43:53 INFO : B2 bucket rclone-test-kunijul9kosa: cleaning bucket "rclone-test-kunijul9kosa" of all files 2024/11/14 18:43:53 DEBUG : empty space: Deleting (id "4_z8fc20df3f0dd2bbb9f380e1b_f417c9670a3c4afa5_d20241114_m184350_c001_v7007000_t0000_u01731609830771") 2024/11/14 18:43:53 DEBUG : empty space: Deleting (id "4_z8fc20df3f0dd2bbb9f380e1b_f108b772c9907dce0_d20241114_m184346_c001_v0001181_t0038_u01731609826183") 2024/11/14 18:43:53 DEBUG : potato2: Deleting (id "4_z8fc20df3f0dd2bbb9f380e1b_f4036e7692493667f_d20241114_m184350_c001_v7007000_t0000_u01731609830872") 2024/11/14 18:43:53 DEBUG : potato2: Deleting (id "4_z8fc20df3f0dd2bbb9f380e1b_f118ea449a3325e10_d20241114_m184347_c001_v0001091_t0028_u01731609827039") 2024/11/14 18:43:53 DEBUG : potato3: Deleting (id "4_z8fc20df3f0dd2bbb9f380e1b_f417c9670a3c4afa6_d20241114_m184350_c001_v7007000_t0000_u01731609830953") 2024/11/14 18:43:53 DEBUG : potato3: Deleting (id "4_z8fc20df3f0dd2bbb9f380e1b_f11994e18536c4c65_d20241114_m184347_c001_v0001105_t0019_u01731609827385") 2024/11/14 18:43:53 DEBUG : potato3: Deleting (id "4_z8fc20df3f0dd2bbb9f380e1b_f108b772c9907dce2_d20241114_m184346_c001_v0001181_t0021_u01731609826426") --- PASS: TestServerSideMoveDeleteEmptySourceDirs (13.06s) === RUN TestServerSideMoveOverlap run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:43:55 DEBUG : Creating backend with remote "TestB2:rclone-test-jaderac3cuvu/rclone-move-test" --- PASS: TestServerSideMoveOverlap (2.40s) === RUN TestSyncOverlap run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:43:57 DEBUG : Creating backend with remote "TestB2:rclone-test-jaderac3cuvu/rclone-sync-test" run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestSyncOverlap (2.94s) === RUN TestSyncOverlapWithFilter run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:44:00 DEBUG : Creating backend with remote "TestB2:rclone-test-jaderac3cuvu/rclone-sync-test" 2024/11/14 18:44:02 DEBUG : Creating backend with remote "TestB2:rclone-test-jaderac3cuvu/rclone-sync-test-include/layer2" 2024/11/14 18:44:04 DEBUG : Creating backend with remote "TestB2:rclone-test-jaderac3cuvu/rclone-sync-test-ignore-file" 2024/11/14 18:44:07 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_list_file_names": EOF) 2024/11/14 18:44:07 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2024/11/14 18:44:08 DEBUG : pacer: Reducing sleep to 10ms 2024/11/14 18:44:08 DEBUG : B2 bucket rclone-test-jaderac3cuvu path rclone-sync-test: Waiting for checks to finish 2024/11/14 18:44:08 DEBUG : B2 bucket rclone-test-jaderac3cuvu path rclone-sync-test: Waiting for transfers to finish 2024/11/14 18:44:08 DEBUG : Waiting for deletions to finish 2024/11/14 18:44:08 INFO : There was nothing to transfer 2024/11/14 18:44:08 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:44:08 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:44:08 DEBUG : Waiting for deletions to finish 2024/11/14 18:44:08 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:44:08 DEBUG : B2 bucket rclone-test-jaderac3cuvu path rclone-sync-test-include/layer2: Waiting for checks to finish 2024/11/14 18:44:08 DEBUG : B2 bucket rclone-test-jaderac3cuvu path rclone-sync-test-include/layer2: Waiting for transfers to finish 2024/11/14 18:44:08 DEBUG : Waiting for deletions to finish 2024/11/14 18:44:08 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:44:09 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:44:09 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:44:09 DEBUG : Waiting for deletions to finish 2024/11/14 18:44:09 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:44:09 DEBUG : B2 bucket rclone-test-jaderac3cuvu path rclone-sync-test-ignore-file: Waiting for checks to finish 2024/11/14 18:44:09 DEBUG : B2 bucket rclone-test-jaderac3cuvu path rclone-sync-test-ignore-file: Waiting for transfers to finish 2024/11/14 18:44:09 DEBUG : Waiting for deletions to finish 2024/11/14 18:44:09 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestSyncOverlapWithFilter (15.72s) === RUN TestSyncCompareDest run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:44:16 DEBUG : Creating backend with remote "TestB2:rclone-test-jaderac3cuvu/dst" 2024/11/14 18:44:17 DEBUG : Creating backend with remote "TestB2:rclone-test-jaderac3cuvu/CompareDest" 2024/11/14 18:44:19 DEBUG : one: Need to transfer - File not found at Destination 2024/11/14 18:44:19 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for checks to finish 2024/11/14 18:44:19 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for transfers to finish 2024/11/14 18:44:20 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/11/14 18:44:20 INFO : one: Copied (new) 2024/11/14 18:44:20 DEBUG : Waiting for deletions to finish 2024/11/14 18:44:21 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/14 18:44:21 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for checks to finish 2024/11/14 18:44:21 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for transfers to finish 2024/11/14 18:44:22 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2024/11/14 18:44:22 INFO : one: Copied (replaced existing) 2024/11/14 18:44:22 DEBUG : Waiting for deletions to finish 2024/11/14 18:44:23 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/14 18:44:23 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for checks to finish 2024/11/14 18:44:23 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/11/14 18:44:23 DEBUG : one: Destination found in --compare-dest, skipping 2024/11/14 18:44:23 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for transfers to finish 2024/11/14 18:44:23 DEBUG : Waiting for deletions to finish 2024/11/14 18:44:23 INFO : There was nothing to transfer 2024/11/14 18:44:25 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/11/14 18:44:25 DEBUG : two: Destination found in --compare-dest, skipping 2024/11/14 18:44:25 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/14 18:44:25 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for checks to finish 2024/11/14 18:44:25 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/11/14 18:44:25 DEBUG : one: Destination found in --compare-dest, skipping 2024/11/14 18:44:25 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for transfers to finish 2024/11/14 18:44:25 DEBUG : Waiting for deletions to finish 2024/11/14 18:44:25 INFO : There was nothing to transfer 2024/11/14 18:44:26 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/11/14 18:44:26 DEBUG : two: Destination found in --compare-dest, skipping 2024/11/14 18:44:26 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/14 18:44:26 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for checks to finish 2024/11/14 18:44:26 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/11/14 18:44:26 DEBUG : one: Destination found in --compare-dest, skipping 2024/11/14 18:44:26 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for transfers to finish 2024/11/14 18:44:26 DEBUG : Waiting for deletions to finish 2024/11/14 18:44:26 INFO : There was nothing to transfer 2024/11/14 18:44:27 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/11/14 18:44:27 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2024/11/14 18:44:27 DEBUG : two: Destination found in --compare-dest, skipping 2024/11/14 18:44:27 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/14 18:44:27 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for checks to finish 2024/11/14 18:44:27 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/11/14 18:44:27 DEBUG : one: Destination found in --compare-dest, skipping 2024/11/14 18:44:27 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for transfers to finish 2024/11/14 18:44:27 DEBUG : Waiting for deletions to finish 2024/11/14 18:44:27 INFO : There was nothing to transfer 2024/11/14 18:44:28 DEBUG : two: Sizes differ (src 5 vs dst 3) 2024/11/14 18:44:28 DEBUG : two: Need to transfer - File not found at Destination 2024/11/14 18:44:28 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for checks to finish 2024/11/14 18:44:28 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/14 18:44:28 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/11/14 18:44:28 DEBUG : one: Destination found in --compare-dest, skipping 2024/11/14 18:44:28 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for transfers to finish 2024/11/14 18:44:29 DEBUG : two: sha1 = a4be8877ad88f3109a6411985a1f359e10e2d930 OK 2024/11/14 18:44:29 INFO : two: Copied (new) 2024/11/14 18:44:29 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (14.25s) === RUN TestSyncMultipleCompareDest run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:44:31 DEBUG : Creating backend with remote "TestB2:rclone-test-jaderac3cuvu/dest" 2024/11/14 18:44:33 DEBUG : Creating backend with remote "TestB2:rclone-test-jaderac3cuvu/pre-dest1" 2024/11/14 18:44:34 DEBUG : Creating backend with remote "TestB2:rclone-test-jaderac3cuvu/pre-dest2" 2024/11/14 18:44:36 DEBUG : 1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:44:36 DEBUG : 1: Destination found in --compare-dest, skipping 2024/11/14 18:44:36 DEBUG : 2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:44:36 DEBUG : 2: Destination found in --compare-dest, skipping 2024/11/14 18:44:36 DEBUG : 3: Need to transfer - File not found at Destination 2024/11/14 18:44:36 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dest: Waiting for checks to finish 2024/11/14 18:44:36 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dest: Waiting for transfers to finish 2024/11/14 18:44:37 DEBUG : 3: sha1 = 77de68daecd823babbb58edb1c8e14d7106e83bb OK 2024/11/14 18:44:37 INFO : 3: Copied (new) 2024/11/14 18:44:37 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (8.83s) === RUN TestSyncCopyDest run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:44:39 DEBUG : Creating backend with remote "TestB2:rclone-test-jaderac3cuvu/dst" 2024/11/14 18:44:40 DEBUG : Creating backend with remote "TestB2:rclone-test-jaderac3cuvu/CopyDest" 2024/11/14 18:44:42 DEBUG : one: Need to transfer - File not found at Destination 2024/11/14 18:44:42 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for checks to finish 2024/11/14 18:44:42 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for transfers to finish 2024/11/14 18:44:43 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/11/14 18:44:43 INFO : one: Copied (new) 2024/11/14 18:44:43 DEBUG : Waiting for deletions to finish 2024/11/14 18:44:44 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/14 18:44:44 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for checks to finish 2024/11/14 18:44:44 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for transfers to finish 2024/11/14 18:44:44 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2024/11/14 18:44:44 INFO : one: Copied (replaced existing) 2024/11/14 18:44:44 DEBUG : Waiting for deletions to finish 2024/11/14 18:44:46 DEBUG : Creating backend with remote "TestB2:rclone-test-jaderac3cuvu/BackupDir" 2024/11/14 18:44:47 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/14 18:44:47 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for checks to finish 2024/11/14 18:44:47 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/11/14 18:44:47 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/14 18:44:48 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/11/14 18:44:48 INFO : one: Copied (server-side copy) 2024/11/14 18:44:49 INFO : one: Deleted 2024/11/14 18:44:49 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2024/11/14 18:44:49 INFO : one: Copied (server-side copy) 2024/11/14 18:44:49 DEBUG : one: Destination found in --copy-dest, using server-side copy 2024/11/14 18:44:49 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for transfers to finish 2024/11/14 18:44:49 DEBUG : Waiting for deletions to finish 2024/11/14 18:44:51 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/11/14 18:44:51 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2024/11/14 18:44:51 INFO : two: Copied (server-side copy) 2024/11/14 18:44:51 DEBUG : two: Destination found in --copy-dest, using server-side copy 2024/11/14 18:44:51 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/11/14 18:44:51 DEBUG : one: Unchanged skipping 2024/11/14 18:44:51 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for checks to finish 2024/11/14 18:44:51 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for transfers to finish 2024/11/14 18:44:51 DEBUG : Waiting for deletions to finish 2024/11/14 18:44:51 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/11/14 18:44:51 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/11/14 18:44:51 DEBUG : two: Unchanged skipping 2024/11/14 18:44:51 DEBUG : one: Unchanged skipping 2024/11/14 18:44:51 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for checks to finish 2024/11/14 18:44:51 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for transfers to finish 2024/11/14 18:44:51 DEBUG : Waiting for deletions to finish 2024/11/14 18:44:51 INFO : There was nothing to transfer 2024/11/14 18:44:52 DEBUG : three: Sizes differ (src 7 vs dst 5) 2024/11/14 18:44:52 DEBUG : three: Destination not found in --copy-dest 2024/11/14 18:44:52 DEBUG : three: Need to transfer - File not found at Destination 2024/11/14 18:44:52 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/11/14 18:44:52 DEBUG : one: Unchanged skipping 2024/11/14 18:44:52 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for checks to finish 2024/11/14 18:44:52 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2024/11/14 18:44:52 DEBUG : two: Unchanged skipping 2024/11/14 18:44:52 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for transfers to finish 2024/11/14 18:44:53 DEBUG : three: sha1 = 370e613335f3cf2f19b2a2d35a86402f55c659f8 OK 2024/11/14 18:44:53 INFO : three: Copied (new) 2024/11/14 18:44:53 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCopyDest (16.21s) === RUN TestSyncBackupDir run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:44:57 DEBUG : Creating backend with remote "TestB2:rclone-test-jaderac3cuvu/dst" 2024/11/14 18:44:58 DEBUG : Creating backend with remote "TestB2:rclone-test-jaderac3cuvu/backup" 2024/11/14 18:45:00 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/11/14 18:45:00 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for checks to finish 2024/11/14 18:45:00 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:45:00 DEBUG : two: Unchanged skipping 2024/11/14 18:45:01 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/11/14 18:45:01 INFO : one: Copied (server-side copy) 2024/11/14 18:45:01 INFO : one: Deleted 2024/11/14 18:45:01 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for transfers to finish 2024/11/14 18:45:02 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/11/14 18:45:02 INFO : one: Copied (new) 2024/11/14 18:45:02 DEBUG : Waiting for deletions to finish 2024/11/14 18:45:02 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2024/11/14 18:45:02 INFO : three.txt: Copied (server-side copy) 2024/11/14 18:45:03 INFO : three.txt: Deleted 2024/11/14 18:45:03 INFO : three.txt: Moved into backup dir 2024/11/14 18:45:04 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/11/14 18:45:04 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:45:04 DEBUG : two: Unchanged skipping 2024/11/14 18:45:04 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for checks to finish 2024/11/14 18:45:05 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/11/14 18:45:05 INFO : one: Copied (server-side copy) 2024/11/14 18:45:05 INFO : one: Deleted 2024/11/14 18:45:05 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for transfers to finish 2024/11/14 18:45:05 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2024/11/14 18:45:05 INFO : one: Copied (new) 2024/11/14 18:45:05 DEBUG : Waiting for deletions to finish 2024/11/14 18:45:06 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/11/14 18:45:06 INFO : three.txt: Copied (server-side copy) 2024/11/14 18:45:06 INFO : three.txt: Deleted 2024/11/14 18:45:06 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (12.22s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:45:09 DEBUG : Creating backend with remote "TestB2:rclone-test-jaderac3cuvu/dst" 2024/11/14 18:45:10 DEBUG : Creating backend with remote "TestB2:rclone-test-jaderac3cuvu/backup" 2024/11/14 18:45:12 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/11/14 18:45:12 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:45:12 DEBUG : two: Unchanged skipping 2024/11/14 18:45:12 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for checks to finish 2024/11/14 18:45:13 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/11/14 18:45:13 INFO : one: Copied (server-side copy) to: one.bak 2024/11/14 18:45:13 INFO : one: Deleted 2024/11/14 18:45:13 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for transfers to finish 2024/11/14 18:45:14 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/11/14 18:45:14 INFO : one: Copied (new) 2024/11/14 18:45:14 DEBUG : Waiting for deletions to finish 2024/11/14 18:45:15 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2024/11/14 18:45:15 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/11/14 18:45:15 INFO : three.txt: Deleted 2024/11/14 18:45:15 INFO : three.txt: Moved into backup dir 2024/11/14 18:45:16 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/11/14 18:45:16 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:45:16 DEBUG : two: Unchanged skipping 2024/11/14 18:45:16 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for checks to finish 2024/11/14 18:45:17 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/11/14 18:45:17 INFO : one: Copied (server-side copy) to: one.bak 2024/11/14 18:45:18 INFO : one: Deleted 2024/11/14 18:45:18 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for transfers to finish 2024/11/14 18:45:18 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2024/11/14 18:45:18 INFO : one: Copied (new) 2024/11/14 18:45:18 DEBUG : Waiting for deletions to finish 2024/11/14 18:45:19 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/11/14 18:45:19 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/11/14 18:45:19 INFO : three.txt: Deleted 2024/11/14 18:45:19 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (12.81s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:45:22 DEBUG : Creating backend with remote "TestB2:rclone-test-jaderac3cuvu/dst" 2024/11/14 18:45:22 DEBUG : Config file has changed externally - reloading 2024/11/14 18:45:23 DEBUG : Creating backend with remote "TestB2:rclone-test-jaderac3cuvu/backup" 2024/11/14 18:45:25 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/11/14 18:45:25 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:45:25 DEBUG : two: Unchanged skipping 2024/11/14 18:45:25 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for checks to finish 2024/11/14 18:45:26 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/11/14 18:45:26 INFO : one: Copied (server-side copy) to: one-2019-01-01 2024/11/14 18:45:27 INFO : one: Deleted 2024/11/14 18:45:27 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for transfers to finish 2024/11/14 18:45:27 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/11/14 18:45:27 INFO : one: Copied (new) 2024/11/14 18:45:27 DEBUG : Waiting for deletions to finish 2024/11/14 18:45:28 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2024/11/14 18:45:28 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2024/11/14 18:45:28 INFO : three.txt: Deleted 2024/11/14 18:45:28 INFO : three.txt: Moved into backup dir 2024/11/14 18:45:29 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/11/14 18:45:29 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:45:29 DEBUG : two: Unchanged skipping 2024/11/14 18:45:29 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for checks to finish 2024/11/14 18:45:30 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/11/14 18:45:30 INFO : one: Copied (server-side copy) to: one-2019-01-01 2024/11/14 18:45:31 INFO : one: Deleted 2024/11/14 18:45:31 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for transfers to finish 2024/11/14 18:45:31 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2024/11/14 18:45:31 INFO : one: Copied (new) 2024/11/14 18:45:31 DEBUG : Waiting for deletions to finish 2024/11/14 18:45:32 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/11/14 18:45:32 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2024/11/14 18:45:32 INFO : three.txt: Deleted 2024/11/14 18:45:32 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (13.08s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:45:35 DEBUG : Creating backend with remote "TestB2:rclone-test-jaderac3cuvu/dst" 2024/11/14 18:45:37 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/11/14 18:45:37 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:45:37 DEBUG : two: Unchanged skipping 2024/11/14 18:45:37 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for checks to finish 2024/11/14 18:45:37 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/11/14 18:45:37 INFO : one: Copied (server-side copy) to: one.bak 2024/11/14 18:45:38 INFO : one: Deleted 2024/11/14 18:45:38 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for transfers to finish 2024/11/14 18:45:39 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/11/14 18:45:39 INFO : one: Copied (new) 2024/11/14 18:45:39 DEBUG : Waiting for deletions to finish 2024/11/14 18:45:40 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2024/11/14 18:45:40 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/11/14 18:45:40 INFO : three.txt: Deleted 2024/11/14 18:45:40 INFO : three.txt: Moved into backup dir 2024/11/14 18:45:41 DEBUG : one.bak: Excluded (Path Filter) 2024/11/14 18:45:41 DEBUG : three.txt.bak: Excluded (Path Filter) 2024/11/14 18:45:41 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/11/14 18:45:41 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:45:41 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for checks to finish 2024/11/14 18:45:41 DEBUG : two: Unchanged skipping 2024/11/14 18:45:42 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/11/14 18:45:42 INFO : one: Copied (server-side copy) to: one.bak 2024/11/14 18:45:42 INFO : one: Deleted 2024/11/14 18:45:42 DEBUG : B2 bucket rclone-test-jaderac3cuvu path dst: Waiting for transfers to finish 2024/11/14 18:45:42 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2024/11/14 18:45:42 INFO : one: Copied (new) 2024/11/14 18:45:42 DEBUG : Waiting for deletions to finish 2024/11/14 18:45:43 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/11/14 18:45:43 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/11/14 18:45:43 INFO : three.txt: Deleted 2024/11/14 18:45:43 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (11.44s) === RUN TestSyncSuffix run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:45:47 DEBUG : Creating backend with remote "TestB2:rclone-test-jaderac3cuvu/dst" 2024/11/14 18:45:48 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/11/14 18:45:49 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/11/14 18:45:49 INFO : one: Copied (server-side copy) to: one.bak 2024/11/14 18:45:49 INFO : one: Deleted 2024/11/14 18:45:50 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/11/14 18:45:50 INFO : one: Copied (new) 2024/11/14 18:45:50 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:45:50 DEBUG : two: Unchanged skipping 2024/11/14 18:45:50 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2024/11/14 18:45:51 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2024/11/14 18:45:51 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/11/14 18:45:52 INFO : three.txt: Deleted 2024/11/14 18:45:52 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/11/14 18:45:52 INFO : three.txt: Copied (new) 2024/11/14 18:45:53 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/11/14 18:45:53 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/11/14 18:45:53 INFO : one: Copied (server-side copy) to: one.bak 2024/11/14 18:45:54 INFO : one: Deleted 2024/11/14 18:45:54 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2024/11/14 18:45:54 INFO : one: Copied (new) 2024/11/14 18:45:54 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:45:54 DEBUG : two: Unchanged skipping 2024/11/14 18:45:54 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2024/11/14 18:45:55 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/11/14 18:45:55 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/11/14 18:45:55 INFO : three.txt: Deleted 2024/11/14 18:45:55 DEBUG : three.txt: sha1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK 2024/11/14 18:45:55 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (12.32s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:45:59 DEBUG : Creating backend with remote "TestB2:rclone-test-jaderac3cuvu/dst" 2024/11/14 18:46:00 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/11/14 18:46:02 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2024/11/14 18:46:02 INFO : one: Copied (server-side copy) to: one-2019-01-01 2024/11/14 18:46:02 INFO : one: Deleted 2024/11/14 18:46:03 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/11/14 18:46:03 INFO : one: Copied (new) 2024/11/14 18:46:03 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:03 DEBUG : two: Unchanged skipping 2024/11/14 18:46:03 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2024/11/14 18:46:04 DEBUG : three.txt: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2024/11/14 18:46:04 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2024/11/14 18:46:04 INFO : three.txt: Deleted 2024/11/14 18:46:04 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/11/14 18:46:04 INFO : three.txt: Copied (new) 2024/11/14 18:46:05 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/11/14 18:46:06 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2024/11/14 18:46:06 INFO : one: Copied (server-side copy) to: one-2019-01-01 2024/11/14 18:46:06 INFO : one: Deleted 2024/11/14 18:46:06 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2024/11/14 18:46:06 INFO : one: Copied (new) 2024/11/14 18:46:07 DEBUG : two: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:07 DEBUG : two: Unchanged skipping 2024/11/14 18:46:07 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2024/11/14 18:46:08 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2024/11/14 18:46:08 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2024/11/14 18:46:08 INFO : three.txt: Deleted 2024/11/14 18:46:08 DEBUG : three.txt: sha1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK 2024/11/14 18:46:08 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (12.85s) === RUN TestSyncUTFNorm run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:46:11 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2024/11/14 18:46:11 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:46:11 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:46:11 DEBUG : Testêé: sha1 = a54d88e06612d820bc3be72877c74f257b561b19 OK 2024/11/14 18:46:11 INFO : Testêé: Copied (replaced existing) to: Testêé 2024/11/14 18:46:11 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (2.27s) === RUN TestSyncImmutable run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:46:12 DEBUG : existing: Need to transfer - File not found at Destination 2024/11/14 18:46:12 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:46:12 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:46:13 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2024/11/14 18:46:13 INFO : existing: Copied (new) 2024/11/14 18:46:13 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:46:14 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2024/11/14 18:46:14 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:46:14 ERROR : existing: Source and destination exist but do not match: immutable file modified 2024/11/14 18:46:14 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:46:14 ERROR : B2 bucket rclone-test-jaderac3cuvu: not deleting files as there were IO errors 2024/11/14 18:46:14 ERROR : B2 bucket rclone-test-jaderac3cuvu: not deleting directories as there were IO errors run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestSyncImmutable (3.27s) === RUN TestSyncIgnoreCase run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:46:15 DEBUG : EXISTING: Clearing upload URL because of error: Post "https://pod-000-1182-17.backblaze.com/b2api/v1/b2_upload_file/1f82dde3f0ad2bbb9f380e1b/c001_v0001182_t0040": EOF 2024/11/14 18:46:15 DEBUG : pacer: low level retry 1/1 (error Post "https://pod-000-1182-17.backblaze.com/b2api/v1/b2_upload_file/1f82dde3f0ad2bbb9f380e1b/c001_v0001182_t0040": EOF) 2024/11/14 18:46:15 DEBUG : pacer: Rate limited, increasing sleep to 20ms run.go:281: Retry Put of "EXISTING" to B2 bucket rclone-test-jaderac3cuvu: 1/10 (Post "https://pod-000-1182-17.backblaze.com/b2api/v1/b2_upload_file/1f82dde3f0ad2bbb9f380e1b/c001_v0001182_t0040": EOF) 2024/11/14 18:46:18 DEBUG : pacer: Reducing sleep to 10ms 2024/11/14 18:46:18 DEBUG : existing: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:18 DEBUG : existing: Unchanged skipping 2024/11/14 18:46:18 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:46:18 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:46:18 DEBUG : Waiting for deletions to finish 2024/11/14 18:46:18 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (3.72s) === RUN TestFixCase run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" sync_test.go:2529: Skipping test as local or remote are case-sensitive --- SKIP: TestFixCase (0.38s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" sync_test.go:2568: This test only runs on local === RUN TestMaxTransfer/Soft run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" sync_test.go:2568: This test only runs on local === RUN TestMaxTransfer/Cautious run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" sync_test.go:2568: This test only runs on local --- PASS: TestMaxTransfer (1.13s) --- SKIP: TestMaxTransfer/Hard (0.38s) --- SKIP: TestMaxTransfer/Soft (0.38s) --- SKIP: TestMaxTransfer/Cautious (0.38s) === RUN TestSyncConcurrentDelete run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:46:33 DEBUG : both0: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:33 DEBUG : both1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:33 DEBUG : both10: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:33 DEBUG : both11: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:33 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:46:33 DEBUG : both0: Unchanged skipping 2024/11/14 18:46:33 DEBUG : both12: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:33 DEBUG : both12: Unchanged skipping 2024/11/14 18:46:33 DEBUG : both13: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:33 DEBUG : both13: Unchanged skipping 2024/11/14 18:46:33 DEBUG : both14: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:33 DEBUG : both14: Unchanged skipping 2024/11/14 18:46:33 DEBUG : both15: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:33 DEBUG : both15: Unchanged skipping 2024/11/14 18:46:33 DEBUG : both16: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:33 DEBUG : both16: Unchanged skipping 2024/11/14 18:46:33 DEBUG : both17: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:33 DEBUG : both17: Unchanged skipping 2024/11/14 18:46:33 DEBUG : both18: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:33 DEBUG : both18: Unchanged skipping 2024/11/14 18:46:33 DEBUG : both19: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:33 DEBUG : both19: Unchanged skipping 2024/11/14 18:46:33 DEBUG : both2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:33 DEBUG : both2: Unchanged skipping 2024/11/14 18:46:33 DEBUG : both3: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:33 DEBUG : both3: Unchanged skipping 2024/11/14 18:46:33 DEBUG : both4: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:33 DEBUG : both4: Unchanged skipping 2024/11/14 18:46:33 DEBUG : both5: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:33 DEBUG : both5: Unchanged skipping 2024/11/14 18:46:33 DEBUG : both6: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:33 DEBUG : both6: Unchanged skipping 2024/11/14 18:46:33 DEBUG : both7: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:33 DEBUG : both7: Unchanged skipping 2024/11/14 18:46:33 DEBUG : both8: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:33 DEBUG : both8: Unchanged skipping 2024/11/14 18:46:33 DEBUG : both9: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:33 DEBUG : both1: Unchanged skipping 2024/11/14 18:46:33 DEBUG : both10: Unchanged skipping 2024/11/14 18:46:33 DEBUG : both11: Unchanged skipping 2024/11/14 18:46:33 DEBUG : both9: Unchanged skipping 2024/11/14 18:46:33 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:46:33 DEBUG : Waiting for deletions to finish 2024/11/14 18:46:34 INFO : only11: Deleted 2024/11/14 18:46:34 INFO : only12: Deleted 2024/11/14 18:46:34 INFO : only19: Deleted 2024/11/14 18:46:34 INFO : only3: Deleted 2024/11/14 18:46:34 INFO : only14: Deleted 2024/11/14 18:46:34 INFO : only5: Deleted 2024/11/14 18:46:34 INFO : only0: Deleted 2024/11/14 18:46:34 INFO : only1: Deleted 2024/11/14 18:46:34 INFO : only15: Deleted 2024/11/14 18:46:34 INFO : only4: Deleted 2024/11/14 18:46:34 INFO : only18: Deleted 2024/11/14 18:46:34 INFO : only2: Deleted 2024/11/14 18:46:34 INFO : only6: Deleted 2024/11/14 18:46:34 INFO : only7: Deleted 2024/11/14 18:46:35 INFO : only9: Deleted 2024/11/14 18:46:35 INFO : only10: Deleted 2024/11/14 18:46:35 INFO : only17: Deleted 2024/11/14 18:46:35 INFO : only8: Deleted 2024/11/14 18:46:35 INFO : only13: Deleted 2024/11/14 18:46:35 INFO : only16: Deleted 2024/11/14 18:46:35 INFO : There was nothing to transfer run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestSyncConcurrentDelete (18.84s) === RUN TestSyncConcurrentTruncate run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:46:52 DEBUG : both0: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:52 DEBUG : both11: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:52 DEBUG : both1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:52 DEBUG : both10: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:52 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for checks to finish 2024/11/14 18:46:52 DEBUG : both0: Unchanged skipping 2024/11/14 18:46:52 DEBUG : both12: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:52 DEBUG : both12: Unchanged skipping 2024/11/14 18:46:52 DEBUG : both13: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:52 DEBUG : both11: Unchanged skipping 2024/11/14 18:46:52 DEBUG : both14: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:52 DEBUG : both14: Unchanged skipping 2024/11/14 18:46:52 DEBUG : both15: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:52 DEBUG : both1: Unchanged skipping 2024/11/14 18:46:52 DEBUG : both16: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:52 DEBUG : both16: Unchanged skipping 2024/11/14 18:46:52 DEBUG : both17: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:52 DEBUG : both10: Unchanged skipping 2024/11/14 18:46:52 DEBUG : both18: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:52 DEBUG : both18: Unchanged skipping 2024/11/14 18:46:52 DEBUG : both19: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:52 DEBUG : both19: Unchanged skipping 2024/11/14 18:46:52 DEBUG : both2: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:52 DEBUG : both2: Unchanged skipping 2024/11/14 18:46:52 DEBUG : both3: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:52 DEBUG : both13: Unchanged skipping 2024/11/14 18:46:52 DEBUG : both4: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:52 DEBUG : both4: Unchanged skipping 2024/11/14 18:46:52 DEBUG : both5: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:52 DEBUG : both5: Unchanged skipping 2024/11/14 18:46:52 DEBUG : both6: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:52 DEBUG : both15: Unchanged skipping 2024/11/14 18:46:52 DEBUG : both7: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:52 DEBUG : both7: Unchanged skipping 2024/11/14 18:46:52 DEBUG : both8: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:52 DEBUG : both17: Unchanged skipping 2024/11/14 18:46:52 DEBUG : both9: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2024/11/14 18:46:52 DEBUG : both9: Unchanged skipping 2024/11/14 18:46:52 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2024/11/14 18:46:52 DEBUG : both3: Unchanged skipping 2024/11/14 18:46:52 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2024/11/14 18:46:52 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2024/11/14 18:46:52 DEBUG : both6: Unchanged skipping 2024/11/14 18:46:52 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2024/11/14 18:46:52 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2024/11/14 18:46:52 DEBUG : both8: Unchanged skipping 2024/11/14 18:46:52 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2024/11/14 18:46:52 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2024/11/14 18:46:52 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2024/11/14 18:46:52 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2024/11/14 18:46:52 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2024/11/14 18:46:52 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2024/11/14 18:46:52 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2024/11/14 18:46:52 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2024/11/14 18:46:52 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2024/11/14 18:46:52 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2024/11/14 18:46:52 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2024/11/14 18:46:52 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2024/11/14 18:46:52 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2024/11/14 18:46:52 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2024/11/14 18:46:52 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2024/11/14 18:46:52 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Waiting for transfers to finish 2024/11/14 18:46:53 DEBUG : only1: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/14 18:46:53 INFO : only1: Copied (replaced existing) 2024/11/14 18:46:53 DEBUG : only10: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/14 18:46:53 INFO : only10: Copied (replaced existing) 2024/11/14 18:46:53 DEBUG : only15: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/14 18:46:53 INFO : only15: Copied (replaced existing) 2024/11/14 18:46:53 DEBUG : only16: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/14 18:46:53 INFO : only16: Copied (replaced existing) 2024/11/14 18:46:53 DEBUG : only13: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/14 18:46:53 INFO : only13: Copied (replaced existing) 2024/11/14 18:46:53 DEBUG : only17: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/14 18:46:53 INFO : only17: Copied (replaced existing) 2024/11/14 18:46:53 DEBUG : only18: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/14 18:46:53 INFO : only18: Copied (replaced existing) 2024/11/14 18:46:53 DEBUG : only19: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/14 18:46:53 INFO : only19: Copied (replaced existing) 2024/11/14 18:46:53 DEBUG : only14: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/14 18:46:53 INFO : only14: Copied (replaced existing) 2024/11/14 18:46:53 DEBUG : only2: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/14 18:46:53 INFO : only2: Copied (replaced existing) 2024/11/14 18:46:53 DEBUG : only3: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/14 18:46:53 INFO : only3: Copied (replaced existing) 2024/11/14 18:46:54 DEBUG : only4: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/14 18:46:54 INFO : only4: Copied (replaced existing) 2024/11/14 18:46:54 DEBUG : only5: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/14 18:46:54 INFO : only5: Copied (replaced existing) 2024/11/14 18:46:54 DEBUG : only6: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/14 18:46:54 INFO : only6: Copied (replaced existing) 2024/11/14 18:46:54 DEBUG : only7: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/14 18:46:54 INFO : only7: Copied (replaced existing) 2024/11/14 18:46:54 DEBUG : only8: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/14 18:46:54 INFO : only8: Copied (replaced existing) 2024/11/14 18:46:54 DEBUG : only9: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/14 18:46:54 INFO : only9: Copied (replaced existing) 2024/11/14 18:46:54 DEBUG : only0: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/14 18:46:54 INFO : only0: Copied (replaced existing) 2024/11/14 18:46:54 DEBUG : only12: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/14 18:46:54 INFO : only12: Copied (replaced existing) 2024/11/14 18:46:54 DEBUG : only11: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2024/11/14 18:46:54 INFO : only11: Copied (replaced existing) 2024/11/14 18:46:54 DEBUG : Waiting for deletions to finish run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestSyncConcurrentTruncate (23.05s) === RUN TestNothingToTransferWithEmptyDirs run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:47:02 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/11/14 18:47:02 DEBUG : sub dir: Making directory 2024/11/14 18:47:02 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestNothingToTransferWithEmptyDirs (3.05s) === RUN TestNothingToTransferWithoutEmptyDirs run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" 2024/11/14 18:47:06 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/11/14 18:47:06 DEBUG : sub dir: Making directory 2024/11/14 18:47:06 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" run.go:180: Remote "B2 bucket rclone-test-jaderac3cuvu", Local "Local file system at /tmp/rclone1983136226", Modify Window "1ms" --- PASS: TestNothingToTransferWithoutEmptyDirs (3.04s) PASS 2024/11/14 18:47:09 DEBUG : B2 bucket rclone-test-jaderac3cuvu: Purge remote 2024/11/14 18:47:09 INFO : B2 bucket rclone-test-jaderac3cuvu: cleaning bucket "rclone-test-jaderac3cuvu" of all files 2024/11/14 18:47:09 DEBUG : BackupDir/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f406360b8fa839113_d20241114_m184454_c001_v7007000_t0000_u01731609894180") 2024/11/14 18:47:09 DEBUG : BackupDir/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1147afd6f21ce5b9_d20241114_m184448_c001_v0001130_t0036_u01731609888623") 2024/11/14 18:47:09 DEBUG : CompareDest/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f415755034864fded_d20241114_m184429_c001_v7007000_t0000_u01731609869709") 2024/11/14 18:47:09 DEBUG : CompareDest/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f11764c36203b39f9_d20241114_m184423_c001_v0001182_t0022_u01731609863305") 2024/11/14 18:47:09 DEBUG : CompareDest/two: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f415755034864fdee_d20241114_m184429_c001_v7007000_t0000_u01731609869889") 2024/11/14 18:47:09 DEBUG : CompareDest/two: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521c340_d20241114_m184424_c001_v0001182_t0022_u01731609864614") 2024/11/14 18:47:09 DEBUG : CopyDest/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f406360b8fa839114_d20241114_m184454_c001_v7007000_t0000_u01731609894362") 2024/11/14 18:47:09 DEBUG : CopyDest/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b2e3_d20241114_m184445_c001_v0001105_t0018_u01731609885701") 2024/11/14 18:47:09 DEBUG : CopyDest/three: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f406360b8fa839115_d20241114_m184454_c001_v7007000_t0000_u01731609894545") 2024/11/14 18:47:10 DEBUG : CopyDest/three: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521c4da_d20241114_m184452_c001_v0001182_t0027_u01731609892288") 2024/11/14 18:47:10 DEBUG : CopyDest/two: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f406360b8fa839116_d20241114_m184454_c001_v7007000_t0000_u01731609894728") 2024/11/14 18:47:10 DEBUG : CopyDest/two: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f11764c36203b3b84_d20241114_m184450_c001_v0001182_t0031_u01731609890321") 2024/11/14 18:47:10 DEBUG : EXISTING: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f40666b2a122614d0_d20241114_m184619_c001_v7007000_t0000_u01731609979269") 2024/11/14 18:47:10 DEBUG : EXISTING: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521ca7d_d20241114_m184618_c001_v0001182_t0006_u01731609978316") 2024/11/14 18:47:10 DEBUG : Testêé: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f40666b2a122614bc_d20241114_m184612_c001_v7007000_t0000_u01731609972282") 2024/11/14 18:47:10 DEBUG : Testêé: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521ca19_d20241114_m184611_c001_v0001182_t0048_u01731609971697") 2024/11/14 18:47:10 DEBUG : Testêé: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f11764c36203b4098_d20241114_m184610_c001_v0001182_t0018_u01731609970740") 2024/11/14 18:47:10 DEBUG : a/potato2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f405b74bd864e9858_d20241114_m184237_c001_v7007000_t0000_u01731609757164") 2024/11/14 18:47:10 DEBUG : a/potato2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b1bf_d20241114_m184236_c001_v0001105_t0010_u01731609756490") 2024/11/14 18:47:10 DEBUG : a/potato2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f405b74bd864e9854_d20241114_m184234_c001_v7007000_t0000_u01731609754442") 2024/11/14 18:47:10 DEBUG : a/potato2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b1b3_d20241114_m184233_c001_v0001105_t0017_u01731609753615") 2024/11/14 18:47:10 DEBUG : a/potato2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f402d8e8c8e40f379_d20241114_m184212_c001_v7007000_t0000_u01731609732288") 2024/11/14 18:47:10 DEBUG : a/potato2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b163_d20241114_m184211_c001_v0001105_t0027_u01731609731471") 2024/11/14 18:47:10 DEBUG : b/potato: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f405b74bd864e9859_d20241114_m184237_c001_v7007000_t0000_u01731609757345") 2024/11/14 18:47:10 DEBUG : b/potato: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b1b7_d20241114_m184235_c001_v0001105_t0005_u01731609755356") 2024/11/14 18:47:10 DEBUG : b/potato: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f405b74bd864e9853_d20241114_m184233_c001_v7007000_t0000_u01731609753890") 2024/11/14 18:47:11 DEBUG : b/potato: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b1ab_d20241114_m184232_c001_v0001105_t0050_u01731609752435") 2024/11/14 18:47:11 DEBUG : b/potato: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f402d8e8c8e40f378_d20241114_m184211_c001_v7007000_t0000_u01731609731732") 2024/11/14 18:47:11 DEBUG : b/potato: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b15f_d20241114_m184210_c001_v0001105_t0044_u01731609730399") 2024/11/14 18:47:11 DEBUG : backup/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4082b5c456adc81f_d20241114_m184506_c001_v7007000_t0000_u01731609906947") 2024/11/14 18:47:11 DEBUG : backup/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f101b9c93713bb14f_d20241114_m184505_c001_v0001181_t0005_u01731609905128") 2024/11/14 18:47:11 DEBUG : backup/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1022037fe0f6f51c_d20241114_m184501_c001_v0001179_t0036_u01731609901286") 2024/11/14 18:47:11 DEBUG : backup/one-2019-01-01: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4082883d3e5f61e5_d20241114_m184532_c001_v7007000_t0000_u01731609932853") 2024/11/14 18:47:11 DEBUG : backup/one-2019-01-01: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1147b0d38df16e43_d20241114_m184530_c001_v0001116_t0040_u01731609930296") 2024/11/14 18:47:11 DEBUG : backup/one-2019-01-01: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f10392b2aae5f49d5_d20241114_m184526_c001_v0001131_t0024_u01731609926702") 2024/11/14 18:47:11 DEBUG : backup/one.bak: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e92b6_d20241114_m184519_c001_v7007000_t0000_u01731609919771") 2024/11/14 18:47:11 DEBUG : backup/one.bak: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f105a60f4736da48e_d20241114_m184517_c001_v0001117_t0024_u01731609917291") 2024/11/14 18:47:11 DEBUG : backup/one.bak: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f10184ba1586d91f0_d20241114_m184513_c001_v0001180_t0049_u01731609913615") 2024/11/14 18:47:11 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4082883d3e5f61e7_d20241114_m184533_c001_v7007000_t0000_u01731609933035") 2024/11/14 18:47:11 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f119f8a97589e1ed6_d20241114_m184531_c001_v0001106_t0014_u01731609931559") 2024/11/14 18:47:11 DEBUG : backup/three-2019-01-01.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f11096ea46d996372_d20241114_m184528_c001_v0001165_t0020_u01731609928175") 2024/11/14 18:47:11 DEBUG : backup/three.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4082b5c456adc820_d20241114_m184507_c001_v7007000_t0000_u01731609907131") 2024/11/14 18:47:11 DEBUG : backup/three.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1113aed46381164b_d20241114_m184506_c001_v0001092_t0053_u01731609906039") 2024/11/14 18:47:11 DEBUG : backup/three.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f114ae4827127f475_d20241114_m184502_c001_v0001181_t0057_u01731609902779") 2024/11/14 18:47:11 DEBUG : backup/three.txt.bak: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e92b7_d20241114_m184519_c001_v7007000_t0000_u01731609919954") 2024/11/14 18:47:11 DEBUG : backup/three.txt.bak: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1181ff6c6c730d50_d20241114_m184518_c001_v0001098_t0035_u01731609918846") 2024/11/14 18:47:12 DEBUG : backup/three.txt.bak: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f108fe402f3208edb_d20241114_m184515_c001_v0001180_t0001_u01731609915202") 2024/11/14 18:47:12 DEBUG : both0: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e76924936863_d20241114_m184655_c001_v7007000_t0000_u01731610015108") 2024/11/14 18:47:12 DEBUG : both0: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b3f1_d20241114_m184640_c001_v0001105_t0026_u01731610000354") 2024/11/14 18:47:12 DEBUG : both0: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e92ec_d20241114_m184635_c001_v7007000_t0000_u01731609995759") 2024/11/14 18:47:12 DEBUG : both0: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b3a9_d20241114_m184621_c001_v0001105_t0016_u01731609981510") 2024/11/14 18:47:12 DEBUG : both1: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e76924936864_d20241114_m184655_c001_v7007000_t0000_u01731610015290") 2024/11/14 18:47:12 DEBUG : both1: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b3f5_d20241114_m184641_c001_v0001105_t0018_u01731610001235") 2024/11/14 18:47:12 DEBUG : both1: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e92ed_d20241114_m184635_c001_v7007000_t0000_u01731609995941") 2024/11/14 18:47:12 DEBUG : both1: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b3ab_d20241114_m184622_c001_v0001105_t0054_u01731609982089") 2024/11/14 18:47:12 DEBUG : both10: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e76924936865_d20241114_m184655_c001_v7007000_t0000_u01731610015475") 2024/11/14 18:47:12 DEBUG : both10: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b411_d20241114_m184646_c001_v0001105_t0013_u01731610006366") 2024/11/14 18:47:12 DEBUG : both10: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e92ee_d20241114_m184636_c001_v7007000_t0000_u01731609996125") 2024/11/14 18:47:12 DEBUG : both10: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b3c5_d20241114_m184626_c001_v0001105_t0032_u01731609986819") 2024/11/14 18:47:12 DEBUG : both11: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e76924936866_d20241114_m184655_c001_v7007000_t0000_u01731610015660") 2024/11/14 18:47:12 DEBUG : both11: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b413_d20241114_m184646_c001_v0001105_t0037_u01731610006891") 2024/11/14 18:47:12 DEBUG : both11: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e92ef_d20241114_m184636_c001_v7007000_t0000_u01731609996308") 2024/11/14 18:47:12 DEBUG : both11: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b3c9_d20241114_m184627_c001_v0001105_t0006_u01731609987284") 2024/11/14 18:47:12 DEBUG : both12: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e76924936867_d20241114_m184655_c001_v7007000_t0000_u01731610015842") 2024/11/14 18:47:12 DEBUG : both12: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b415_d20241114_m184647_c001_v0001105_t0001_u01731610007369") 2024/11/14 18:47:12 DEBUG : both12: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e92f1_d20241114_m184636_c001_v7007000_t0000_u01731609996491") 2024/11/14 18:47:12 DEBUG : both12: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b3cf_d20241114_m184627_c001_v0001105_t0030_u01731609987838") 2024/11/14 18:47:12 DEBUG : both13: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e76924936868_d20241114_m184656_c001_v7007000_t0000_u01731610016025") 2024/11/14 18:47:13 DEBUG : both13: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b417_d20241114_m184648_c001_v0001105_t0010_u01731610008546") 2024/11/14 18:47:13 DEBUG : both13: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e92f2_d20241114_m184636_c001_v7007000_t0000_u01731609996674") 2024/11/14 18:47:13 DEBUG : both13: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b3d1_d20241114_m184628_c001_v0001105_t0040_u01731609988426") 2024/11/14 18:47:13 DEBUG : both14: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e76924936869_d20241114_m184656_c001_v7007000_t0000_u01731610016212") 2024/11/14 18:47:13 DEBUG : both14: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b41b_d20241114_m184649_c001_v0001105_t0017_u01731610009027") 2024/11/14 18:47:13 DEBUG : both14: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e92f3_d20241114_m184636_c001_v7007000_t0000_u01731609996856") 2024/11/14 18:47:13 DEBUG : both14: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b3d5_d20241114_m184629_c001_v0001105_t0003_u01731609989028") 2024/11/14 18:47:13 DEBUG : both15: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e7692493686a_d20241114_m184656_c001_v7007000_t0000_u01731610016394") 2024/11/14 18:47:13 DEBUG : both15: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b41d_d20241114_m184649_c001_v0001105_t0049_u01731610009502") 2024/11/14 18:47:13 DEBUG : both15: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e92f4_d20241114_m184637_c001_v7007000_t0000_u01731609997039") 2024/11/14 18:47:13 DEBUG : both15: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b3db_d20241114_m184629_c001_v0001105_t0057_u01731609989695") 2024/11/14 18:47:13 DEBUG : both16: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e7692493686c_d20241114_m184656_c001_v7007000_t0000_u01731610016579") 2024/11/14 18:47:13 DEBUG : both16: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b41f_d20241114_m184650_c001_v0001105_t0012_u01731610010106") 2024/11/14 18:47:13 DEBUG : both16: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e92f5_d20241114_m184637_c001_v7007000_t0000_u01731609997226") 2024/11/14 18:47:13 DEBUG : both16: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b3dd_d20241114_m184630_c001_v0001105_t0058_u01731609990399") 2024/11/14 18:47:13 DEBUG : both17: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e7692493686d_d20241114_m184656_c001_v7007000_t0000_u01731610016761") 2024/11/14 18:47:13 DEBUG : both17: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b423_d20241114_m184650_c001_v0001105_t0041_u01731610010567") 2024/11/14 18:47:13 DEBUG : both17: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e92f6_d20241114_m184637_c001_v7007000_t0000_u01731609997410") 2024/11/14 18:47:13 DEBUG : both17: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b3df_d20241114_m184631_c001_v0001105_t0001_u01731609991087") 2024/11/14 18:47:13 DEBUG : both18: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e7692493686e_d20241114_m184656_c001_v7007000_t0000_u01731610016945") 2024/11/14 18:47:13 DEBUG : both18: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b427_d20241114_m184651_c001_v0001105_t0004_u01731610011133") 2024/11/14 18:47:14 DEBUG : both18: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e92f7_d20241114_m184637_c001_v7007000_t0000_u01731609997593") 2024/11/14 18:47:14 DEBUG : both18: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b3e1_d20241114_m184631_c001_v0001105_t0003_u01731609991694") 2024/11/14 18:47:14 DEBUG : both19: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e7692493686f_d20241114_m184657_c001_v7007000_t0000_u01731610017129") 2024/11/14 18:47:14 DEBUG : both19: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b42b_d20241114_m184651_c001_v0001105_t0020_u01731610011808") 2024/11/14 18:47:14 DEBUG : both19: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e92f8_d20241114_m184637_c001_v7007000_t0000_u01731609997775") 2024/11/14 18:47:14 DEBUG : both19: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b3e3_d20241114_m184632_c001_v0001105_t0003_u01731609992445") 2024/11/14 18:47:14 DEBUG : both2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e76924936871_d20241114_m184657_c001_v7007000_t0000_u01731610017314") 2024/11/14 18:47:14 DEBUG : both2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b3fb_d20241114_m184641_c001_v0001105_t0021_u01731610001754") 2024/11/14 18:47:14 DEBUG : both2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e92f9_d20241114_m184637_c001_v7007000_t0000_u01731609997957") 2024/11/14 18:47:14 DEBUG : both2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b3b1_d20241114_m184622_c001_v0001105_t0033_u01731609982696") 2024/11/14 18:47:14 DEBUG : both3: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e76924936872_d20241114_m184657_c001_v7007000_t0000_u01731610017496") 2024/11/14 18:47:14 DEBUG : both3: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b3fd_d20241114_m184642_c001_v0001105_t0045_u01731610002373") 2024/11/14 18:47:14 DEBUG : both3: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e92fa_d20241114_m184638_c001_v7007000_t0000_u01731609998139") 2024/11/14 18:47:14 DEBUG : both3: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b3b3_d20241114_m184623_c001_v0001105_t0006_u01731609983211") 2024/11/14 18:47:14 DEBUG : both4: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e76924936873_d20241114_m184657_c001_v7007000_t0000_u01731610017678") 2024/11/14 18:47:14 DEBUG : both4: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b401_d20241114_m184643_c001_v0001105_t0004_u01731610003009") 2024/11/14 18:47:14 DEBUG : both4: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e92fb_d20241114_m184638_c001_v7007000_t0000_u01731609998324") 2024/11/14 18:47:14 DEBUG : both4: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b3b5_d20241114_m184623_c001_v0001105_t0043_u01731609983746") 2024/11/14 18:47:14 DEBUG : both5: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e76924936874_d20241114_m184657_c001_v7007000_t0000_u01731610017861") 2024/11/14 18:47:14 DEBUG : both5: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b405_d20241114_m184643_c001_v0001105_t0007_u01731610003616") 2024/11/14 18:47:15 DEBUG : both5: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e92fc_d20241114_m184638_c001_v7007000_t0000_u01731609998506") 2024/11/14 18:47:15 DEBUG : both5: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b3b7_d20241114_m184624_c001_v0001105_t0025_u01731609984341") 2024/11/14 18:47:15 DEBUG : both6: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e76924936876_d20241114_m184658_c001_v7007000_t0000_u01731610018048") 2024/11/14 18:47:15 DEBUG : both6: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b407_d20241114_m184644_c001_v0001105_t0028_u01731610004137") 2024/11/14 18:47:15 DEBUG : both6: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e92fd_d20241114_m184638_c001_v7007000_t0000_u01731609998689") 2024/11/14 18:47:15 DEBUG : both6: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b3b9_d20241114_m184624_c001_v0001105_t0036_u01731609984824") 2024/11/14 18:47:15 DEBUG : both7: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e76924936878_d20241114_m184658_c001_v7007000_t0000_u01731610018234") 2024/11/14 18:47:15 DEBUG : both7: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b409_d20241114_m184644_c001_v0001105_t0000_u01731610004639") 2024/11/14 18:47:15 DEBUG : both7: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e92fe_d20241114_m184638_c001_v7007000_t0000_u01731609998872") 2024/11/14 18:47:15 DEBUG : both7: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b3bd_d20241114_m184625_c001_v0001105_t0039_u01731609985275") 2024/11/14 18:47:15 DEBUG : both8: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e76924936879_d20241114_m184658_c001_v7007000_t0000_u01731610018419") 2024/11/14 18:47:15 DEBUG : both8: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b40b_d20241114_m184645_c001_v0001105_t0040_u01731610005265") 2024/11/14 18:47:15 DEBUG : both8: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e92ff_d20241114_m184639_c001_v7007000_t0000_u01731609999055") 2024/11/14 18:47:15 DEBUG : both8: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b3bf_d20241114_m184625_c001_v0001105_t0034_u01731609985737") 2024/11/14 18:47:15 DEBUG : both9: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e7692493687a_d20241114_m184658_c001_v7007000_t0000_u01731610018603") 2024/11/14 18:47:15 DEBUG : both9: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b40d_d20241114_m184645_c001_v0001105_t0005_u01731610005793") 2024/11/14 18:47:15 DEBUG : both9: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e9300_d20241114_m184639_c001_v7007000_t0000_u01731609999238") 2024/11/14 18:47:15 DEBUG : both9: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b3c3_d20241114_m184626_c001_v0001105_t0013_u01731609986298") 2024/11/14 18:47:15 DEBUG : c/non empty space: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f405b74bd864e985a_d20241114_m184237_c001_v7007000_t0000_u01731609757537") 2024/11/14 18:47:15 DEBUG : c/non empty space: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b1b9_d20241114_m184235_c001_v0001105_t0019_u01731609755790") 2024/11/14 18:47:16 DEBUG : c/non empty space: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f405b74bd864e9855_d20241114_m184234_c001_v7007000_t0000_u01731609754626") 2024/11/14 18:47:16 DEBUG : c/non empty space: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b1af_d20241114_m184232_c001_v0001105_t0058_u01731609752838") 2024/11/14 18:47:16 DEBUG : c/non empty space: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f402d8e8c8e40f37a_d20241114_m184212_c001_v7007000_t0000_u01731609732475") 2024/11/14 18:47:16 DEBUG : c/non empty space: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b161_d20241114_m184210_c001_v0001105_t0008_u01731609730753") 2024/11/14 18:47:16 DEBUG : check sum: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f402d8e8c8e40f35e_d20241114_m184159_c001_v7007000_t0000_u01731609719781") 2024/11/14 18:47:16 DEBUG : check sum: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b13b_d20241114_m184158_c001_v0001105_t0008_u01731609718638") 2024/11/14 18:47:16 DEBUG : dest/3: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f406360b8fa839107_d20241114_m184438_c001_v7007000_t0000_u01731609878724") 2024/11/14 18:47:16 DEBUG : dest/3: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f414f996dd43d0b5a_d20241114_m184437_c001_v0001182_t0010_u01731609877600") 2024/11/14 18:47:16 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f40666b2a122614af_d20241114_m184609_c001_v7007000_t0000_u01731609969278") 2024/11/14 18:47:16 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f11416cbb1e2f3cd4_d20241114_m184606_c001_v0001154_t0015_u01731609966703") 2024/11/14 18:47:16 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f40140e70f1780dfd_d20241114_m184606_c001_v7007000_t0000_u01731609966519") 2024/11/14 18:47:16 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f11416cbb1e2f3cd0_d20241114_m184603_c001_v0001154_t0003_u01731609963050") 2024/11/14 18:47:16 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f40140e70f1780df0_d20241114_m184602_c001_v7007000_t0000_u01731609962313") 2024/11/14 18:47:16 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f11764c36203b3fa2_d20241114_m184557_c001_v0001182_t0023_u01731609957890") 2024/11/14 18:47:16 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f404ec75e5e5c67a1_d20241114_m184556_c001_v7007000_t0000_u01731609956431") 2024/11/14 18:47:16 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f10144573cd8803b7_d20241114_m184554_c001_v0001172_t0035_u01731609954261") 2024/11/14 18:47:16 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e769249367e0_d20241114_m184554_c001_v7007000_t0000_u01731609954077") 2024/11/14 18:47:16 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f10144573cd8803ad_d20241114_m184550_c001_v0001172_t0013_u01731609950377") 2024/11/14 18:47:16 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e769249367da_d20241114_m184549_c001_v7007000_t0000_u01731609949640") 2024/11/14 18:47:16 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f11764c36203b3ec2_d20241114_m184545_c001_v0001182_t0045_u01731609945566") 2024/11/14 18:47:17 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4082883d3e5f61ed_d20241114_m184544_c001_v7007000_t0000_u01731609944290") 2024/11/14 18:47:17 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f11936c69554bef82_d20241114_m184542_c001_v0001117_t0042_u01731609942359") 2024/11/14 18:47:17 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4057c3b87f40248f_d20241114_m184542_c001_v7007000_t0000_u01731609942172") 2024/11/14 18:47:17 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f11936c69554bef78_d20241114_m184538_c001_v0001117_t0008_u01731609938802") 2024/11/14 18:47:17 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4057c3b87f40248d_d20241114_m184538_c001_v7007000_t0000_u01731609938066") 2024/11/14 18:47:17 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b347_d20241114_m184534_c001_v0001105_t0029_u01731609934131") 2024/11/14 18:47:17 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4082883d3e5f61e8_d20241114_m184533_c001_v7007000_t0000_u01731609933218") 2024/11/14 18:47:17 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f11044ed47ea062fe_d20241114_m184531_c001_v0001182_t0022_u01731609931127") 2024/11/14 18:47:17 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4093a1ce20db890d_d20241114_m184530_c001_v7007000_t0000_u01731609930942") 2024/11/14 18:47:17 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f11044ed47ea062cd_d20241114_m184527_c001_v0001182_t0027_u01731609927748") 2024/11/14 18:47:17 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4093a1ce20db890b_d20241114_m184527_c001_v7007000_t0000_u01731609927017") 2024/11/14 18:47:17 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521c668_d20241114_m184521_c001_v0001182_t0011_u01731609921055") 2024/11/14 18:47:17 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e92b8_d20241114_m184520_c001_v7007000_t0000_u01731609920137") 2024/11/14 18:47:17 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f106054d600e2242e_d20241114_m184518_c001_v0001144_t0009_u01731609918122") 2024/11/14 18:47:17 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4082b5c456adc835_d20241114_m184517_c001_v7007000_t0000_u01731609917930") 2024/11/14 18:47:17 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f106054d600e2241e_d20241114_m184514_c001_v0001144_t0019_u01731609914554") 2024/11/14 18:47:17 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4082b5c456adc82c_d20241114_m184513_c001_v7007000_t0000_u01731609913820") 2024/11/14 18:47:17 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f11764c36203b3c8c_d20241114_m184508_c001_v0001182_t0013_u01731609908243") 2024/11/14 18:47:17 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4082b5c456adc821_d20241114_m184507_c001_v7007000_t0000_u01731609907315") 2024/11/14 18:47:17 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1017922f73d88dc1_d20241114_m184505_c001_v0001113_t0035_u01731609905540") 2024/11/14 18:47:18 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f404ec75e5e5c6708_d20241114_m184505_c001_v7007000_t0000_u01731609905354") 2024/11/14 18:47:18 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1017922f73d88db9_d20241114_m184502_c001_v0001113_t0012_u01731609902250") 2024/11/14 18:47:18 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f404ec75e5e5c66e6_d20241114_m184501_c001_v7007000_t0000_u01731609901513") 2024/11/14 18:47:18 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b2f7_d20241114_m184456_c001_v0001105_t0037_u01731609896032") 2024/11/14 18:47:18 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f406360b8fa839118_d20241114_m184454_c001_v7007000_t0000_u01731609894910") 2024/11/14 18:47:18 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f11109846720891bc_d20241114_m184449_c001_v0001039_t0003_u01731609889148") 2024/11/14 18:47:18 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4136fc1be8fd2f1a_d20241114_m184448_c001_v7007000_t0000_u01731609888912") 2024/11/14 18:47:18 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521c462_d20241114_m184445_c001_v0001182_t0047_u01731609885138") 2024/11/14 18:47:18 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1160b601c87d61c1_d20241114_m184444_c001_v0001100_t0011_u01731609884295") 2024/11/14 18:47:18 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1160b601c87d61bf_d20241114_m184443_c001_v0001100_t0026_u01731609883231") 2024/11/14 18:47:18 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f415755034864fdef_d20241114_m184430_c001_v7007000_t0000_u01731609870075") 2024/11/14 18:47:18 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b2a7_d20241114_m184422_c001_v0001105_t0027_u01731609862649") 2024/11/14 18:47:18 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f101b1b7d53befc40_d20241114_m184421_c001_v0001104_t0011_u01731609861370") 2024/11/14 18:47:18 DEBUG : dst/one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f101b1b7d53befc3a_d20241114_m184420_c001_v0001104_t0051_u01731609860120") 2024/11/14 18:47:18 DEBUG : dst/one-2019-01-01: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f40666b2a122614b0_d20241114_m184609_c001_v7007000_t0000_u01731609969459") 2024/11/14 18:47:18 DEBUG : dst/one-2019-01-01: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f100891b4d1b59bb0_d20241114_m184606_c001_v0001093_t0055_u01731609966001") 2024/11/14 18:47:18 DEBUG : dst/one-2019-01-01: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f103f11ebaddad56f_d20241114_m184602_c001_v0001182_t0023_u01731609962106") 2024/11/14 18:47:18 DEBUG : dst/one.bak: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f404ec75e5e5c67a3_d20241114_m184556_c001_v7007000_t0000_u01731609956615") 2024/11/14 18:47:18 DEBUG : dst/one.bak: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f112adef954387696_d20241114_m184553_c001_v0001115_t0032_u01731609953633") 2024/11/14 18:47:18 DEBUG : dst/one.bak: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1120d6120e243a69_d20241114_m184549_c001_v0001179_t0051_u01731609949437") 2024/11/14 18:47:19 DEBUG : dst/one.bak: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4082883d3e5f61ee_d20241114_m184544_c001_v7007000_t0000_u01731609944473") 2024/11/14 18:47:19 DEBUG : dst/one.bak: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f114a37872a8da291_d20241114_m184541_c001_v0001105_t0018_u01731609941897") 2024/11/14 18:47:19 DEBUG : dst/one.bak: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f115de73059fd3740_d20241114_m184537_c001_v0001182_t0039_u01731609937865") 2024/11/14 18:47:19 DEBUG : dst/three: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f406360b8fa839119_d20241114_m184455_c001_v7007000_t0000_u01731609895092") 2024/11/14 18:47:19 DEBUG : dst/three: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1160b601c87d61c3_d20241114_m184453_c001_v0001100_t0008_u01731609893443") 2024/11/14 18:47:19 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f40666b2a122614b1_d20241114_m184609_c001_v7007000_t0000_u01731609969640") 2024/11/14 18:47:19 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f106274e186fa17d8_d20241114_m184607_c001_v0001109_t0002_u01731609967557") 2024/11/14 18:47:19 DEBUG : dst/three-2019-01-01.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f102961f20cc0c680_d20241114_m184603_c001_v0001032_t0040_u01731609963922") 2024/11/14 18:47:19 DEBUG : dst/three.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f40666b2a122614b2_d20241114_m184609_c001_v7007000_t0000_u01731609969831") 2024/11/14 18:47:19 DEBUG : dst/three.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f11416cbb1e2f3cd6_d20241114_m184608_c001_v0001154_t0023_u01731609968546") 2024/11/14 18:47:19 DEBUG : dst/three.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f40140e70f1780e05_d20241114_m184608_c001_v7007000_t0000_u01731609968362") 2024/11/14 18:47:19 DEBUG : dst/three.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f11416cbb1e2f3cd2_d20241114_m184604_c001_v0001154_t0023_u01731609964524") 2024/11/14 18:47:19 DEBUG : dst/three.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f40140e70f1780df8_d20241114_m184604_c001_v7007000_t0000_u01731609964338") 2024/11/14 18:47:19 DEBUG : dst/three.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b375_d20241114_m184559_c001_v0001105_t0043_u01731609959035") 2024/11/14 18:47:19 DEBUG : dst/three.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f404ec75e5e5c67a5_d20241114_m184556_c001_v7007000_t0000_u01731609956797") 2024/11/14 18:47:19 DEBUG : dst/three.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f10144573cd8803b9_d20241114_m184555_c001_v0001172_t0003_u01731609955518") 2024/11/14 18:47:19 DEBUG : dst/three.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e769249367e2_d20241114_m184555_c001_v7007000_t0000_u01731609955334") 2024/11/14 18:47:19 DEBUG : dst/three.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f10144573cd8803b1_d20241114_m184552_c001_v0001172_t0032_u01731609952213") 2024/11/14 18:47:19 DEBUG : dst/three.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e769249367dd_d20241114_m184552_c001_v7007000_t0000_u01731609952029") 2024/11/14 18:47:19 DEBUG : dst/three.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b35b_d20241114_m184546_c001_v0001105_t0042_u01731609946684") 2024/11/14 18:47:20 DEBUG : dst/three.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4057c3b87f402490_d20241114_m184543_c001_v7007000_t0000_u01731609943728") 2024/11/14 18:47:20 DEBUG : dst/three.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b34d_d20241114_m184541_c001_v0001105_t0023_u01731609941045") 2024/11/14 18:47:20 DEBUG : dst/three.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4057c3b87f40248e_d20241114_m184540_c001_v7007000_t0000_u01731609940315") 2024/11/14 18:47:20 DEBUG : dst/three.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521c74f_d20241114_m184535_c001_v0001182_t0050_u01731609935320") 2024/11/14 18:47:20 DEBUG : dst/three.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4093a1ce20db890e_d20241114_m184532_c001_v7007000_t0000_u01731609932291") 2024/11/14 18:47:20 DEBUG : dst/three.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521c6df_d20241114_m184529_c001_v0001182_t0019_u01731609929495") 2024/11/14 18:47:20 DEBUG : dst/three.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4093a1ce20db890c_d20241114_m184528_c001_v7007000_t0000_u01731609928404") 2024/11/14 18:47:20 DEBUG : dst/three.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f11764c36203b3d3e_d20241114_m184522_c001_v0001182_t0008_u01731609922299") 2024/11/14 18:47:20 DEBUG : dst/three.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4082b5c456adc837_d20241114_m184519_c001_v7007000_t0000_u01731609919211") 2024/11/14 18:47:20 DEBUG : dst/three.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f11764c36203b3d00_d20241114_m184516_c001_v0001182_t0027_u01731609916495") 2024/11/14 18:47:20 DEBUG : dst/three.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4082b5c456adc830_d20241114_m184515_c001_v7007000_t0000_u01731609915407") 2024/11/14 18:47:20 DEBUG : dst/three.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b317_d20241114_m184509_c001_v0001105_t0017_u01731609909021") 2024/11/14 18:47:20 DEBUG : dst/three.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f404ec75e5e5c6709_d20241114_m184506_c001_v7007000_t0000_u01731609906393") 2024/11/14 18:47:20 DEBUG : dst/three.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b30d_d20241114_m184504_c001_v0001105_t0059_u01731609904111") 2024/11/14 18:47:20 DEBUG : dst/three.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f404ec75e5e5c6707_d20241114_m184503_c001_v7007000_t0000_u01731609903012") 2024/11/14 18:47:20 DEBUG : dst/three.txt: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521c50c_d20241114_m184456_c001_v0001182_t0003_u01731609896825") 2024/11/14 18:47:20 DEBUG : dst/three.txt.bak: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f404ec75e5e5c67a6_d20241114_m184556_c001_v7007000_t0000_u01731609956979") 2024/11/14 18:47:20 DEBUG : dst/three.txt.bak: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f114f996dd43d102d_d20241114_m184555_c001_v0001182_t0051_u01731609955116") 2024/11/14 18:47:20 DEBUG : dst/three.txt.bak: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1003b7b39cf707e0_d20241114_m184551_c001_v0001144_t0017_u01731609951252") 2024/11/14 18:47:20 DEBUG : dst/three.txt.bak: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4082883d3e5f61ef_d20241114_m184544_c001_v7007000_t0000_u01731609944658") 2024/11/14 18:47:21 DEBUG : dst/three.txt.bak: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f11091bd71f476ea0_d20241114_m184543_c001_v0001116_t0001_u01731609943050") 2024/11/14 18:47:21 DEBUG : dst/three.txt.bak: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f118f029a325bf4a6_d20241114_m184539_c001_v0001109_t0038_u01731609939591") 2024/11/14 18:47:21 DEBUG : dst/two: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f40666b2a122614b5_d20241114_m184610_c001_v7007000_t0000_u01731609970013") 2024/11/14 18:47:21 DEBUG : dst/two: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521c8fd_d20241114_m184558_c001_v0001182_t0056_u01731609958460") 2024/11/14 18:47:21 DEBUG : dst/two: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f404ec75e5e5c67a8_d20241114_m184557_c001_v7007000_t0000_u01731609957161") 2024/11/14 18:47:21 DEBUG : dst/two: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521c81c_d20241114_m184546_c001_v0001182_t0010_u01731609946122") 2024/11/14 18:47:21 DEBUG : dst/two: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4082883d3e5f61f0_d20241114_m184544_c001_v7007000_t0000_u01731609944840") 2024/11/14 18:47:21 DEBUG : dst/two: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f11764c36203b3e06_d20241114_m184534_c001_v0001182_t0012_u01731609934758") 2024/11/14 18:47:21 DEBUG : dst/two: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4082883d3e5f61e9_d20241114_m184533_c001_v7007000_t0000_u01731609933402") 2024/11/14 18:47:21 DEBUG : dst/two: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b333_d20241114_m184521_c001_v0001105_t0025_u01731609921644") 2024/11/14 18:47:21 DEBUG : dst/two: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e92b9_d20241114_m184520_c001_v7007000_t0000_u01731609920318") 2024/11/14 18:47:21 DEBUG : dst/two: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521c5b8_d20241114_m184508_c001_v0001182_t0011_u01731609908812") 2024/11/14 18:47:21 DEBUG : dst/two: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4082b5c456adc822_d20241114_m184507_c001_v7007000_t0000_u01731609907506") 2024/11/14 18:47:21 DEBUG : dst/two: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f11764c36203b3bee_d20241114_m184456_c001_v0001182_t0052_u01731609896619") 2024/11/14 18:47:21 DEBUG : dst/two: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f406360b8fa83911a_d20241114_m184455_c001_v7007000_t0000_u01731609895292") 2024/11/14 18:47:21 DEBUG : dst/two: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f11764c36203b3ba2_d20241114_m184451_c001_v0001182_t0020_u01731609891136") 2024/11/14 18:47:21 DEBUG : dst/two: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f415755034864fdf0_d20241114_m184430_c001_v7007000_t0000_u01731609870257") 2024/11/14 18:47:21 DEBUG : dst/two: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f101b1b7d53befc46_d20241114_m184428_c001_v0001104_t0052_u01731609868768") 2024/11/14 18:47:21 DEBUG : empty space: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e9214_d20241114_m184347_c001_v7007000_t0000_u01731609827017") 2024/11/14 18:47:21 DEBUG : empty space: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521c0f0_d20241114_m184343_c001_v0001182_t0037_u01731609823736") 2024/11/14 18:47:22 DEBUG : empty space: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e920e_d20241114_m184341_c001_v7007000_t0000_u01731609821881") 2024/11/14 18:47:22 DEBUG : empty space: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521c035_d20241114_m184331_c001_v0001182_t0035_u01731609811540") 2024/11/14 18:47:22 DEBUG : empty space: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4105f111ddf479f5_d20241114_m184321_c001_v7007000_t0000_u01731609801722") 2024/11/14 18:47:22 DEBUG : empty space: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521bf7b_d20241114_m184318_c001_v0001182_t0007_u01731609798323") 2024/11/14 18:47:22 DEBUG : empty space: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f409715789058c2c5_d20241114_m184251_c001_v7007000_t0000_u01731609771575") 2024/11/14 18:47:22 DEBUG : empty space: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b1ef_d20241114_m184249_c001_v0001105_t0024_u01731609769737") 2024/11/14 18:47:22 DEBUG : empty space: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f409715789058c2be_d20241114_m184248_c001_v7007000_t0000_u01731609768084") 2024/11/14 18:47:22 DEBUG : empty space: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b1e5_d20241114_m184246_c001_v0001105_t0001_u01731609766753") 2024/11/14 18:47:22 DEBUG : empty space: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f409715789058c2b5_d20241114_m184243_c001_v7007000_t0000_u01731609763194") 2024/11/14 18:47:22 DEBUG : empty space: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b1cf_d20241114_m184241_c001_v0001105_t0036_u01731609761078") 2024/11/14 18:47:22 DEBUG : empty space: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f405b74bd864e985d_d20241114_m184239_c001_v7007000_t0000_u01731609759879") 2024/11/14 18:47:22 DEBUG : empty space: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b1c7_d20241114_m184238_c001_v0001105_t0033_u01731609758528") 2024/11/14 18:47:22 DEBUG : empty space: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f405b74bd864e9850_d20241114_m184231_c001_v7007000_t0000_u01731609751522") 2024/11/14 18:47:22 DEBUG : empty space: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b1a3_d20241114_m184230_c001_v0001105_t0036_u01731609750032") 2024/11/14 18:47:22 DEBUG : empty space: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f405b74bd864e984a_d20241114_m184228_c001_v7007000_t0000_u01731609748697") 2024/11/14 18:47:22 DEBUG : empty space: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b19b_d20241114_m184227_c001_v0001105_t0038_u01731609747891") 2024/11/14 18:47:22 DEBUG : empty space: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f405b74bd864e9845_d20241114_m184222_c001_v7007000_t0000_u01731609742445") 2024/11/14 18:47:22 DEBUG : empty space: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b17f_d20241114_m184220_c001_v0001105_t0058_u01731609740950") 2024/11/14 18:47:22 DEBUG : empty space: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f405b74bd864e9804_d20241114_m184218_c001_v7007000_t0000_u01731609738362") 2024/11/14 18:47:22 DEBUG : empty space: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b16f_d20241114_m184217_c001_v0001105_t0000_u01731609737207") 2024/11/14 18:47:22 DEBUG : empty space: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f402d8e8c8e40f381_d20241114_m184215_c001_v7007000_t0000_u01731609735753") 2024/11/14 18:47:23 DEBUG : empty space: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f113eda244975e486_d20241114_m184214_c001_v0001037_t0010_u01731609734777") 2024/11/14 18:47:23 DEBUG : empty space: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b167_d20241114_m184213_c001_v0001105_t0034_u01731609733207") 2024/11/14 18:47:23 DEBUG : enormous: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f409715789058c2c0_d20241114_m184250_c001_v7007000_t0000_u01731609770665") 2024/11/14 18:47:23 DEBUG : enormous: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b1f3_d20241114_m184250_c001_v0001105_t0035_u01731609770060") 2024/11/14 18:47:23 DEBUG : existing: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f40666b2a122614c2_d20241114_m184614_c001_v7007000_t0000_u01731609974799") 2024/11/14 18:47:23 DEBUG : existing: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b399_d20241114_m184613_c001_v0001105_t0049_u01731609973392") 2024/11/14 18:47:23 DEBUG : existing: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4105f111ddf479da_d20241114_m184316_c001_v7007000_t0000_u01731609796612") 2024/11/14 18:47:23 DEBUG : existing: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b231_d20241114_m184315_c001_v0001105_t0040_u01731609795569") 2024/11/14 18:47:23 DEBUG : existing: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f402d8e8c8e40f373_d20241114_m184209_c001_v7007000_t0000_u01731609729302") 2024/11/14 18:47:23 DEBUG : existing: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b157_d20241114_m184208_c001_v0001105_t0041_u01731609728308") 2024/11/14 18:47:23 DEBUG : existing: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f402d8e8c8e40f36a_d20241114_m184207_c001_v7007000_t0000_u01731609727028") 2024/11/14 18:47:23 DEBUG : existing: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b153_d20241114_m184206_c001_v0001105_t0018_u01731609726331") 2024/11/14 18:47:23 DEBUG : existing: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b151_d20241114_m184205_c001_v0001105_t0041_u01731609725512") 2024/11/14 18:47:23 DEBUG : existing-b: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4105f111ddf479dc_d20241114_m184316_c001_v7007000_t0000_u01731609796795") 2024/11/14 18:47:23 DEBUG : existing-b: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521bf44_d20241114_m184315_c001_v0001182_t0023_u01731609795577") 2024/11/14 18:47:23 DEBUG : five: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f409715789058c350_d20241114_m184256_c001_v7007000_t0000_u01731609776116") 2024/11/14 18:47:23 DEBUG : five: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4044aeb8ab31b205_d20241114_m184254_c001_v0001105_t0010_u01731609774061") 2024/11/14 18:47:23 DEBUG : foo: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f405b74bd864e9841_d20241114_m184220_c001_v7007000_t0000_u01731609740226") 2024/11/14 18:47:23 DEBUG : foo: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4044aeb8ab31b17b_d20241114_m184219_c001_v0001105_t0010_u01731609739676") 2024/11/14 18:47:23 DEBUG : foo: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4044aeb8ab31b177_d20241114_m184219_c001_v0001105_t0010_u01731609739088") 2024/11/14 18:47:23 DEBUG : four: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f409715789058c351_d20241114_m184256_c001_v7007000_t0000_u01731609776299") 2024/11/14 18:47:24 DEBUG : four: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f41764c36203b3497_d20241114_m184254_c001_v0001182_t0040_u01731609774618") 2024/11/14 18:47:24 DEBUG : four: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b201_d20241114_m184253_c001_v0001105_t0030_u01731609773343") 2024/11/14 18:47:24 DEBUG : hello world2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f404ec75e5e5c65a5_d20241114_m184133_c001_v7007000_t0000_u01731609693164") 2024/11/14 18:47:24 DEBUG : hello world2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b0f1_d20241114_m184132_c001_v0001105_t0013_u01731609692444") 2024/11/14 18:47:24 DEBUG : ignore-size: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f402d8e8c8e40f360_d20241114_m184204_c001_v7007000_t0000_u01731609724418") 2024/11/14 18:47:24 DEBUG : ignore-size: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b147_d20241114_m184203_c001_v0001105_t0025_u01731609723327") 2024/11/14 18:47:24 DEBUG : nested/sub dir/file: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4105f111ddf479cb_d20241114_m184314_c001_v7007000_t0000_u01731609794464") 2024/11/14 18:47:24 DEBUG : nested/sub dir/file: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521bf29_d20241114_m184313_c001_v0001182_t0002_u01731609793532") 2024/11/14 18:47:24 DEBUG : nested/sub dir/file: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4105f111ddf479bf_d20241114_m184312_c001_v7007000_t0000_u01731609792416") 2024/11/14 18:47:24 DEBUG : nested/sub dir/file: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521befb_d20241114_m184310_c001_v0001182_t0005_u01731609790853") 2024/11/14 18:47:24 DEBUG : one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f409715789058c352_d20241114_m184256_c001_v7007000_t0000_u01731609776486") 2024/11/14 18:47:24 DEBUG : one: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4044aeb8ab31b1fb_d20241114_m184252_c001_v0001105_t0010_u01731609772676") 2024/11/14 18:47:24 DEBUG : only0: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e7692493687c_d20241114_m184658_c001_v7007000_t0000_u01731610018785") 2024/11/14 18:47:24 DEBUG : only0: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4044aeb8ab31b43b_d20241114_m184654_c001_v0001105_t0010_u01731610014230") 2024/11/14 18:47:24 DEBUG : only0: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521cc3e_d20241114_m184641_c001_v0001182_t0003_u01731610001003") 2024/11/14 18:47:24 DEBUG : only0: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f400c20a411688081_d20241114_m184634_c001_v7007000_t0000_u01731609994561") 2024/11/14 18:47:24 DEBUG : only0: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521cabf_d20241114_m184621_c001_v0001182_t0027_u01731609981835") 2024/11/14 18:47:24 DEBUG : only1: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e7692493687d_d20241114_m184658_c001_v7007000_t0000_u01731610018967") 2024/11/14 18:47:24 DEBUG : only1: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4044aeb8ab31b42f_d20241114_m184653_c001_v0001105_t0010_u01731610013081") 2024/11/14 18:47:24 DEBUG : only1: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521cc44_d20241114_m184641_c001_v0001182_t0053_u01731610001548") 2024/11/14 18:47:25 DEBUG : only1: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e92e8_d20241114_m184634_c001_v7007000_t0000_u01731609994577") 2024/11/14 18:47:25 DEBUG : only1: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521cacd_d20241114_m184622_c001_v0001182_t0043_u01731609982490") 2024/11/14 18:47:25 DEBUG : only10: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e7692493687e_d20241114_m184659_c001_v7007000_t0000_u01731610019153") 2024/11/14 18:47:25 DEBUG : only10: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4047781b0521cd3a_d20241114_m184653_c001_v0001182_t0014_u01731610013089") 2024/11/14 18:47:25 DEBUG : only10: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521ccc0_d20241114_m184646_c001_v0001182_t0036_u01731610006654") 2024/11/14 18:47:25 DEBUG : only10: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e92ea_d20241114_m184634_c001_v7007000_t0000_u01731609994946") 2024/11/14 18:47:25 DEBUG : only10: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521cb39_d20241114_m184627_c001_v0001182_t0027_u01731609987080") 2024/11/14 18:47:25 DEBUG : only11: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e7692493687f_d20241114_m184659_c001_v7007000_t0000_u01731610019345") 2024/11/14 18:47:25 DEBUG : only11: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f417563a19f86cecf_d20241114_m184654_c001_v0001036_t0029_u01731610014397") 2024/11/14 18:47:25 DEBUG : only11: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521ccca_d20241114_m184647_c001_v0001182_t0010_u01731610007167") 2024/11/14 18:47:25 DEBUG : only11: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f400c20a41168807e_d20241114_m184634_c001_v7007000_t0000_u01731609994008") 2024/11/14 18:47:25 DEBUG : only11: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521cb41_d20241114_m184627_c001_v0001182_t0038_u01731609987639") 2024/11/14 18:47:25 DEBUG : only12: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e76924936880_d20241114_m184659_c001_v7007000_t0000_u01731610019528") 2024/11/14 18:47:25 DEBUG : only12: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4047781b0521cd52_d20241114_m184654_c001_v0001182_t0014_u01731610014239") 2024/11/14 18:47:25 DEBUG : only12: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521ccde_d20241114_m184648_c001_v0001182_t0022_u01731610008340") 2024/11/14 18:47:25 DEBUG : only12: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f400c20a41168807f_d20241114_m184634_c001_v7007000_t0000_u01731609994191") 2024/11/14 18:47:25 DEBUG : only12: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521cb47_d20241114_m184628_c001_v0001182_t0021_u01731609988094") 2024/11/14 18:47:25 DEBUG : only13: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e76924936881_d20241114_m184659_c001_v7007000_t0000_u01731610019712") 2024/11/14 18:47:25 DEBUG : only13: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f417563a19f86cec7_d20241114_m184653_c001_v0001036_t0029_u01731610013660") 2024/11/14 18:47:25 DEBUG : only13: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521cce4_d20241114_m184648_c001_v0001182_t0017_u01731610008824") 2024/11/14 18:47:26 DEBUG : only13: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f400c20a411688084_d20241114_m184635_c001_v7007000_t0000_u01731609995114") 2024/11/14 18:47:26 DEBUG : only13: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521cb59_d20241114_m184628_c001_v0001182_t0028_u01731609988828") 2024/11/14 18:47:26 DEBUG : only14: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e76924936882_d20241114_m184659_c001_v7007000_t0000_u01731610019896") 2024/11/14 18:47:26 DEBUG : only14: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f410b1b78a7bc3c98_d20241114_m184653_c001_v0001130_t0030_u01731610013845") 2024/11/14 18:47:26 DEBUG : only14: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521ccec_d20241114_m184649_c001_v0001182_t0059_u01731610009281") 2024/11/14 18:47:26 DEBUG : only14: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4070de570cc58c6a_d20241114_m184634_c001_v7007000_t0000_u01731609994379") 2024/11/14 18:47:26 DEBUG : only14: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521cb65_d20241114_m184629_c001_v0001182_t0039_u01731609989489") 2024/11/14 18:47:26 DEBUG : only15: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e76924936883_d20241114_m184700_c001_v7007000_t0000_u01731610020078") 2024/11/14 18:47:26 DEBUG : only15: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4044aeb8ab31b431_d20241114_m184653_c001_v0001105_t0010_u01731610013487") 2024/11/14 18:47:26 DEBUG : only15: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521ccf2_d20241114_m184649_c001_v0001182_t0017_u01731610009892") 2024/11/14 18:47:26 DEBUG : only15: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4070de570cc58c6b_d20241114_m184634_c001_v7007000_t0000_u01731609994582") 2024/11/14 18:47:26 DEBUG : only15: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521cb6f_d20241114_m184630_c001_v0001182_t0052_u01731609990193") 2024/11/14 18:47:26 DEBUG : only16: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e76924936885_d20241114_m184700_c001_v7007000_t0000_u01731610020261") 2024/11/14 18:47:26 DEBUG : only16: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4047781b0521cd40_d20241114_m184653_c001_v0001182_t0014_u01731610013495") 2024/11/14 18:47:26 DEBUG : only16: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521ccfe_d20241114_m184650_c001_v0001182_t0022_u01731610010359") 2024/11/14 18:47:26 DEBUG : only16: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e92eb_d20241114_m184635_c001_v7007000_t0000_u01731609995128") 2024/11/14 18:47:26 DEBUG : only16: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521cb7b_d20241114_m184630_c001_v0001182_t0018_u01731609990888") 2024/11/14 18:47:26 DEBUG : only17: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e76924936887_d20241114_m184700_c001_v7007000_t0000_u01731610020444") 2024/11/14 18:47:26 DEBUG : only17: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4044aeb8ab31b433_d20241114_m184653_c001_v0001105_t0010_u01731610013668") 2024/11/14 18:47:26 DEBUG : only17: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521cd0e_d20241114_m184650_c001_v0001182_t0029_u01731610010916") 2024/11/14 18:47:27 DEBUG : only17: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4070de570cc58c6d_d20241114_m184634_c001_v7007000_t0000_u01731609994952") 2024/11/14 18:47:27 DEBUG : only17: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521cb8b_d20241114_m184631_c001_v0001182_t0041_u01731609991487") 2024/11/14 18:47:27 DEBUG : only18: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e76924936888_d20241114_m184700_c001_v7007000_t0000_u01731610020628") 2024/11/14 18:47:27 DEBUG : only18: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4047781b0521cd44_d20241114_m184653_c001_v0001182_t0014_u01731610013678") 2024/11/14 18:47:27 DEBUG : only18: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521cd1a_d20241114_m184651_c001_v0001182_t0035_u01731610011605") 2024/11/14 18:47:27 DEBUG : only18: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f400c20a411688082_d20241114_m184634_c001_v7007000_t0000_u01731609994745") 2024/11/14 18:47:27 DEBUG : only18: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521cb95_d20241114_m184632_c001_v0001182_t0001_u01731609992162") 2024/11/14 18:47:27 DEBUG : only19: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e76924936889_d20241114_m184700_c001_v7007000_t0000_u01731610020811") 2024/11/14 18:47:27 DEBUG : only19: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f417563a19f86cec9_d20241114_m184653_c001_v0001036_t0029_u01731610013847") 2024/11/14 18:47:27 DEBUG : only19: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521cd26_d20241114_m184652_c001_v0001182_t0027_u01731610012114") 2024/11/14 18:47:27 DEBUG : only19: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f400c20a411688080_d20241114_m184634_c001_v7007000_t0000_u01731609994378") 2024/11/14 18:47:27 DEBUG : only19: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521cb9d_d20241114_m184632_c001_v0001182_t0015_u01731609992813") 2024/11/14 18:47:27 DEBUG : only2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e7692493688a_d20241114_m184700_c001_v7007000_t0000_u01731610020994") 2024/11/14 18:47:27 DEBUG : only2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4044aeb8ab31b435_d20241114_m184653_c001_v0001105_t0010_u01731610013855") 2024/11/14 18:47:27 DEBUG : only2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521cc5c_d20241114_m184642_c001_v0001182_t0023_u01731610002174") 2024/11/14 18:47:27 DEBUG : only2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e92e9_d20241114_m184634_c001_v7007000_t0000_u01731609994763") 2024/11/14 18:47:27 DEBUG : only2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521cae7_d20241114_m184623_c001_v0001182_t0051_u01731609983010") 2024/11/14 18:47:27 DEBUG : only3: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e7692493688b_d20241114_m184701_c001_v7007000_t0000_u01731610021177") 2024/11/14 18:47:27 DEBUG : only3: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4047781b0521cd4c_d20241114_m184653_c001_v0001182_t0014_u01731610013863") 2024/11/14 18:47:27 DEBUG : only3: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521cc6d_d20241114_m184642_c001_v0001182_t0016_u01731610002796") 2024/11/14 18:47:28 DEBUG : only3: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e92e7_d20241114_m184634_c001_v7007000_t0000_u01731609994394") 2024/11/14 18:47:28 DEBUG : only3: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521caed_d20241114_m184623_c001_v0001182_t0018_u01731609983534") 2024/11/14 18:47:28 DEBUG : only4: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e7692493688c_d20241114_m184701_c001_v7007000_t0000_u01731610021362") 2024/11/14 18:47:28 DEBUG : only4: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f417563a19f86cecb_d20241114_m184654_c001_v0001036_t0029_u01731610014029") 2024/11/14 18:47:28 DEBUG : only4: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521cc7e_d20241114_m184643_c001_v0001182_t0040_u01731610003407") 2024/11/14 18:47:28 DEBUG : only4: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4030058bbe5736aa_d20241114_m184634_c001_v7007000_t0000_u01731609994599") 2024/11/14 18:47:28 DEBUG : only4: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521caf9_d20241114_m184624_c001_v0001182_t0015_u01731609984128") 2024/11/14 18:47:28 DEBUG : only5: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e7692493688e_d20241114_m184701_c001_v7007000_t0000_u01731610021544") 2024/11/14 18:47:28 DEBUG : only5: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f410b1b78a7bc3c9a_d20241114_m184654_c001_v0001130_t0030_u01731610014038") 2024/11/14 18:47:28 DEBUG : only5: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521cc8c_d20241114_m184643_c001_v0001182_t0037_u01731610003939") 2024/11/14 18:47:28 DEBUG : only5: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4030058bbe5736a9_d20241114_m184634_c001_v7007000_t0000_u01731609994416") 2024/11/14 18:47:28 DEBUG : only5: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521cb05_d20241114_m184624_c001_v0001182_t0015_u01731609984611") 2024/11/14 18:47:28 DEBUG : only6: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e7692493688f_d20241114_m184701_c001_v7007000_t0000_u01731610021726") 2024/11/14 18:47:28 DEBUG : only6: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4044aeb8ab31b437_d20241114_m184654_c001_v0001105_t0010_u01731610014048") 2024/11/14 18:47:28 DEBUG : only6: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521cc96_d20241114_m184644_c001_v0001182_t0008_u01731610004441") 2024/11/14 18:47:28 DEBUG : only6: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4070de570cc58c6c_d20241114_m184634_c001_v7007000_t0000_u01731609994769") 2024/11/14 18:47:28 DEBUG : only6: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521cb13_d20241114_m184625_c001_v0001182_t0027_u01731609985058") 2024/11/14 18:47:28 DEBUG : only7: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e76924936891_d20241114_m184701_c001_v7007000_t0000_u01731610021910") 2024/11/14 18:47:28 DEBUG : only7: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4047781b0521cd4e_d20241114_m184654_c001_v0001182_t0014_u01731610014056") 2024/11/14 18:47:28 DEBUG : only7: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521cca2_d20241114_m184645_c001_v0001182_t0007_u01731610005060") 2024/11/14 18:47:29 DEBUG : only7: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4030058bbe5736ab_d20241114_m184634_c001_v7007000_t0000_u01731609994783") 2024/11/14 18:47:29 DEBUG : only7: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521cb1b_d20241114_m184625_c001_v0001182_t0034_u01731609985540") 2024/11/14 18:47:29 DEBUG : only8: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e76924936893_d20241114_m184702_c001_v7007000_t0000_u01731610022094") 2024/11/14 18:47:29 DEBUG : only8: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f417563a19f86cecd_d20241114_m184654_c001_v0001036_t0029_u01731610014213") 2024/11/14 18:47:29 DEBUG : only8: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521ccaa_d20241114_m184645_c001_v0001182_t0023_u01731610005594") 2024/11/14 18:47:29 DEBUG : only8: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4030058bbe5736ad_d20241114_m184634_c001_v7007000_t0000_u01731609994967") 2024/11/14 18:47:29 DEBUG : only8: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521cb25_d20241114_m184626_c001_v0001182_t0014_u01731609986071") 2024/11/14 18:47:29 DEBUG : only9: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e76924936894_d20241114_m184702_c001_v7007000_t0000_u01731610022279") 2024/11/14 18:47:29 DEBUG : only9: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f410b1b78a7bc3c9c_d20241114_m184654_c001_v0001130_t0030_u01731610014221") 2024/11/14 18:47:29 DEBUG : only9: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521ccba_d20241114_m184646_c001_v0001182_t0057_u01731610006153") 2024/11/14 18:47:29 DEBUG : only9: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f400c20a411688083_d20241114_m184634_c001_v7007000_t0000_u01731609994930") 2024/11/14 18:47:29 DEBUG : only9: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521cb33_d20241114_m184626_c001_v0001182_t0024_u01731609986599") 2024/11/14 18:47:29 DEBUG : potato: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f409715789058c367_d20241114_m184309_c001_v7007000_t0000_u01731609789015") 2024/11/14 18:47:29 DEBUG : potato: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f11764c36203b356a_d20241114_m184307_c001_v0001182_t0025_u01731609787468") 2024/11/14 18:47:29 DEBUG : potato: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f409715789058c35f_d20241114_m184305_c001_v7007000_t0000_u01731609785629") 2024/11/14 18:47:29 DEBUG : potato: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b217_d20241114_m184303_c001_v0001105_t0008_u01731609783570") 2024/11/14 18:47:29 DEBUG : potato: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f409715789058c35a_d20241114_m184301_c001_v7007000_t0000_u01731609781733") 2024/11/14 18:47:29 DEBUG : potato: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f11764c36203b34d7_d20241114_m184257_c001_v0001182_t0016_u01731609777409") 2024/11/14 18:47:29 DEBUG : potato: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f409715789058c2b9_d20241114_m184245_c001_v7007000_t0000_u01731609765556") 2024/11/14 18:47:29 DEBUG : potato: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b1d7_d20241114_m184244_c001_v0001105_t0047_u01731609764110") 2024/11/14 18:47:29 DEBUG : potato: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f405b74bd864e9862_d20241114_m184241_c001_v7007000_t0000_u01731609761706") 2024/11/14 18:47:30 DEBUG : potato: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b1cd_d20241114_m184240_c001_v0001105_t0021_u01731609760790") 2024/11/14 18:47:30 DEBUG : potato: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f405b74bd864e985b_d20241114_m184239_c001_v7007000_t0000_u01731609759153") 2024/11/14 18:47:30 DEBUG : potato: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b1c5_d20241114_m184238_c001_v0001105_t0017_u01731609758268") 2024/11/14 18:47:30 DEBUG : potato: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f405b74bd864e984e_d20241114_m184230_c001_v7007000_t0000_u01731609750971") 2024/11/14 18:47:30 DEBUG : potato: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b1a1_d20241114_m184229_c001_v0001105_t0002_u01731609749604") 2024/11/14 18:47:30 DEBUG : potato: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f405b74bd864e984c_d20241114_m184228_c001_v7007000_t0000_u01731609748879") 2024/11/14 18:47:30 DEBUG : potato: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b197_d20241114_m184227_c001_v0001105_t0016_u01731609747562") 2024/11/14 18:47:30 DEBUG : potato: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f405b74bd864e9848_d20241114_m184226_c001_v7007000_t0000_u01731609746833") 2024/11/14 18:47:30 DEBUG : potato: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b195_d20241114_m184226_c001_v0001105_t0054_u01731609746091") 2024/11/14 18:47:30 DEBUG : potato: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b191_d20241114_m184225_c001_v0001105_t0021_u01731609745472") 2024/11/14 18:47:30 DEBUG : potato: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f405b74bd864e9847_d20241114_m184224_c001_v7007000_t0000_u01731609744743") 2024/11/14 18:47:30 DEBUG : potato: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b18d_d20241114_m184224_c001_v0001105_t0037_u01731609744158") 2024/11/14 18:47:30 DEBUG : potato: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b189_d20241114_m184223_c001_v0001105_t0044_u01731609743351") 2024/11/14 18:47:30 DEBUG : potato: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f405b74bd864e9846_d20241114_m184222_c001_v7007000_t0000_u01731609742627") 2024/11/14 18:47:30 DEBUG : potato: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b183_d20241114_m184221_c001_v0001105_t0000_u01731609741715") 2024/11/14 18:47:30 DEBUG : potato2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f40666b2a12261307_d20241114_m184357_c001_v7007000_t0000_u01731609837344") 2024/11/14 18:47:30 DEBUG : potato2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f11764c36203b3881_d20241114_m184356_c001_v0001182_t0006_u01731609836771") 2024/11/14 18:47:30 DEBUG : potato2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e9215_d20241114_m184347_c001_v7007000_t0000_u01731609827362") 2024/11/14 18:47:30 DEBUG : potato2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f11764c36203b37bb_d20241114_m184343_c001_v0001182_t0042_u01731609823161") 2024/11/14 18:47:31 DEBUG : potato2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f402d8e8c8e40f411_d20241114_m184335_c001_v7007000_t0000_u01731609815294") 2024/11/14 18:47:31 DEBUG : potato2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f11764c36203b36fc_d20241114_m184330_c001_v0001182_t0056_u01731609810977") 2024/11/14 18:47:31 DEBUG : potato2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4105f111ddf479f7_d20241114_m184322_c001_v7007000_t0000_u01731609802062") 2024/11/14 18:47:31 DEBUG : potato2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f11764c36203b363c_d20241114_m184318_c001_v0001182_t0049_u01731609798109") 2024/11/14 18:47:31 DEBUG : potato2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f409715789058c2c1_d20241114_m184250_c001_v7007000_t0000_u01731609770847") 2024/11/14 18:47:31 DEBUG : potato2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b1ed_d20241114_m184249_c001_v0001105_t0006_u01731609769358") 2024/11/14 18:47:31 DEBUG : potato2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f409715789058c2bf_d20241114_m184248_c001_v7007000_t0000_u01731609768270") 2024/11/14 18:47:31 DEBUG : potato2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b1e3_d20241114_m184246_c001_v0001105_t0041_u01731609766464") 2024/11/14 18:47:31 DEBUG : potato2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f409715789058c2ba_d20241114_m184245_c001_v7007000_t0000_u01731609765738") 2024/11/14 18:47:31 DEBUG : potato2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b1dd_d20241114_m184244_c001_v0001105_t0014_u01731609764836") 2024/11/14 18:47:31 DEBUG : potato2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f409715789058c2b6_d20241114_m184243_c001_v7007000_t0000_u01731609763374") 2024/11/14 18:47:31 DEBUG : potato2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b1d5_d20241114_m184242_c001_v0001105_t0023_u01731609762073") 2024/11/14 18:47:31 DEBUG : potato2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f405b74bd864e985e_d20241114_m184240_c001_v7007000_t0000_u01731609760063") 2024/11/14 18:47:31 DEBUG : potato2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b1c9_d20241114_m184239_c001_v0001105_t0008_u01731609759161") 2024/11/14 18:47:31 DEBUG : potato2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f405b74bd864e9851_d20241114_m184231_c001_v7007000_t0000_u01731609751704") 2024/11/14 18:47:31 DEBUG : potato2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b1a7_d20241114_m184230_c001_v0001105_t0044_u01731609750649") 2024/11/14 18:47:31 DEBUG : potato2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f404ec75e5e5c65aa_d20241114_m184136_c001_v7007000_t0000_u01731609696763") 2024/11/14 18:47:31 DEBUG : potato2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b0fd_d20241114_m184136_c001_v0001105_t0030_u01731609696120") 2024/11/14 18:47:31 DEBUG : potato2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f404ec75e5e5c65a6_d20241114_m184134_c001_v7007000_t0000_u01731609694843") 2024/11/14 18:47:32 DEBUG : potato2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b0f9_d20241114_m184134_c001_v0001105_t0054_u01731609694075") 2024/11/14 18:47:32 DEBUG : potato3: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4163521dcd0e9217_d20241114_m184347_c001_v7007000_t0000_u01731609827778") 2024/11/14 18:47:32 DEBUG : potato3: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b263_d20241114_m184344_c001_v0001105_t0026_u01731609824302") 2024/11/14 18:47:32 DEBUG : potato3: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f402d8e8c8e40f412_d20241114_m184335_c001_v7007000_t0000_u01731609815727") 2024/11/14 18:47:32 DEBUG : potato3: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b249_d20241114_m184332_c001_v0001105_t0039_u01731609812108") 2024/11/14 18:47:32 DEBUG : potato3: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4105f111ddf479f9_d20241114_m184322_c001_v7007000_t0000_u01731609802330") 2024/11/14 18:47:32 DEBUG : potato3: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b235_d20241114_m184318_c001_v0001105_t0056_u01731609798534") 2024/11/14 18:47:32 DEBUG : pre-dest1/1: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f406360b8fa839108_d20241114_m184438_c001_v7007000_t0000_u01731609878906") 2024/11/14 18:47:32 DEBUG : pre-dest1/1: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b2bd_d20241114_m184430_c001_v0001105_t0033_u01731609870986") 2024/11/14 18:47:32 DEBUG : pre-dest2/2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f406360b8fa839109_d20241114_m184439_c001_v7007000_t0000_u01731609879088") 2024/11/14 18:47:32 DEBUG : pre-dest2/2: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f11764c36203b3a8b_d20241114_m184431_c001_v0001182_t0056_u01731609871653") 2024/11/14 18:47:32 DEBUG : rclone-sync-test-ignore-file/.ignore: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f415755034864fdc5_d20241114_m184409_c001_v7007000_t0000_u01731609849763") 2024/11/14 18:47:32 DEBUG : rclone-sync-test-ignore-file/.ignore: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521c238_d20241114_m184406_c001_v0001182_t0030_u01731609846770") 2024/11/14 18:47:32 DEBUG : sizeonly: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f402d8e8c8e40f35f_d20241114_m184202_c001_v7007000_t0000_u01731609722045") 2024/11/14 18:47:32 DEBUG : sizeonly: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b143_d20241114_m184201_c001_v0001105_t0034_u01731609721066") 2024/11/14 18:47:32 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e769249368a3_d20241114_m184707_c001_v7007000_t0000_u01731610027800") 2024/11/14 18:47:32 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521ce32_d20241114_m184706_c001_v0001182_t0019_u01731610026660") 2024/11/14 18:47:32 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e7692493689c_d20241114_m184704_c001_v7007000_t0000_u01731610024763") 2024/11/14 18:47:32 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f110b1b78a7bc3cb0_d20241114_m184703_c001_v0001130_t0059_u01731610023613") 2024/11/14 18:47:32 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4105f111ddf479cd_d20241114_m184314_c001_v7007000_t0000_u01731609794647") 2024/11/14 18:47:32 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f11764c36203b35f4_d20241114_m184313_c001_v0001182_t0017_u01731609793889") 2024/11/14 18:47:33 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4105f111ddf479c0_d20241114_m184312_c001_v7007000_t0000_u01731609792599") 2024/11/14 18:47:33 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b225_d20241114_m184311_c001_v0001105_t0000_u01731609791203") 2024/11/14 18:47:33 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f402d8e8c8e40f35d_d20241114_m184157_c001_v7007000_t0000_u01731609717717") 2024/11/14 18:47:33 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b133_d20241114_m184156_c001_v0001105_t0004_u01731609716150") 2024/11/14 18:47:33 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f402d8e8c8e40f34b_d20241114_m184155_c001_v7007000_t0000_u01731609715419") 2024/11/14 18:47:33 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b12f_d20241114_m184154_c001_v0001105_t0027_u01731609714379") 2024/11/14 18:47:33 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f402d8e8c8e40f34a_d20241114_m184153_c001_v7007000_t0000_u01731609713257") 2024/11/14 18:47:33 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b121_d20241114_m184147_c001_v0001105_t0057_u01731609707556") 2024/11/14 18:47:33 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f402d8e8c8e40f343_d20241114_m184147_c001_v7007000_t0000_u01731609707191") 2024/11/14 18:47:33 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b11b_d20241114_m184146_c001_v0001105_t0051_u01731609706380") 2024/11/14 18:47:33 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f404ec75e5e5c65b7_d20241114_m184144_c001_v7007000_t0000_u01731609704721") 2024/11/14 18:47:33 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b115_d20241114_m184143_c001_v0001105_t0056_u01731609703894") 2024/11/14 18:47:33 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f404ec75e5e5c65b5_d20241114_m184143_c001_v7007000_t0000_u01731609703350") 2024/11/14 18:47:33 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b111_d20241114_m184142_c001_v0001105_t0040_u01731609702658") 2024/11/14 18:47:33 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f404ec75e5e5c65b3_d20241114_m184141_c001_v7007000_t0000_u01731609701387") 2024/11/14 18:47:33 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b10b_d20241114_m184140_c001_v0001105_t0028_u01731609700548") 2024/11/14 18:47:33 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f404ec75e5e5c65b1_d20241114_m184140_c001_v7007000_t0000_u01731609700001") 2024/11/14 18:47:33 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b109_d20241114_m184139_c001_v0001105_t0015_u01731609699279") 2024/11/14 18:47:33 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f404ec75e5e5c65ae_d20241114_m184138_c001_v7007000_t0000_u01731609698362") 2024/11/14 18:47:33 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b105_d20241114_m184137_c001_v0001105_t0012_u01731609697671") 2024/11/14 18:47:34 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f404ec75e5e5c65a2_d20241114_m184131_c001_v7007000_t0000_u01731609691538") 2024/11/14 18:47:34 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b0eb_d20241114_m184130_c001_v0001105_t0045_u01731609690725") 2024/11/14 18:47:34 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f404ec75e5e5c659b_d20241114_m184129_c001_v7007000_t0000_u01731609689820") 2024/11/14 18:47:34 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b0e7_d20241114_m184129_c001_v0001105_t0003_u01731609689015") 2024/11/14 18:47:34 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f404ec75e5e5c6596_d20241114_m184128_c001_v7007000_t0000_u01731609688107") 2024/11/14 18:47:34 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b0dd_d20241114_m184127_c001_v0001105_t0027_u01731609687463") 2024/11/14 18:47:34 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f404ec75e5e5c658e_d20241114_m184124_c001_v7007000_t0000_u01731609684556") 2024/11/14 18:47:34 DEBUG : sub dir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b0d7_d20241114_m184123_c001_v0001105_t0049_u01731609683863") 2024/11/14 18:47:34 DEBUG : sub dir2/very/very/very/very/very/nested/subdir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e769249368a4_d20241114_m184707_c001_v7007000_t0000_u01731610027984") 2024/11/14 18:47:34 DEBUG : sub dir2/very/very/very/very/very/nested/subdir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f117563a19f86ced5_d20241114_m184706_c001_v0001036_t0038_u01731610026685") 2024/11/14 18:47:34 DEBUG : sub dir2/very/very/very/very/very/nested/subdir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4036e7692493689d_d20241114_m184704_c001_v7007000_t0000_u01731610024947") 2024/11/14 18:47:34 DEBUG : sub dir2/very/very/very/very/very/nested/subdir/hello world: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b44f_d20241114_m184703_c001_v0001105_t0016_u01731610023614") 2024/11/14 18:47:34 DEBUG : sub/yam: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f409715789058c365_d20241114_m184308_c001_v7007000_t0000_u01731609788469") 2024/11/14 18:47:34 DEBUG : sub/yam: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521bebf_d20241114_m184307_c001_v0001182_t0047_u01731609787105") 2024/11/14 18:47:34 DEBUG : three: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f409715789058c353_d20241114_m184256_c001_v7007000_t0000_u01731609776667") 2024/11/14 18:47:34 DEBUG : three: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b20b_d20241114_m184255_c001_v0001105_t0048_u01731609775368") 2024/11/14 18:47:34 DEBUG : three: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1044aeb8ab31b1ff_d20241114_m184253_c001_v0001105_t0023_u01731609773052") 2024/11/14 18:47:34 DEBUG : two: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f409715789058c355_d20241114_m184256_c001_v7007000_t0000_u01731609776848") 2024/11/14 18:47:34 DEBUG : two: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4047781b0521be04_d20241114_m184254_c001_v0001182_t0014_u01731609774804") 2024/11/14 18:47:34 DEBUG : two: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f4044aeb8ab31b1fd_d20241114_m184252_c001_v0001105_t0010_u01731609772869") 2024/11/14 18:47:35 DEBUG : yam: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f409715789058c368_d20241114_m184309_c001_v7007000_t0000_u01731609789198") 2024/11/14 18:47:35 DEBUG : yam: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f119130064319ef2b_d20241114_m184308_c001_v0001178_t0059_u01731609788245") 2024/11/14 18:47:35 DEBUG : yam: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f409715789058c35e_d20241114_m184305_c001_v7007000_t0000_u01731609785077") 2024/11/14 18:47:35 DEBUG : yam: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521be90_d20241114_m184303_c001_v0001182_t0035_u01731609783575") 2024/11/14 18:47:35 DEBUG : yam: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f409715789058c359_d20241114_m184301_c001_v7007000_t0000_u01731609781184") 2024/11/14 18:47:35 DEBUG : yam: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1047781b0521be32_d20241114_m184257_c001_v0001182_t0037_u01731609777421") 2024/11/14 18:47:35 DEBUG : yaml: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f409715789058c360_d20241114_m184305_c001_v7007000_t0000_u01731609785817") 2024/11/14 18:47:35 DEBUG : yaml: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f1112e3ce77e17e81_d20241114_m184304_c001_v0001181_t0010_u01731609784866") 2024/11/14 18:47:35 DEBUG : yaml: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f409715789058c35c_d20241114_m184301_c001_v7007000_t0000_u01731609781916") 2024/11/14 18:47:35 DEBUG : yaml: Deleting (id "4_z1f82dde3f0ad2bbb9f380e1b_f110615c4acf309f5_d20241114_m184300_c001_v0001098_t0005_u01731609780580") "./sync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -fast-list" - Finished OK in 6m17.682744971s (try 1/5)