"./sync.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose -fast-list" - Starting (try 1/5) 2025/04/14 04:37:14 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bafaqep0resu" 2025/04/14 04:37:14 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/04/14 04:37:14 DEBUG : Creating backend with remote "/tmp/rclone2607998092" === RUN TestPipe --- PASS: TestPipe (0.00s) === RUN TestPipeConcurrent --- PASS: TestPipeConcurrent (0.05s) === 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 "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:37:15 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/14 04:37:15 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) 2025/04/14 04:37:15 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:37:15 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestCopyWithDryRun (1.23s) === RUN TestCopy run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:37:16 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/04/14 04:37:16 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/14 04:37:16 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:37:16 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:37:16 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/04/14 04:37:16 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world 2025/04/14 04:37:16 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:37:16 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopy (1.54s) === RUN TestCopyMetadata run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" sync_test.go:97: Skipping as metadata not supported --- SKIP: TestCopyMetadata (0.22s) === RUN TestCopyMetadataNoEmptyDirs run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" sync_test.go:97: Skipping as metadata not supported --- SKIP: TestCopyMetadataNoEmptyDirs (0.23s) === RUN TestCopyMissingDirectory run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:37:18 DEBUG : Creating backend with remote "/non-existing" 2025/04/14 04:37:18 ERROR : Local file system at /non-existing: error reading source root directory: directory not found 2025/04/14 04:37:18 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:37:18 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestCopyMissingDirectory (0.56s) === RUN TestCopyNoTraverse run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:37:18 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/14 04:37:18 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:37:18 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:37:19 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/04/14 04:37:19 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world 2025/04/14 04:37:19 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestCopyNoTraverse (1.24s) === RUN TestCopyCheckFirst run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:37:19 INFO : pcloud root 'rclone-test-bafaqep0resu': Running all checks before starting transfers 2025/04/14 04:37:19 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/14 04:37:19 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:37:19 INFO : pcloud root 'rclone-test-bafaqep0resu': Checks finished, now starting transfers 2025/04/14 04:37:19 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:37:20 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/04/14 04:37:20 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world 2025/04/14 04:37:20 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestCopyCheckFirst (1.34s) === RUN TestSyncNoTraverse run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:37:21 ERROR : Ignoring --no-traverse with sync 2025/04/14 04:37:21 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/14 04:37:21 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:37:21 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:37:21 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/04/14 04:37:21 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world 2025/04/14 04:37:21 INFO : sub dir/hello world: Copied (new) 2025/04/14 04:37:21 DEBUG : Waiting for deletions to finish run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestSyncNoTraverse (1.12s) === RUN TestCopyWithDepth run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:37:22 DEBUG : hello world2: Need to transfer - File not found at Destination 2025/04/14 04:37:22 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:37:22 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:37:22 DEBUG : hello world2: sha1 = c0bf117f9c93d02c894fe8ffd6e5cecf3545c209 OK 2025/04/14 04:37:22 DEBUG : hello world2.ab19a585.partial: renamed to: hello world2 2025/04/14 04:37:22 INFO : hello world2: Copied (new) run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestCopyWithDepth (0.86s) === RUN TestCopyWithFilesFrom run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:37:23 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/14 04:37:23 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:37:23 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:37:23 DEBUG : potato2: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/04/14 04:37:23 DEBUG : potato2.adfb51a5.partial: renamed to: potato2 2025/04/14 04:37:23 INFO : potato2: Copied (new) run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestCopyWithFilesFrom (0.86s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:37:24 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/14 04:37:24 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:37:24 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:37:24 DEBUG : potato2: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/04/14 04:37:24 DEBUG : potato2.adfb51a5.partial: renamed to: potato2 2025/04/14 04:37:24 INFO : potato2: Copied (new) run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestCopyWithFilesFromAndNoTraverse (0.86s) === RUN TestCopyEmptyDirectories run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:37:24 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2025/04/14 04:37:24 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/14 04:37:24 INFO : sub dir2: Set directory modification time (using DirSetModTime) 2025/04/14 04:37:24 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/04/14 04:37:24 INFO : sub dir: Making directory 2025/04/14 04:37:25 INFO : sub dir2: Making directory 2025/04/14 04:37:25 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/14 04:37:25 INFO : sub dir2/sub sub dir2: Making directory 2025/04/14 04:37:26 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:37:26 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:37:26 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/04/14 04:37:26 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world 2025/04/14 04:37:26 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:37:26 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopyEmptyDirectories (2.14s) === RUN TestCopyNoEmptyDirectories run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:37:27 INFO : sub dir2: Making directory 2025/04/14 04:37:27 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2025/04/14 04:37:27 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/14 04:37:27 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/14 04:37:27 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:37:27 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:37:27 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/04/14 04:37:27 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world 2025/04/14 04:37:27 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoEmptyDirectories (1.41s) === RUN TestMoveEmptyDirectories run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:37:28 DEBUG : sub dir2: Making directory with metadata 2025/04/14 04:37:28 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/14 04:37:28 INFO : sub dir: Making directory 2025/04/14 04:37:28 INFO : sub dir2: Making directory 2025/04/14 04:37:29 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/14 04:37:29 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:37:29 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:37:29 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/04/14 04:37:29 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world 2025/04/14 04:37:29 INFO : sub dir/hello world: Copied (new) 2025/04/14 04:37:29 INFO : sub dir/hello world: Deleted run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:37:29 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata 2025/04/14 04:37:29 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestMoveEmptyDirectories (1.59s) === RUN TestSyncNoUpdateDirModtime run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" sync_test.go:408: Skipping test as backend does not support DirSetModTime --- SKIP: TestSyncNoUpdateDirModtime (0.17s) === RUN TestMoveNoEmptyDirectories run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:37:30 INFO : sub dir2: Making directory 2025/04/14 04:37:30 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/14 04:37:30 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:37:30 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:37:30 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/04/14 04:37:30 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world 2025/04/14 04:37:30 INFO : sub dir/hello world: Copied (new) 2025/04/14 04:37:30 INFO : sub dir/hello world: Deleted --- PASS: TestMoveNoEmptyDirectories (1.20s) === RUN TestSyncEmptyDirectories run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:37:31 DEBUG : sub dir2: Making directory with metadata 2025/04/14 04:37:31 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/14 04:37:31 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/04/14 04:37:31 INFO : sub dir: Making directory 2025/04/14 04:37:31 INFO : sub dir2: Making directory 2025/04/14 04:37:31 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/14 04:37:31 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:37:31 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:37:31 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/04/14 04:37:31 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world 2025/04/14 04:37:31 INFO : sub dir/hello world: Copied (new) 2025/04/14 04:37:31 DEBUG : Waiting for deletions to finish run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:37:32 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestSyncEmptyDirectories (1.35s) === RUN TestSyncSetDelayedModTimes run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" sync_test.go:507: Backend doesn't have DirModTimeUpdatesOnWrite set --- SKIP: TestSyncSetDelayedModTimes (0.17s) === RUN TestSyncNoEmptyDirectories run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:37:32 INFO : sub dir2: Making directory 2025/04/14 04:37:33 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/14 04:37:33 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:37:33 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:37:33 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/04/14 04:37:33 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world 2025/04/14 04:37:33 INFO : sub dir/hello world: Copied (new) 2025/04/14 04:37:33 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoEmptyDirectories (0.94s) === RUN TestServerSideCopy run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:37:34 DEBUG : Creating backend with remote "TestPcloud:rclone-test-xijunoc7wino" 2025/04/14 04:37:34 DEBUG : Config file has changed externally - reloading sync_test.go:590: Server side copy (if possible) pcloud root 'rclone-test-bafaqep0resu' -> pcloud root 'rclone-test-xijunoc7wino' 2025/04/14 04:37:35 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/14 04:37:35 DEBUG : pcloud root 'rclone-test-xijunoc7wino': Waiting for checks to finish 2025/04/14 04:37:35 DEBUG : pcloud root 'rclone-test-xijunoc7wino': Waiting for transfers to finish 2025/04/14 04:37:36 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/04/14 04:37:36 DEBUG : sub dir/hello world.e0e42c92.partial: renamed to: sub dir/hello world 2025/04/14 04:37:36 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:37:36 DEBUG : pcloud root 'rclone-test-xijunoc7wino': Purge remote --- PASS: TestServerSideCopy (3.26s) === RUN TestCopyOverSelf run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:37:37 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/04/14 04:37:37 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:37:37 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:37:37 DEBUG : sub dir/hello world: sha1 = b84a9b2362aee3556081792f3b7abd3958da8deb OK 2025/04/14 04:37:38 DEBUG : sub dir/hello world.55b27b22.partial: renamed to: sub dir/hello world 2025/04/14 04:37:38 INFO : sub dir/hello world: Copied (replaced existing) run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache fstest.go:286: Sleeping for 6s just to make sure --- PASS: TestCopyOverSelf (8.79s) === RUN TestServerSideCopyOverSelf run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" run.go:285: Failed to put "sub dir/hello world" to "pcloud root 'rclone-test-bafaqep0resu'": failed to make directory: pcloud error: File or folder already exists. (2004) --- FAIL: TestServerSideCopyOverSelf (0.67s) === RUN TestMoveOverSelf run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" run.go:285: Failed to put "sub dir/hello world" to "pcloud root 'rclone-test-bafaqep0resu'": failed to make directory: pcloud error: File or folder already exists. (2004) --- FAIL: TestMoveOverSelf (0.75s) === RUN TestServerSideMoveOverSelf run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" run.go:285: Failed to put "sub dir/hello world" to "pcloud root 'rclone-test-bafaqep0resu'": failed to make directory: pcloud error: File or folder already exists. (2004) --- FAIL: TestServerSideMoveOverSelf (0.69s) === RUN TestCopyAfterDelete run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" run.go:285: Failed to put "sub dir/hello world" to "pcloud root 'rclone-test-bafaqep0resu'": failed to make directory: pcloud error: File or folder already exists. (2004) --- FAIL: TestCopyAfterDelete (0.72s) === RUN TestCopyRedownload run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" run.go:285: Failed to put "sub dir/hello world" to "pcloud root 'rclone-test-bafaqep0resu'": failed to make directory: pcloud error: File or folder already exists. (2004) --- FAIL: TestCopyRedownload (0.72s) === RUN TestSyncBasedOnCheckSum run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:37:49 DEBUG : check sum: Need to transfer - File not found at Destination 2025/04/14 04:37:49 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:37:49 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:37:49 DEBUG : check sum: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2025/04/14 04:37:49 DEBUG : check sum.b37ac6a8.partial: renamed to: check sum 2025/04/14 04:37:49 INFO : check sum: Copied (new) 2025/04/14 04:37:49 DEBUG : Waiting for deletions to finish run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:295: Flushing the directory cache fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:295: Flushing the directory cache fstest.go:299: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:299 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:759 Error: Should be true Test: TestSyncBasedOnCheckSum Messages: listing wrong, want check sum (1) got fstest.go:197: Not found "check sum" fstest.go:200: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:200 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:304 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:759 Error: Not equal: expected: 0 actual : 1 Test: TestSyncBasedOnCheckSum Messages: 1 objects not found 2025/04/14 04:37:58 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:37:58 DEBUG : check sum: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2025/04/14 04:37:58 DEBUG : check sum: Size and sha1 of src and dst objects identical 2025/04/14 04:37:58 DEBUG : check sum: Unchanged skipping 2025/04/14 04:37:58 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:37:58 DEBUG : Waiting for deletions to finish 2025/04/14 04:37:58 INFO : sub dir/hello world: Deleted 2025/04/14 04:37:58 INFO : sub dir: Removing directory 2025/04/14 04:37:58 DEBUG : pcloud root 'rclone-test-bafaqep0resu': deleted 1 directories 2025/04/14 04:37:58 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- FAIL: TestSyncBasedOnCheckSum (9.98s) === RUN TestSyncSizeOnly run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:37:59 DEBUG : sizeonly: Need to transfer - File not found at Destination 2025/04/14 04:37:59 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:37:59 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:37:59 DEBUG : sizeonly: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2025/04/14 04:37:59 DEBUG : sizeonly.468f3f0c.partial: renamed to: sizeonly 2025/04/14 04:37:59 INFO : sizeonly: Copied (new) 2025/04/14 04:37:59 DEBUG : Waiting for deletions to finish run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:38:00 DEBUG : sizeonly: Sizes identical 2025/04/14 04:38:00 DEBUG : sizeonly: Unchanged skipping 2025/04/14 04:38:00 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:38:00 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:38:00 DEBUG : Waiting for deletions to finish 2025/04/14 04:38:00 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestSyncSizeOnly (3.59s) === RUN TestSyncIgnoreSize run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:38:03 DEBUG : ignore-size: Need to transfer - File not found at Destination 2025/04/14 04:38:03 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:38:03 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:38:03 DEBUG : ignore-size: sha1 = 4a756ca07e9487f482465a99e8286abc86ba4dc7 OK 2025/04/14 04:38:03 DEBUG : ignore-size.7615ca05.partial: renamed to: ignore-size 2025/04/14 04:38:03 INFO : ignore-size: Copied (new) 2025/04/14 04:38:03 DEBUG : Waiting for deletions to finish run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:38:03 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:38:03 DEBUG : ignore-size: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:38:03 DEBUG : ignore-size: Unchanged skipping 2025/04/14 04:38:03 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:38:03 DEBUG : Waiting for deletions to finish 2025/04/14 04:38:03 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestSyncIgnoreSize (1.31s) === RUN TestSyncIgnoreTimes run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:38:04 DEBUG : existing: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:38:04 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:38:04 DEBUG : existing: Unchanged skipping 2025/04/14 04:38:04 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:38:04 DEBUG : Waiting for deletions to finish 2025/04/14 04:38:04 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:38:04 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2025/04/14 04:38:04 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:38:04 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:38:04 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2025/04/14 04:38:04 DEBUG : existing.468f3f0c.partial: renamed to: existing 2025/04/14 04:38:04 INFO : existing: Copied (replaced existing) 2025/04/14 04:38:04 DEBUG : Waiting for deletions to finish run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestSyncIgnoreTimes (1.39s) === RUN TestSyncIgnoreExisting run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:38:05 DEBUG : existing: Need to transfer - File not found at Destination 2025/04/14 04:38:05 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:38:05 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:38:05 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2025/04/14 04:38:06 DEBUG : existing.468f3f0c.partial: renamed to: existing 2025/04/14 04:38:06 INFO : existing: Copied (new) 2025/04/14 04:38:06 DEBUG : Waiting for deletions to finish run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:38:06 DEBUG : existing: Destination exists, skipping 2025/04/14 04:38:06 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:38:06 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:38:06 DEBUG : Waiting for deletions to finish 2025/04/14 04:38:06 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestSyncIgnoreExisting (1.30s) === RUN TestSyncIgnoreErrors run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:38:07 INFO : d: Making directory 2025/04/14 04:38:08 DEBUG : c/non empty space: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/14 04:38:08 DEBUG : c/non empty space: Unchanged skipping 2025/04/14 04:38:08 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/04/14 04:38:08 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:38:08 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:38:08 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2025/04/14 04:38:08 DEBUG : a/potato2.94a2530c.partial: renamed to: a/potato2 2025/04/14 04:38:08 INFO : a/potato2: Copied (new) 2025/04/14 04:38:08 DEBUG : Waiting for deletions to finish 2025/04/14 04:38:08 INFO : b/potato: Deleted 2025/04/14 04:38:08 INFO : d: Removing directory 2025/04/14 04:38:08 INFO : b: Removing directory 2025/04/14 04:38:08 DEBUG : pcloud root 'rclone-test-bafaqep0resu': deleted 2 directories run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:295: Flushing the directory cache fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:295: Flushing the directory cache fstest.go:321: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:321 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Not equal: expected: []string{} actual : []string{"sub dir"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=7) "sub dir" } Test: TestSyncIgnoreErrors Messages: directories --- FAIL: TestSyncIgnoreErrors (10.67s) === RUN TestSyncAfterChangingModtimeOnly run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:38:18 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:38:18 DEBUG : empty space: Modification times differ by -95456h54m53.123456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06 +0000 UTC 2025/04/14 04:38:18 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2025/04/14 04:38:18 NOTICE: empty space: Skipped update modification time as --dry-run is set (size 1) 2025/04/14 04:38:18 DEBUG : empty space: Unchanged skipping 2025/04/14 04:38:18 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:38:18 DEBUG : Waiting for deletions to finish 2025/04/14 04:38:18 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:38:18 DEBUG : empty space: Modification times differ by -95456h54m53.123456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06 +0000 UTC 2025/04/14 04:38:18 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:38:18 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2025/04/14 04:38:18 INFO : empty space: Updated modification time in destination 2025/04/14 04:38:18 DEBUG : empty space: Unchanged skipping 2025/04/14 04:38:18 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:38:18 DEBUG : Waiting for deletions to finish 2025/04/14 04:38:18 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestSyncAfterChangingModtimeOnly (1.57s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:38:19 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:38:19 DEBUG : empty space: Modification times differ by -95456h54m53.123456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06 +0000 UTC 2025/04/14 04:38:19 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2025/04/14 04:38:19 DEBUG : empty space: Unchanged skipping 2025/04/14 04:38:19 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:38:19 DEBUG : Waiting for deletions to finish 2025/04/14 04:38:19 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (1.08s) === RUN TestSyncDoesntUpdateModtime run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:38:20 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:38:20 DEBUG : foo: Modification times differ by -95456h54m53.123456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06 +0000 UTC 2025/04/14 04:38:20 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 (Local file system at /tmp/rclone2607998092) 2025/04/14 04:38:20 DEBUG : foo: sha1 = 62cdb7020ff920e5aa642c3d4066950dd1f01f4d (pcloud root 'rclone-test-bafaqep0resu') 2025/04/14 04:38:20 DEBUG : foo: sha1 differ 2025/04/14 04:38:20 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:38:20 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 OK 2025/04/14 04:38:21 DEBUG : foo.5d8fa229.partial: renamed to: foo 2025/04/14 04:38:21 INFO : foo: Copied (replaced existing) 2025/04/14 04:38:21 DEBUG : Waiting for deletions to finish run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestSyncDoesntUpdateModtime (1.23s) === RUN TestSyncAfterAddingAFile run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:38:22 DEBUG : empty space: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/14 04:38:22 DEBUG : potato: Need to transfer - File not found at Destination 2025/04/14 04:38:22 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:38:22 DEBUG : empty space: Unchanged skipping 2025/04/14 04:38:22 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:38:22 DEBUG : potato: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2025/04/14 04:38:22 DEBUG : potato.3edca19f.partial: renamed to: potato 2025/04/14 04:38:22 INFO : potato: Copied (new) 2025/04/14 04:38:22 DEBUG : Waiting for deletions to finish run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestSyncAfterAddingAFile (1.52s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:38:23 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:38:23 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2025/04/14 04:38:23 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:38:23 DEBUG : potato: sha1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f OK 2025/04/14 04:38:23 DEBUG : potato.41b15364.partial: renamed to: potato 2025/04/14 04:38:23 INFO : potato: Copied (replaced existing) 2025/04/14 04:38:23 DEBUG : Waiting for deletions to finish run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestSyncAfterChangingFilesSizeOnly (1.46s) === RUN TestSyncAfterChangingContentsOnly run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:38:24 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 2025/04/14 04:38:24 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:38:25 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f (Local file system at /tmp/rclone2607998092) 2025/04/14 04:38:25 DEBUG : potato: sha1 = 0fd321a1023ac4e1e1054fcc0236b9d0755f722f (pcloud root 'rclone-test-bafaqep0resu') 2025/04/14 04:38:25 DEBUG : potato: sha1 differ 2025/04/14 04:38:25 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:38:25 DEBUG : potato: sha1 = 1ca5094b3b73f587249eabe179c40a3eec839b1f OK 2025/04/14 04:38:25 DEBUG : potato.706b9954.partial: renamed to: potato 2025/04/14 04:38:25 INFO : potato: Copied (replaced existing) 2025/04/14 04:38:25 DEBUG : Waiting for deletions to finish run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestSyncAfterChangingContentsOnly (1.21s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:38:26 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/14 04:38:26 DEBUG : empty space: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/14 04:38:26 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2025/04/14 04:38:26 DEBUG : empty space: Unchanged skipping 2025/04/14 04:38:26 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:38:26 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:38:26 DEBUG : Waiting for deletions to finish 2025/04/14 04:38:26 NOTICE: potato: Skipped delete as --dry-run is set (size 21) run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (1.08s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:38:28 DEBUG : empty space: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/14 04:38:28 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/14 04:38:28 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:38:28 DEBUG : empty space: Unchanged skipping 2025/04/14 04:38:28 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:38:28 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2025/04/14 04:38:28 DEBUG : potato2.94a2530c.partial: renamed to: potato2 2025/04/14 04:38:28 INFO : potato2: Copied (new) 2025/04/14 04:38:28 DEBUG : Waiting for deletions to finish 2025/04/14 04:38:28 INFO : potato: Deleted run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (2.95s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:38:30 INFO : d: Making directory 2025/04/14 04:38:30 INFO : d/e: Making directory 2025/04/14 04:38:31 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/04/14 04:38:31 DEBUG : c/non empty space: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/14 04:38:31 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:38:31 DEBUG : c/non empty space: Unchanged skipping 2025/04/14 04:38:31 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:38:31 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2025/04/14 04:38:31 DEBUG : a/potato2.94a2530c.partial: renamed to: a/potato2 2025/04/14 04:38:31 INFO : a/potato2: Copied (new) 2025/04/14 04:38:31 DEBUG : Waiting for deletions to finish 2025/04/14 04:38:31 INFO : b/potato: Deleted 2025/04/14 04:38:31 INFO : d/e: Removing directory 2025/04/14 04:38:32 INFO : d: Removing directory 2025/04/14 04:38:32 INFO : b: Removing directory 2025/04/14 04:38:32 DEBUG : pcloud root 'rclone-test-bafaqep0resu': deleted 3 directories run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (3.81s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:38:34 INFO : d: Making directory 2025/04/14 04:38:35 DEBUG : c/non empty space: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/14 04:38:35 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/04/14 04:38:35 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:38:35 DEBUG : c/non empty space: Unchanged skipping 2025/04/14 04:38:35 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:38:35 DEBUG : a/potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2025/04/14 04:38:35 DEBUG : a/potato2.94a2530c.partial: renamed to: a/potato2 2025/04/14 04:38:35 INFO : a/potato2: Copied (new) 2025/04/14 04:38:35 ERROR : pcloud root 'rclone-test-bafaqep0resu': not deleting files as there were IO errors 2025/04/14 04:38:35 ERROR : pcloud root 'rclone-test-bafaqep0resu': not deleting directories as there were IO errors run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:295: Flushing the directory cache fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:295: Flushing the directory cache fstest.go:299: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:299 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors Messages: listing wrong, want got sub dir/hello world (17) fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors Messages: Unexpected file "sub dir/hello world" fstest.go:321: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:321 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Not equal: expected: []string{} actual : []string{"sub dir"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=7) "sub dir" } Test: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors Messages: directories --- FAIL: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (11.61s) === RUN TestSyncDeleteAfter --- PASS: TestSyncDeleteAfter (0.00s) === RUN TestSyncDeleteDuring run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:295: Flushing the directory cache fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:295: Flushing the directory cache fstest.go:299: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:299 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1151 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1317 Error: Should be true Test: TestSyncDeleteDuring Messages: listing wrong, want empty space (1), potato (21) got fstest.go:197: Not found "potato" fstest.go:197: Not found "empty space" fstest.go:200: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:200 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:304 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1151 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1317 Error: Not equal: expected: 0 actual : 2 Test: TestSyncDeleteDuring Messages: 2 objects not found 2025/04/14 04:38:53 DEBUG : Waiting for deletions to finish 2025/04/14 04:38:54 DEBUG : empty space: Need to transfer - File not found at Destination 2025/04/14 04:38:54 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/14 04:38:54 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:38:54 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:38:54 ERROR : potato: Couldn't delete: pcloud error: File not found. (2009) 2025/04/14 04:38:54 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2025/04/14 04:38:54 DEBUG : potato2.94a2530c.partial: renamed to: potato2 2025/04/14 04:38:54 INFO : potato2: Copied (new) 2025/04/14 04:38:54 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2025/04/14 04:38:54 DEBUG : empty space.56d1852a.partial: renamed to: empty space 2025/04/14 04:38:54 INFO : empty space: Copied (new) 2025/04/14 04:38:54 ERROR : pcloud root 'rclone-test-bafaqep0resu': not deleting directories as there were IO errors sync_test.go:1157: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1157 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1317 Error: Received unexpected error: failed to delete 1 files Test: TestSyncDeleteDuring --- FAIL: TestSyncDeleteDuring (9.62s) === RUN TestSyncDeleteBefore run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:295: Flushing the directory cache fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:295: Flushing the directory cache fstest.go:299: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:299 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1151 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1326 Error: Should be true Test: TestSyncDeleteBefore Messages: listing wrong, want empty space (1), potato (21) got a/potato2 (60), b/potato (21), c/non empty space (5), empty space (1), potato (21), potato2 (60) fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1151 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1326 Error: Should be true Test: TestSyncDeleteBefore Messages: Unexpected file "a/potato2" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1151 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1326 Error: Should be true Test: TestSyncDeleteBefore Messages: Unexpected file "b/potato" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1151 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1326 Error: Should be true Test: TestSyncDeleteBefore Messages: Unexpected file "c/non empty space" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1151 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1326 Error: Should be true Test: TestSyncDeleteBefore Messages: Unexpected file "potato2" 2025/04/14 04:39:03 DEBUG : Waiting for deletions to finish 2025/04/14 04:39:03 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:39:03 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:39:03 INFO : b/potato: Deleted 2025/04/14 04:39:03 INFO : c/non empty space: Deleted 2025/04/14 04:39:03 INFO : potato: Deleted 2025/04/14 04:39:03 INFO : a/potato2: Deleted 2025/04/14 04:39:03 INFO : d: Removing directory 2025/04/14 04:39:04 INFO : c: Removing directory 2025/04/14 04:39:04 INFO : b: Removing directory 2025/04/14 04:39:04 INFO : a: Removing directory 2025/04/14 04:39:04 DEBUG : pcloud root 'rclone-test-bafaqep0resu': deleted 4 directories 2025/04/14 04:39:04 DEBUG : empty space: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/14 04:39:04 DEBUG : potato2: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:39:04 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:39:04 DEBUG : empty space: Unchanged skipping 2025/04/14 04:39:04 DEBUG : potato2: Unchanged skipping 2025/04/14 04:39:04 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:39:04 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- FAIL: TestSyncDeleteBefore (10.49s) === RUN TestCopyDeleteBefore run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:39:05 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/14 04:39:05 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:39:05 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:39:05 DEBUG : potato2: sha1 = 810274f0df19dab60a894a562b7a8ff04c072623 OK 2025/04/14 04:39:05 DEBUG : potato2.8083cda9.partial: renamed to: potato2 2025/04/14 04:39:05 INFO : potato2: Copied (new) run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestCopyDeleteBefore (1.54s) === RUN TestSyncWithExclude run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:39:08 DEBUG : enormous: Excluded (Size Filter) 2025/04/14 04:39:08 DEBUG : enormous: Excluded 2025/04/14 04:39:08 DEBUG : potato2: Excluded (Size Filter) 2025/04/14 04:39:08 DEBUG : potato2: Excluded 2025/04/14 04:39:08 DEBUG : potato2: Excluded (Size Filter) 2025/04/14 04:39:08 DEBUG : empty space: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/14 04:39:08 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:39:08 DEBUG : empty space: Unchanged skipping 2025/04/14 04:39:08 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:39:08 DEBUG : Waiting for deletions to finish 2025/04/14 04:39:08 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:39:08 DEBUG : enormous: Excluded (Size Filter) 2025/04/14 04:39:08 DEBUG : enormous: Excluded 2025/04/14 04:39:08 DEBUG : potato2: Excluded (Size Filter) 2025/04/14 04:39:08 DEBUG : potato2: Excluded 2025/04/14 04:39:08 DEBUG : potato2: Excluded (Size Filter) 2025/04/14 04:39:08 DEBUG : empty space: Size and modification time the same (differ by 123.456789ms, within tolerance 1s) 2025/04/14 04:39:08 DEBUG : empty space: Unchanged skipping 2025/04/14 04:39:08 DEBUG : Local file system at /tmp/rclone2607998092: Waiting for checks to finish 2025/04/14 04:39:08 DEBUG : Local file system at /tmp/rclone2607998092: Waiting for transfers to finish 2025/04/14 04:39:08 DEBUG : Waiting for deletions to finish 2025/04/14 04:39:08 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestSyncWithExclude (2.59s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:39:10 DEBUG : enormous: Excluded (Size Filter) 2025/04/14 04:39:10 DEBUG : enormous: Excluded 2025/04/14 04:39:10 DEBUG : potato2: Excluded (Size Filter) 2025/04/14 04:39:10 DEBUG : potato2: Excluded 2025/04/14 04:39:10 DEBUG : empty space: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/14 04:39:10 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:39:10 DEBUG : empty space: Unchanged skipping 2025/04/14 04:39:10 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:39:10 DEBUG : Waiting for deletions to finish 2025/04/14 04:39:10 INFO : potato2: Deleted 2025/04/14 04:39:10 INFO : enormous: Deleted 2025/04/14 04:39:10 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:39:10 DEBUG : empty space: Size and modification time the same (differ by 123.456789ms, within tolerance 1s) 2025/04/14 04:39:10 DEBUG : empty space: Unchanged skipping 2025/04/14 04:39:10 DEBUG : Local file system at /tmp/rclone2607998092: Waiting for checks to finish 2025/04/14 04:39:10 DEBUG : Local file system at /tmp/rclone2607998092: Waiting for transfers to finish 2025/04/14 04:39:10 DEBUG : Waiting for deletions to finish 2025/04/14 04:39:10 INFO : enormous: Deleted 2025/04/14 04:39:10 INFO : potato2: Deleted 2025/04/14 04:39:10 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestSyncWithExcludeAndDeleteExcluded (1.61s) === RUN TestSyncWithUpdateOlder run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:39:12 DEBUG : five: Need to transfer - File not found at Destination 2025/04/14 04:39:12 DEBUG : four: Sizes differ (src 4 vs dst 8) 2025/04/14 04:39:12 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2025/04/14 04:39:12 DEBUG : one: Destination is newer than source, skipping 2025/04/14 04:39:12 DEBUG : three: Sizes identical 2025/04/14 04:39:12 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2025/04/14 04:39:12 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:39:13 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2025/04/14 04:39:13 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b (Local file system at /tmp/rclone2607998092) 2025/04/14 04:39:13 DEBUG : two: sha1 = b10e0da85e90399abfec36c7376b20aa4596461b (pcloud root 'rclone-test-bafaqep0resu') 2025/04/14 04:39:13 DEBUG : two: sha1 differ 2025/04/14 04:39:13 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:39:13 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2025/04/14 04:39:13 DEBUG : four.a87a5b8d.partial: renamed to: four 2025/04/14 04:39:13 INFO : four: Copied (replaced existing) 2025/04/14 04:39:13 DEBUG : five.a87a5b8d.partial: renamed to: five 2025/04/14 04:39:13 INFO : five: Copied (new) 2025/04/14 04:39:13 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2025/04/14 04:39:13 DEBUG : two.3353c5f5.partial: renamed to: two 2025/04/14 04:39:13 INFO : two: Copied (replaced existing) 2025/04/14 04:39:13 DEBUG : Waiting for deletions to finish 2025/04/14 04:39:13 DEBUG : one: Destination is newer than source, skipping 2025/04/14 04:39:13 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:39:13 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2025/04/14 04:39:13 DEBUG : four: Size and sha1 of src and dst objects identical 2025/04/14 04:39:13 DEBUG : four: Destination mod time is within 1s of source and files identical, skipping 2025/04/14 04:39:13 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb (Local file system at /tmp/rclone2607998092) 2025/04/14 04:39:13 DEBUG : three: sha1 = 03731cad13f4cf7b59703c77529381cdec1632e5 (pcloud root 'rclone-test-bafaqep0resu') 2025/04/14 04:39:13 DEBUG : three: sha1 differ 2025/04/14 04:39:13 DEBUG : three: Destination mod time is within 1s of source but files differ, transferring 2025/04/14 04:39:13 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2025/04/14 04:39:13 DEBUG : two: Size and sha1 of src and dst objects identical 2025/04/14 04:39:13 DEBUG : two: Destination mod time is within 1s of source and files identical, skipping 2025/04/14 04:39:13 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2025/04/14 04:39:13 DEBUG : five: Size and sha1 of src and dst objects identical 2025/04/14 04:39:13 DEBUG : five: Destination mod time is within 1s of source and files identical, skipping 2025/04/14 04:39:13 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:39:14 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2025/04/14 04:39:14 DEBUG : three.406dcb2c.partial: renamed to: three 2025/04/14 04:39:14 INFO : three: Copied (replaced existing) 2025/04/14 04:39:14 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithUpdateOlder (4.15s) === RUN TestSyncWithMaxDuration === RUN TestSyncWithMaxDuration/Hard sync_test.go:1466: Skipping test on non local remote === RUN TestSyncWithMaxDuration/Soft sync_test.go:1466: 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 "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" sync_test.go:1538: Can track renames: true 2025/04/14 04:39:15 INFO : pcloud root 'rclone-test-bafaqep0resu': Making map for --track-renames 2025/04/14 04:39:15 INFO : pcloud root 'rclone-test-bafaqep0resu': Finished making map for --track-renames 2025/04/14 04:39:15 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:39:15 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/04/14 04:39:15 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/04/14 04:39:15 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for renames to finish 2025/04/14 04:39:15 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:39:15 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/04/14 04:39:15 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/04/14 04:39:15 DEBUG : potato.53508f02.partial: renamed to: potato 2025/04/14 04:39:15 INFO : potato: Copied (new) 2025/04/14 04:39:15 DEBUG : yam.48501227.partial: renamed to: yam 2025/04/14 04:39:15 INFO : yam: Copied (new) 2025/04/14 04:39:15 DEBUG : Waiting for deletions to finish run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:39:15 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:39:15 INFO : pcloud root 'rclone-test-bafaqep0resu': Making map for --track-renames 2025/04/14 04:39:15 DEBUG : potato: Unchanged skipping 2025/04/14 04:39:15 INFO : pcloud root 'rclone-test-bafaqep0resu': Finished making map for --track-renames 2025/04/14 04:39:15 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:39:15 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for renames to finish 2025/04/14 04:39:16 INFO : yam: Moved (server-side) to: yaml 2025/04/14 04:39:16 INFO : yaml: Renamed from "yam" 2025/04/14 04:39:16 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:39:16 DEBUG : Waiting for deletions to finish 2025/04/14 04:39:16 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestSyncWithTrackRenames (1.79s) === RUN TestParseRenamesStrategyModtime --- PASS: TestParseRenamesStrategyModtime (0.00s) === RUN TestRenamesStrategyModtime --- PASS: TestRenamesStrategyModtime (0.00s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" sync_test.go:1610: Can track renames: true 2025/04/14 04:39:17 INFO : pcloud root 'rclone-test-bafaqep0resu': Making map for --track-renames 2025/04/14 04:39:17 INFO : pcloud root 'rclone-test-bafaqep0resu': Finished making map for --track-renames 2025/04/14 04:39:17 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:39:17 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/04/14 04:39:17 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/04/14 04:39:17 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for renames to finish 2025/04/14 04:39:17 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:39:17 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/04/14 04:39:17 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/04/14 04:39:17 DEBUG : yam.48501227.partial: renamed to: yam 2025/04/14 04:39:17 INFO : yam: Copied (new) 2025/04/14 04:39:17 DEBUG : potato.53508f02.partial: renamed to: potato 2025/04/14 04:39:17 INFO : potato: Copied (new) 2025/04/14 04:39:17 DEBUG : Waiting for deletions to finish run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:39:17 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:39:17 INFO : pcloud root 'rclone-test-bafaqep0resu': Making map for --track-renames 2025/04/14 04:39:17 INFO : pcloud root 'rclone-test-bafaqep0resu': Finished making map for --track-renames 2025/04/14 04:39:17 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:39:17 DEBUG : potato: Unchanged skipping 2025/04/14 04:39:17 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for renames to finish 2025/04/14 04:39:17 INFO : yam: Moved (server-side) to: yaml 2025/04/14 04:39:17 INFO : yaml: Renamed from "yam" 2025/04/14 04:39:17 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:39:17 DEBUG : Waiting for deletions to finish 2025/04/14 04:39:17 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestSyncWithTrackRenamesStrategyModtime (1.74s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" sync_test.go:1649: Can track renames: true 2025/04/14 04:39:18 INFO : pcloud root 'rclone-test-bafaqep0resu': Making map for --track-renames 2025/04/14 04:39:18 INFO : pcloud root 'rclone-test-bafaqep0resu': Finished making map for --track-renames 2025/04/14 04:39:18 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:39:18 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/04/14 04:39:18 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for renames to finish 2025/04/14 04:39:18 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/04/14 04:39:18 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:39:18 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/04/14 04:39:19 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/04/14 04:39:19 DEBUG : potato.53508f02.partial: renamed to: potato 2025/04/14 04:39:19 INFO : potato: Copied (new) 2025/04/14 04:39:19 DEBUG : sub/yam.48501227.partial: renamed to: sub/yam 2025/04/14 04:39:19 INFO : sub/yam: Copied (new) 2025/04/14 04:39:19 DEBUG : Waiting for deletions to finish run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:39:19 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:39:19 DEBUG : potato: Unchanged skipping 2025/04/14 04:39:19 INFO : pcloud root 'rclone-test-bafaqep0resu': Making map for --track-renames 2025/04/14 04:39:19 INFO : pcloud root 'rclone-test-bafaqep0resu': Finished making map for --track-renames 2025/04/14 04:39:19 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:39:19 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for renames to finish 2025/04/14 04:39:19 INFO : sub/yam: Moved (server-side) to: yam 2025/04/14 04:39:19 INFO : yam: Renamed from "sub/yam" 2025/04/14 04:39:19 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:39:19 DEBUG : Waiting for deletions to finish 2025/04/14 04:39:19 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestSyncWithTrackRenamesStrategyLeaf (2.17s) === RUN TestServerSideMoveLocal run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:39:20 DEBUG : Creating backend with remote "/tmp/rclone2607998092/dir1" 2025/04/14 04:39:20 DEBUG : Config file has changed externally - reloading 2025/04/14 04:39:20 DEBUG : Creating backend with remote "/tmp/rclone2607998092/dir2" 2025/04/14 04:39:20 DEBUG : Local file system at /tmp/rclone2607998092/dir2: Using server-side directory move 2025/04/14 04:39:20 INFO : Local file system at /tmp/rclone2607998092/dir2: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/04/14 04:39:20 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/04/14 04:39:20 DEBUG : Local file system at /tmp/rclone2607998092/dir2: Waiting for checks to finish 2025/04/14 04:39:20 DEBUG : Local file system at /tmp/rclone2607998092/dir2: Waiting for transfers to finish 2025/04/14 04:39:20 INFO : file1.txt: Moved (server-side) --- PASS: TestServerSideMoveLocal (0.18s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:39:21 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/14 04:39:21 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/04/14 04:39:21 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:39:21 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:39:21 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/04/14 04:39:21 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world 2025/04/14 04:39:21 INFO : sub dir/hello world: Copied (new) 2025/04/14 04:39:21 INFO : sub dir/hello world: Deleted 2025/04/14 04:39:21 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/04/14 04:39:22 DEBUG : nested/sub dir/file.468f3f0c.partial: renamed to: nested/sub dir/file 2025/04/14 04:39:22 INFO : nested/sub dir/file: Copied (new) 2025/04/14 04:39:22 INFO : nested/sub dir/file: Deleted 2025/04/14 04:39:22 INFO : sub dir: Removing directory 2025/04/14 04:39:22 INFO : nested/sub dir: Removing directory 2025/04/14 04:39:22 INFO : nested: Removing directory 2025/04/14 04:39:22 DEBUG : Local file system at /tmp/rclone2607998092: deleted 3 directories run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestMoveWithDeleteEmptySrcDirs (2.00s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:39:23 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/14 04:39:23 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/04/14 04:39:23 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:39:23 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:39:23 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/04/14 04:39:23 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world 2025/04/14 04:39:23 INFO : sub dir/hello world: Copied (new) 2025/04/14 04:39:23 INFO : sub dir/hello world: Deleted 2025/04/14 04:39:23 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/04/14 04:39:24 DEBUG : nested/sub dir/file.468f3f0c.partial: renamed to: nested/sub dir/file 2025/04/14 04:39:24 INFO : nested/sub dir/file: Copied (new) 2025/04/14 04:39:24 INFO : nested/sub dir/file: Deleted run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestMoveWithoutDeleteEmptySrcDirs (2.00s) === RUN TestMoveWithIgnoreExisting run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:39:25 DEBUG : existing: Need to transfer - File not found at Destination 2025/04/14 04:39:25 DEBUG : existing-b: Need to transfer - File not found at Destination 2025/04/14 04:39:25 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:39:25 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:39:25 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2025/04/14 04:39:25 DEBUG : existing-b: sha1 = 321f6b7e8bf7f29aab89c5e41a555b1b0baa41a9 OK 2025/04/14 04:39:25 DEBUG : existing.468f3f0c.partial: renamed to: existing 2025/04/14 04:39:25 INFO : existing: Copied (new) 2025/04/14 04:39:25 INFO : existing: Deleted 2025/04/14 04:39:25 DEBUG : existing-b.468f3f0c.partial: renamed to: existing-b 2025/04/14 04:39:25 INFO : existing-b: Copied (new) 2025/04/14 04:39:25 INFO : existing-b: Deleted 2025/04/14 04:39:25 DEBUG : existing: Destination exists, skipping 2025/04/14 04:39:25 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2025/04/14 04:39:25 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:39:25 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:39:25 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestMoveWithIgnoreExisting (1.38s) === RUN TestServerSideMove run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:39:26 DEBUG : Creating backend with remote "TestPcloud:rclone-test-jatifod2winu" sync_test.go:1705: Server side move (if possible) pcloud root 'rclone-test-bafaqep0resu' -> pcloud root 'rclone-test-jatifod2winu' 2025/04/14 04:39:28 DEBUG : pcloud root 'rclone-test-jatifod2winu': Using server-side directory move 2025/04/14 04:39:28 INFO : pcloud root 'rclone-test-jatifod2winu': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/04/14 04:39:29 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/14 04:39:29 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/04/14 04:39:29 DEBUG : empty space: Unchanged skipping 2025/04/14 04:39:29 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/04/14 04:39:29 DEBUG : pcloud root 'rclone-test-jatifod2winu': Waiting for checks to finish 2025/04/14 04:39:29 INFO : empty space: Deleted 2025/04/14 04:39:29 DEBUG : pcloud root 'rclone-test-jatifod2winu': Waiting for transfers to finish 2025/04/14 04:39:29 INFO : potato2: Moved (server-side) 2025/04/14 04:39:29 INFO : potato3: Deleted 2025/04/14 04:39:29 INFO : potato3: Moved (server-side) 2025/04/14 04:39:29 DEBUG : Creating backend with remote "TestPcloud:rclone-test-fizepid7bihi" 2025/04/14 04:39:29 DEBUG : Config file has changed externally - reloading 2025/04/14 04:39:30 DEBUG : pcloud root 'rclone-test-fizepid7bihi': Using server-side directory move 2025/04/14 04:39:30 INFO : pcloud root 'rclone-test-fizepid7bihi': Server side directory move succeeded 2025/04/14 04:39:32 DEBUG : pcloud root 'rclone-test-fizepid7bihi': Purge remote 2025/04/14 04:39:32 DEBUG : pcloud root 'rclone-test-jatifod2winu': Purge remote 2025/04/14 04:39:32 NOTICE: purge failed: directory not found --- PASS: TestServerSideMove (6.56s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:39:33 DEBUG : Creating backend with remote "TestPcloud:rclone-test-voxodol5nemu" fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:295: Flushing the directory cache fstest.go:286: Sleeping for 7s just to make sure sync_test.go:1705: Server side move (if possible) pcloud root 'rclone-test-bafaqep0resu' -> pcloud root 'rclone-test-voxodol5nemu' 2025/04/14 04:39:46 DEBUG : empty space: Excluded (Size Filter) 2025/04/14 04:39:46 DEBUG : empty space: Excluded (Size Filter) 2025/04/14 04:39:46 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/14 04:39:46 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/04/14 04:39:46 DEBUG : pcloud root 'rclone-test-voxodol5nemu': Waiting for checks to finish 2025/04/14 04:39:46 DEBUG : pcloud root 'rclone-test-voxodol5nemu': Waiting for transfers to finish 2025/04/14 04:39:46 INFO : potato2: Moved (server-side) 2025/04/14 04:39:46 INFO : potato3: Deleted 2025/04/14 04:39:46 INFO : potato3: Moved (server-side) 2025/04/14 04:39:47 DEBUG : Creating backend with remote "TestPcloud:rclone-test-biyetuj4pini" 2025/04/14 04:39:47 DEBUG : Config file has changed externally - reloading 2025/04/14 04:39:48 DEBUG : empty space: Excluded (Size Filter) 2025/04/14 04:39:48 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/14 04:39:48 DEBUG : potato3: Need to transfer - File not found at Destination 2025/04/14 04:39:48 DEBUG : pcloud root 'rclone-test-biyetuj4pini': Waiting for checks to finish 2025/04/14 04:39:48 DEBUG : pcloud root 'rclone-test-biyetuj4pini': Waiting for transfers to finish 2025/04/14 04:39:48 INFO : potato2: Moved (server-side) 2025/04/14 04:39:48 INFO : potato3: Moved (server-side) 2025/04/14 04:39:49 DEBUG : pcloud root 'rclone-test-biyetuj4pini': Purge remote 2025/04/14 04:39:49 DEBUG : pcloud root 'rclone-test-voxodol5nemu': Purge remote --- PASS: TestServerSideMoveWithFilter (17.32s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:39:50 DEBUG : Creating backend with remote "TestPcloud:rclone-test-liluzep5taka" 2025/04/14 04:39:51 INFO : tomatoDir: Making directory sync_test.go:1705: Server side move (if possible) pcloud root 'rclone-test-bafaqep0resu' -> pcloud root 'rclone-test-liluzep5taka' 2025/04/14 04:39:53 DEBUG : pcloud root 'rclone-test-liluzep5taka': Using server-side directory move 2025/04/14 04:39:53 INFO : pcloud root 'rclone-test-liluzep5taka': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/04/14 04:39:53 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/14 04:39:53 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/04/14 04:39:53 DEBUG : empty space: Unchanged skipping 2025/04/14 04:39:53 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/04/14 04:39:53 DEBUG : pcloud root 'rclone-test-liluzep5taka': Waiting for checks to finish 2025/04/14 04:39:53 INFO : potato2: Moved (server-side) 2025/04/14 04:39:53 INFO : empty space: Deleted 2025/04/14 04:39:53 DEBUG : pcloud root 'rclone-test-liluzep5taka': Waiting for transfers to finish 2025/04/14 04:39:53 INFO : potato3: Deleted 2025/04/14 04:39:53 INFO : potato3: Moved (server-side) 2025/04/14 04:39:53 INFO : tomatoDir: Removing directory 2025/04/14 04:39:53 DEBUG : pcloud root 'rclone-test-bafaqep0resu': deleted 1 directories 2025/04/14 04:39:54 DEBUG : Creating backend with remote "TestPcloud:rclone-test-judirog0dage" 2025/04/14 04:39:55 INFO : tomatoDir: Making directory 2025/04/14 04:39:55 DEBUG : pcloud root 'rclone-test-judirog0dage': Using server-side directory move 2025/04/14 04:39:56 INFO : pcloud root 'rclone-test-judirog0dage': Server side directory move succeeded 2025/04/14 04:39:58 DEBUG : pcloud root 'rclone-test-judirog0dage': Purge remote 2025/04/14 04:39:58 DEBUG : pcloud root 'rclone-test-liluzep5taka': Purge remote 2025/04/14 04:39:58 NOTICE: purge failed: directory not found --- PASS: TestServerSideMoveDeleteEmptySourceDirs (8.60s) === RUN TestServerSideMoveOverlap run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" sync_test.go:1910: Skipping test as remote supports DirMove --- SKIP: TestServerSideMoveOverlap (0.45s) === RUN TestSyncOverlap run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:39:59 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bafaqep0resu/rclone-sync-test" 2025/04/14 04:39:59 DEBUG : Config file has changed externally - reloading run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestSyncOverlap (1.93s) === RUN TestSyncOverlapWithFilter run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:40:01 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bafaqep0resu/rclone-sync-test" 2025/04/14 04:40:02 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bafaqep0resu/rclone-sync-test-include/layer2" 2025/04/14 04:40:03 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bafaqep0resu/rclone-sync-test-ignore-file" 2025/04/14 04:40:04 ERROR : pcloud root 'rclone-test-bafaqep0resu': error reading source root directory: couldn't list files: pcloud error: Directory does not exist. (2005) 2025/04/14 04:40:04 DEBUG : pcloud root 'rclone-test-bafaqep0resu/rclone-sync-test': Waiting for checks to finish 2025/04/14 04:40:04 DEBUG : pcloud root 'rclone-test-bafaqep0resu/rclone-sync-test': Waiting for transfers to finish 2025/04/14 04:40:04 ERROR : pcloud root 'rclone-test-bafaqep0resu/rclone-sync-test': not deleting files as there were IO errors 2025/04/14 04:40:04 ERROR : pcloud root 'rclone-test-bafaqep0resu/rclone-sync-test': not deleting directories as there were IO errors sync_test.go:2003: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2003 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2008 Error: Received unexpected error: couldn't list files: pcloud error: Directory does not exist. (2005) Test: TestSyncOverlapWithFilter --- FAIL: TestSyncOverlapWithFilter (5.09s) === RUN TestSyncCompareDest run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:40:06 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bafaqep0resu/dst" 2025/04/14 04:40:07 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bafaqep0resu/CompareDest" 2025/04/14 04:40:08 DEBUG : one: Need to transfer - File not found at Destination 2025/04/14 04:40:08 DEBUG : pcloud root 'rclone-test-bafaqep0resu/dst': Waiting for checks to finish 2025/04/14 04:40:08 DEBUG : pcloud root 'rclone-test-bafaqep0resu/dst': Waiting for transfers to finish 2025/04/14 04:40:08 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2025/04/14 04:40:08 DEBUG : one.b824e1ab.partial: renamed to: one 2025/04/14 04:40:08 INFO : one: Copied (new) 2025/04/14 04:40:08 DEBUG : Waiting for deletions to finish 2025/04/14 04:40:08 DEBUG : pcloud root 'rclone-test-bafaqep0resu/dst': Waiting for checks to finish 2025/04/14 04:40:08 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/14 04:40:08 DEBUG : pcloud root 'rclone-test-bafaqep0resu/dst': Waiting for transfers to finish 2025/04/14 04:40:09 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2025/04/14 04:40:09 DEBUG : one.406dcb2c.partial: renamed to: one 2025/04/14 04:40:09 INFO : one: Copied (replaced existing) 2025/04/14 04:40:09 DEBUG : Waiting for deletions to finish 2025/04/14 04:40:10 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/14 04:40:10 DEBUG : pcloud root 'rclone-test-bafaqep0resu/dst': Waiting for checks to finish 2025/04/14 04:40:10 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/14 04:40:10 DEBUG : one: Destination found in --compare-dest, skipping 2025/04/14 04:40:10 DEBUG : pcloud root 'rclone-test-bafaqep0resu/dst': Waiting for transfers to finish 2025/04/14 04:40:10 DEBUG : Waiting for deletions to finish 2025/04/14 04:40:10 INFO : There was nothing to transfer 2025/04/14 04:40:12 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/14 04:40:12 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/14 04:40:12 DEBUG : two: Destination found in --compare-dest, skipping 2025/04/14 04:40:12 DEBUG : pcloud root 'rclone-test-bafaqep0resu/dst': Waiting for checks to finish 2025/04/14 04:40:12 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/14 04:40:12 DEBUG : one: Destination found in --compare-dest, skipping 2025/04/14 04:40:12 DEBUG : pcloud root 'rclone-test-bafaqep0resu/dst': Waiting for transfers to finish 2025/04/14 04:40:12 DEBUG : Waiting for deletions to finish 2025/04/14 04:40:12 INFO : There was nothing to transfer 2025/04/14 04:40:12 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/14 04:40:12 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/14 04:40:12 DEBUG : two: Destination found in --compare-dest, skipping 2025/04/14 04:40:12 DEBUG : pcloud root 'rclone-test-bafaqep0resu/dst': Waiting for checks to finish 2025/04/14 04:40:12 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/14 04:40:12 DEBUG : one: Destination found in --compare-dest, skipping 2025/04/14 04:40:12 DEBUG : pcloud root 'rclone-test-bafaqep0resu/dst': Waiting for transfers to finish 2025/04/14 04:40:12 DEBUG : Waiting for deletions to finish 2025/04/14 04:40:12 INFO : There was nothing to transfer 2025/04/14 04:40:13 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/14 04:40:13 DEBUG : two: Modification times differ by -120h0m0s: 2011-12-30 12:59:59 +0000 UTC, 2011-12-25 12:59:59 +0000 UTC 2025/04/14 04:40:13 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/14 04:40:13 DEBUG : one: Destination found in --compare-dest, skipping 2025/04/14 04:40:13 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2025/04/14 04:40:13 DEBUG : two: Destination found in --compare-dest, skipping 2025/04/14 04:40:13 DEBUG : pcloud root 'rclone-test-bafaqep0resu/dst': Waiting for checks to finish 2025/04/14 04:40:13 DEBUG : pcloud root 'rclone-test-bafaqep0resu/dst': Waiting for transfers to finish 2025/04/14 04:40:13 DEBUG : Waiting for deletions to finish 2025/04/14 04:40:13 INFO : There was nothing to transfer 2025/04/14 04:40:14 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/14 04:40:14 DEBUG : two: Sizes differ (src 5 vs dst 3) 2025/04/14 04:40:14 DEBUG : two: Need to transfer - File not found at Destination 2025/04/14 04:40:14 DEBUG : pcloud root 'rclone-test-bafaqep0resu/dst': Waiting for checks to finish 2025/04/14 04:40:14 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/04/14 04:40:14 DEBUG : one: Destination found in --compare-dest, skipping 2025/04/14 04:40:14 DEBUG : pcloud root 'rclone-test-bafaqep0resu/dst': Waiting for transfers to finish 2025/04/14 04:40:14 DEBUG : two: sha1 = a4be8877ad88f3109a6411985a1f359e10e2d930 OK 2025/04/14 04:40:14 DEBUG : two.1503b713.partial: renamed to: two 2025/04/14 04:40:14 INFO : two: Copied (new) 2025/04/14 04:40:14 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (9.51s) === RUN TestSyncMultipleCompareDest run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:40:16 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bafaqep0resu/dest" 2025/04/14 04:40:17 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bafaqep0resu/pre-dest1" 2025/04/14 04:40:17 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bafaqep0resu/pre-dest2" 2025/04/14 04:40:18 DEBUG : 1: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:40:18 DEBUG : 1: Destination found in --compare-dest, skipping 2025/04/14 04:40:19 DEBUG : 2: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:40:19 DEBUG : 2: Destination found in --compare-dest, skipping 2025/04/14 04:40:19 DEBUG : 3: Need to transfer - File not found at Destination 2025/04/14 04:40:19 DEBUG : pcloud root 'rclone-test-bafaqep0resu/dest': Waiting for checks to finish 2025/04/14 04:40:19 DEBUG : pcloud root 'rclone-test-bafaqep0resu/dest': Waiting for transfers to finish 2025/04/14 04:40:19 DEBUG : 3: sha1 = 77de68daecd823babbb58edb1c8e14d7106e83bb OK 2025/04/14 04:40:20 DEBUG : 3.b37ac6a8.partial: renamed to: 3 2025/04/14 04:40:20 INFO : 3: Copied (new) 2025/04/14 04:40:20 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (5.32s) === RUN TestSyncCopyDest run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:40:21 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bafaqep0resu/dst" 2025/04/14 04:40:22 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bafaqep0resu/CopyDest" 2025/04/14 04:40:23 DEBUG : one: Need to transfer - File not found at Destination 2025/04/14 04:40:23 DEBUG : pcloud root 'rclone-test-bafaqep0resu/dst': Waiting for checks to finish 2025/04/14 04:40:23 DEBUG : pcloud root 'rclone-test-bafaqep0resu/dst': Waiting for transfers to finish 2025/04/14 04:40:23 DEBUG : one: sha1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2025/04/14 04:40:23 DEBUG : one.b824e1ab.partial: renamed to: one 2025/04/14 04:40:23 INFO : one: Copied (new) 2025/04/14 04:40:23 DEBUG : Waiting for deletions to finish 2025/04/14 04:40:24 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/14 04:40:24 DEBUG : pcloud root 'rclone-test-bafaqep0resu/dst': Waiting for checks to finish 2025/04/14 04:40:24 DEBUG : pcloud root 'rclone-test-bafaqep0resu/dst': Waiting for transfers to finish 2025/04/14 04:40:24 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2025/04/14 04:40:24 DEBUG : one.406dcb2c.partial: renamed to: one 2025/04/14 04:40:24 INFO : one: Copied (replaced existing) 2025/04/14 04:40:24 DEBUG : Waiting for deletions to finish 2025/04/14 04:40:25 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bafaqep0resu/BackupDir" 2025/04/14 04:40:27 DEBUG : one: Need to transfer - File not found at Destination 2025/04/14 04:40:27 DEBUG : pcloud root 'rclone-test-bafaqep0resu/dst': Waiting for checks to finish 2025/04/14 04:40:27 DEBUG : pcloud root 'rclone-test-bafaqep0resu/dst': Waiting for transfers to finish 2025/04/14 04:40:27 DEBUG : one: sha1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2025/04/14 04:40:27 DEBUG : one.406dcb2c.partial: renamed to: one 2025/04/14 04:40:27 INFO : one: Copied (new) 2025/04/14 04:40:27 DEBUG : Waiting for deletions to finish fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:295: Flushing the directory cache fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:295: Flushing the directory cache fstest.go:299: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:299 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2294 Error: Should be true Test: TestSyncCopyDest Messages: listing wrong, want BackupDir/one (3), CopyDest/one (5), dst/one (5) got empty space (1), potato2 (60), potato3 (68) fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2294 Error: Should be true Test: TestSyncCopyDest Messages: Unexpected file "empty space" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2294 Error: Should be true Test: TestSyncCopyDest Messages: Unexpected file "potato2" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2294 Error: Should be true Test: TestSyncCopyDest Messages: Unexpected file "potato3" fstest.go:197: Not found "BackupDir/one" fstest.go:197: Not found "CopyDest/one" fstest.go:197: Not found "dst/one" fstest.go:200: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:200 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:304 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2294 Error: Not equal: expected: 0 actual : 3 Test: TestSyncCopyDest Messages: 3 objects not found run.go:285: Failed to put "CopyDest/two" to "pcloud root 'rclone-test-bafaqep0resu'": failed to make directory: pcloud error: File or folder already exists. (2004) --- FAIL: TestSyncCopyDest (14.82s) === RUN TestSyncBackupDir run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" run.go:285: Failed to put "dst/one" to "pcloud root 'rclone-test-bafaqep0resu'": failed to make directory: pcloud error: File or folder already exists. (2004) run.go:125: removing file "empty space" failed - try 1/3: pcloud error: File not found. (2009) run.go:125: removing file "empty space" failed - try 2/3: pcloud error: File not found. (2009) run.go:125: removing file "empty space" failed - try 3/3: pcloud error: File not found. (2009) run.go:128: removing file "empty space" failed: pcloud error: File not found. (2009) run.go:125: removing file "potato2" failed - try 1/3: pcloud error: File not found. (2009) run.go:125: removing file "potato2" failed - try 2/3: pcloud error: File not found. (2009) run.go:125: removing file "potato2" failed - try 3/3: pcloud error: File not found. (2009) run.go:128: removing file "potato2" failed: pcloud error: File not found. (2009) run.go:125: removing file "potato3" failed - try 1/3: pcloud error: File not found. (2009) run.go:125: removing file "potato3" failed - try 2/3: pcloud error: File not found. (2009) run.go:125: removing file "potato3" failed - try 3/3: pcloud error: File not found. (2009) run.go:128: removing file "potato3" failed: pcloud error: File not found. (2009) fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:295: Flushing the directory cache fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:295: Flushing the directory cache fstest.go:299: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:299 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/panic.go:629 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1006 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1090 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:285 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:292 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2371 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2427 Error: Should be true Test: TestSyncBackupDir Messages: listing wrong, want got CopyDest/one (5), dst/one (5) fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/panic.go:629 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1006 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1090 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:285 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:292 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2371 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2427 Error: Should be true Test: TestSyncBackupDir Messages: Unexpected file "CopyDest/one" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/panic.go:629 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1006 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1090 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:285 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:292 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2371 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2427 Error: Should be true Test: TestSyncBackupDir Messages: Unexpected file "dst/one" fstest.go:321: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:321 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/panic.go:629 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1006 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1090 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:285 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:292 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2371 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2427 Error: Not equal: expected: []string{} actual : []string{"CopyDest", "dst"} Diff: --- Expected +++ Actual @@ -1,2 +1,4 @@ -([]string) { +([]string) (len=2) { + (string) (len=8) "CopyDest", + (string) (len=3) "dst" } Test: TestSyncBackupDir Messages: directories --- FAIL: TestSyncBackupDir (18.78s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:295: Flushing the directory cache fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:295: Flushing the directory cache fstest.go:299: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:299 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2377 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2431 Error: Should be true Test: TestSyncBackupDirWithSuffix Messages: listing wrong, want dst/one (3), dst/three.txt (5), dst/two (3) got CompareDest/one (5), CompareDest/two (3), dst/one (3) fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2377 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2431 Error: Should be true Test: TestSyncBackupDirWithSuffix Messages: Unexpected file "CompareDest/one" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2377 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2431 Error: Should be true Test: TestSyncBackupDirWithSuffix Messages: Unexpected file "CompareDest/two" fstest.go:197: Not found "dst/two" fstest.go:197: Not found "dst/three.txt" fstest.go:200: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:200 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:304 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2377 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2431 Error: Not equal: expected: 0 actual : 2 Test: TestSyncBackupDirWithSuffix Messages: 2 objects not found 2025/04/14 04:41:03 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bafaqep0resu/dst" 2025/04/14 04:41:03 DEBUG : Config file has changed externally - reloading 2025/04/14 04:41:03 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bafaqep0resu/backup" 2025/04/14 04:41:04 DEBUG : one: Need to transfer - File not found at Destination 2025/04/14 04:41:04 DEBUG : two: Need to transfer - File not found at Destination 2025/04/14 04:41:04 ERROR : pcloud root 'rclone-test-bafaqep0resu/dst': error reading destination root directory: couldn't list files: pcloud error: Directory does not exist. (2005) 2025/04/14 04:41:04 DEBUG : pcloud root 'rclone-test-bafaqep0resu/dst': Waiting for checks to finish 2025/04/14 04:41:04 DEBUG : pcloud root 'rclone-test-bafaqep0resu/dst': Waiting for transfers to finish 2025/04/14 04:46:05 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=one.a87a5b8d.partial&folderid=16358073381&mtime=1324817999&nopartial=1": net/http: timeout awaiting response headers) 2025/04/14 04:46:05 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/04/14 04:46:05 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=two.b824e1ab.partial&folderid=16358073381&mtime=981173106&nopartial=1": net/http: timeout awaiting response headers) 2025/04/14 04:46:05 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2025/04/14 04:46:05 DEBUG : pacer: Reducing sleep to 30ms 2025/04/14 04:46:05 DEBUG : pacer: Reducing sleep to 22.5ms 2025/04/14 04:46:06 DEBUG : pacer: Reducing sleep to 16.875ms 2025/04/14 04:46:06 DEBUG : pacer: Reducing sleep to 12.65625ms 2025/04/14 04:46:07 DEBUG : pacer: Reducing sleep to 10ms 2025/04/14 04:46:10 DEBUG : one: Received error: Put "https://eapi.pcloud.com/uploadfile?filename=one.a87a5b8d.partial&folderid=16358073381&mtime=1324817999&nopartial=1": net/http: timeout awaiting response headers - low level retry 0/10 2025/04/14 04:46:10 DEBUG : two: Received error: Put "https://eapi.pcloud.com/uploadfile?filename=two.b824e1ab.partial&folderid=16358073381&mtime=981173106&nopartial=1": net/http: timeout awaiting response headers - low level retry 0/10 2025/04/14 04:46:15 ERROR : two: Failed to copy: pcloud error: Directory does not exist. (2005) 2025/04/14 04:46:16 INFO : two.b824e1ab.partial: Failed to remove failed partial copy: couldn't list files: pcloud error: Directory does not exist. (2005) 2025/04/14 04:46:16 ERROR : one: Failed to copy: pcloud error: Directory does not exist. (2005) 2025/04/14 04:46:16 INFO : one.a87a5b8d.partial: Failed to remove failed partial copy: couldn't list files: pcloud error: Directory does not exist. (2005) 2025/04/14 04:46:16 ERROR : pcloud root 'rclone-test-bafaqep0resu/dst': not deleting files as there were IO errors 2025/04/14 04:46:16 ERROR : pcloud root 'rclone-test-bafaqep0resu/dst': not deleting directories as there were IO errors sync_test.go:2385: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2385 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2431 Error: Received unexpected error: pcloud error: Directory does not exist. (2005) Test: TestSyncBackupDirWithSuffix fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestSyncBackupDirWithSuffix (330.81s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:46:26 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bafaqep0resu/dst" 2025/04/14 04:46:26 DEBUG : Config file has changed externally - reloading 2025/04/14 04:46:26 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bafaqep0resu/backup" 2025/04/14 04:46:27 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/14 04:46:27 DEBUG : pcloud root 'rclone-test-bafaqep0resu/dst': Waiting for checks to finish 2025/04/14 04:46:27 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:46:27 DEBUG : two: Unchanged skipping 2025/04/14 04:46:28 INFO : one: Moved (server-side) to: one-2019-01-01 2025/04/14 04:46:28 DEBUG : pcloud root 'rclone-test-bafaqep0resu/dst': Waiting for transfers to finish 2025/04/14 04:46:28 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2025/04/14 04:46:28 DEBUG : one.a87a5b8d.partial: renamed to: one 2025/04/14 04:46:28 INFO : one: Copied (new) 2025/04/14 04:46:28 DEBUG : Waiting for deletions to finish 2025/04/14 04:46:28 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2025/04/14 04:46:28 INFO : three.txt: Moved into backup dir 2025/04/14 04:46:29 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/04/14 04:46:29 DEBUG : pcloud root 'rclone-test-bafaqep0resu/dst': Waiting for checks to finish 2025/04/14 04:46:29 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:46:29 DEBUG : two: Unchanged skipping 2025/04/14 04:46:29 INFO : one-2019-01-01: Deleted 2025/04/14 04:46:29 INFO : one: Moved (server-side) to: one-2019-01-01 2025/04/14 04:46:29 DEBUG : pcloud root 'rclone-test-bafaqep0resu/dst': Waiting for transfers to finish 2025/04/14 04:46:30 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2025/04/14 04:46:30 DEBUG : one.1503b713.partial: renamed to: one 2025/04/14 04:46:30 INFO : one: Copied (new) 2025/04/14 04:46:30 DEBUG : Waiting for deletions to finish 2025/04/14 04:46:30 INFO : three-2019-01-01.txt: Deleted 2025/04/14 04:46:30 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2025/04/14 04:46:30 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (5.91s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:46:32 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bafaqep0resu/dst" 2025/04/14 04:46:32 DEBUG : Config file has changed externally - reloading 2025/04/14 04:46:33 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/14 04:46:33 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:46:33 DEBUG : two: Unchanged skipping 2025/04/14 04:46:33 DEBUG : pcloud root 'rclone-test-bafaqep0resu/dst': Waiting for checks to finish 2025/04/14 04:46:33 INFO : one: Moved (server-side) to: one.bak 2025/04/14 04:46:33 DEBUG : pcloud root 'rclone-test-bafaqep0resu/dst': Waiting for transfers to finish 2025/04/14 04:46:33 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2025/04/14 04:46:33 DEBUG : one.a87a5b8d.partial: renamed to: one 2025/04/14 04:46:33 INFO : one: Copied (new) 2025/04/14 04:46:33 DEBUG : Waiting for deletions to finish 2025/04/14 04:46:33 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/04/14 04:46:33 INFO : three.txt: Moved into backup dir 2025/04/14 04:46:35 DEBUG : one.bak: Excluded (Path Filter) 2025/04/14 04:46:35 DEBUG : three.txt.bak: Excluded (Path Filter) 2025/04/14 04:46:35 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/04/14 04:46:35 DEBUG : pcloud root 'rclone-test-bafaqep0resu/dst': Waiting for checks to finish 2025/04/14 04:46:35 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:46:35 DEBUG : two: Unchanged skipping 2025/04/14 04:46:35 INFO : one.bak: Deleted 2025/04/14 04:46:36 INFO : one: Moved (server-side) to: one.bak 2025/04/14 04:46:36 DEBUG : pcloud root 'rclone-test-bafaqep0resu/dst': Waiting for transfers to finish 2025/04/14 04:46:36 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2025/04/14 04:46:36 DEBUG : one.1503b713.partial: renamed to: one 2025/04/14 04:46:36 INFO : one: Copied (new) 2025/04/14 04:46:36 DEBUG : Waiting for deletions to finish 2025/04/14 04:46:36 INFO : three.txt.bak: Deleted 2025/04/14 04:46:36 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/04/14 04:46:36 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (6.49s) === RUN TestSyncSuffix run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:46:39 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bafaqep0resu/dst" 2025/04/14 04:46:39 DEBUG : Config file has changed externally - reloading 2025/04/14 04:46:40 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/14 04:46:40 INFO : one: Moved (server-side) to: one.bak 2025/04/14 04:46:40 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2025/04/14 04:46:40 DEBUG : one.a87a5b8d.partial: renamed to: one 2025/04/14 04:46:40 INFO : one: Copied (new) 2025/04/14 04:46:40 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:46:40 DEBUG : two: Unchanged skipping 2025/04/14 04:46:40 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/04/14 04:46:41 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/04/14 04:46:41 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2025/04/14 04:46:41 DEBUG : three.txt.468f3f0c.partial: renamed to: three.txt 2025/04/14 04:46:41 INFO : three.txt: Copied (new) 2025/04/14 04:46:43 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/04/14 04:46:43 INFO : one.bak: Deleted 2025/04/14 04:46:43 INFO : one: Moved (server-side) to: one.bak 2025/04/14 04:46:43 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2025/04/14 04:46:43 DEBUG : one.1503b713.partial: renamed to: one 2025/04/14 04:46:43 INFO : one: Copied (new) 2025/04/14 04:46:44 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:46:44 DEBUG : two: Unchanged skipping 2025/04/14 04:46:44 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2025/04/14 04:46:44 INFO : three.txt.bak: Deleted 2025/04/14 04:46:45 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/04/14 04:46:45 DEBUG : three.txt: sha1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK 2025/04/14 04:46:45 DEBUG : three.txt.ff911d53.partial: renamed to: three.txt 2025/04/14 04:46:45 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (9.21s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:46:48 DEBUG : Creating backend with remote "TestPcloud:rclone-test-bafaqep0resu/dst" 2025/04/14 04:46:48 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/14 04:46:49 INFO : one: Moved (server-side) to: one-2019-01-01 2025/04/14 04:46:49 DEBUG : one: sha1 = d63a9910ed57f038b76549c070df6196b2102f42 OK 2025/04/14 04:46:49 DEBUG : one.a87a5b8d.partial: renamed to: one 2025/04/14 04:46:49 INFO : one: Copied (new) 2025/04/14 04:46:49 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:46:49 DEBUG : two: Unchanged skipping 2025/04/14 04:46:49 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/04/14 04:46:49 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2025/04/14 04:46:50 DEBUG : three.txt: sha1 = 92e0258fe3c7456f15dff78d509f6e3c9166c254 OK 2025/04/14 04:46:51 DEBUG : three.txt.468f3f0c.partial: renamed to: three.txt 2025/04/14 04:46:51 INFO : three.txt: Copied (new) fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:295: Flushing the directory cache fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:295: Flushing the directory cache fstest.go:299: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:299 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2491 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2524 Error: Should be true Test: TestSyncSuffixKeepExtension Messages: listing wrong, want dst/one (4), dst/one-2019-01-01 (3), dst/three-2019-01-01.txt (5), dst/three.txt (6), dst/two (3) got fstest.go:197: Not found "dst/one-2019-01-01" fstest.go:197: Not found "dst/two" fstest.go:197: Not found "dst/three-2019-01-01.txt" fstest.go:197: Not found "dst/one" fstest.go:197: Not found "dst/three.txt" fstest.go:200: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:200 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:304 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2491 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2524 Error: Not equal: expected: 0 actual : 5 Test: TestSyncSuffixKeepExtension Messages: 5 objects not found 2025/04/14 04:46:59 DEBUG : one: Need to transfer - File not found at Destination 2025/04/14 04:47:00 DEBUG : one: sha1 = 88a8c2880f555638f990d1ec4c8359b25caa20c7 OK 2025/04/14 04:47:00 DEBUG : one.1503b713.partial: renamed to: one 2025/04/14 04:47:00 INFO : one: Copied (new) 2025/04/14 04:47:00 DEBUG : two: Need to transfer - File not found at Destination 2025/04/14 04:47:00 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2025/04/14 04:47:00 DEBUG : two.b824e1ab.partial: renamed to: two 2025/04/14 04:47:00 INFO : two: Copied (new) 2025/04/14 04:47:00 DEBUG : three.txt: Need to transfer - File not found at Destination 2025/04/14 04:47:00 DEBUG : three.txt: sha1 = 476e1707cbd7f0497a7dc4d44f0b07b8566ffc30 OK 2025/04/14 04:47:00 DEBUG : three.txt.ff911d53.partial: renamed to: three.txt 2025/04/14 04:47:00 INFO : three.txt: Copied (new) fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:295: Flushing the directory cache fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:295: Flushing the directory cache fstest.go:299: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:299 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2521 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2524 Error: Should be true Test: TestSyncSuffixKeepExtension Messages: listing wrong, want dst/one (5), dst/one-2019-01-01 (4), dst/three-2019-01-01.txt (6), dst/three.txt (19), dst/two (3) got fstest.go:197: Not found "dst/two" fstest.go:197: Not found "dst/three-2019-01-01.txt" fstest.go:197: Not found "dst/one-2019-01-01" fstest.go:197: Not found "dst/one" fstest.go:197: Not found "dst/three.txt" fstest.go:200: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:200 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:304 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2521 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2524 Error: Not equal: expected: 0 actual : 5 Test: TestSyncSuffixKeepExtension Messages: 5 objects not found --- FAIL: TestSyncSuffixKeepExtension (21.73s) === RUN TestSyncUTFNorm run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:295: Flushing the directory cache fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:295: Flushing the directory cache fstest.go:299: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:299 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2545 Error: Should be true Test: TestSyncUTFNorm Messages: listing wrong, want Testêé (18) got fstest.go:197: Not found "Testêé" fstest.go:200: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:200 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:304 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2545 Error: Not equal: expected: 0 actual : 1 Test: TestSyncUTFNorm Messages: 1 objects not found 2025/04/14 04:47:18 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2025/04/14 04:47:18 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:47:18 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:47:18 DEBUG : Testêé: sha1 = a54d88e06612d820bc3be72877c74f257b561b19 OK 2025/04/14 04:47:18 DEBUG : Testêé.53508f02.partial: renamed to: Testêé 2025/04/14 04:47:18 INFO : Testêé: Copied (replaced existing) to: Testêé 2025/04/14 04:47:18 DEBUG : Waiting for deletions to finish 2025/04/14 04:47:18 INFO : dst/one-2019-01-01: Deleted 2025/04/14 04:47:18 INFO : dst/three-2019-01-01.txt: Deleted 2025/04/14 04:47:18 INFO : dst/three.txt: Deleted 2025/04/14 04:47:18 INFO : dst/two: Deleted 2025/04/14 04:47:18 INFO : dst/one: Deleted 2025/04/14 04:47:18 INFO : dst: Removing directory 2025/04/14 04:47:18 DEBUG : pcloud root 'rclone-test-bafaqep0resu': deleted 1 directories --- FAIL: TestSyncUTFNorm (10.41s) === RUN TestSyncImmutable run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:47:19 DEBUG : existing: Need to transfer - File not found at Destination 2025/04/14 04:47:19 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:47:19 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:47:19 DEBUG : existing: sha1 = 3e2e95f5ad970eadfa7e17eaf73da97024aa5359 OK 2025/04/14 04:47:19 DEBUG : existing.468f3f0c.partial: renamed to: existing 2025/04/14 04:47:19 INFO : existing: Copied (new) 2025/04/14 04:47:19 DEBUG : Waiting for deletions to finish run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:47:20 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2025/04/14 04:47:20 ERROR : existing: Source and destination exist but do not match: immutable file modified 2025/04/14 04:47:20 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:47:20 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:47:20 ERROR : pcloud root 'rclone-test-bafaqep0resu': not deleting files as there were IO errors 2025/04/14 04:47:20 ERROR : pcloud root 'rclone-test-bafaqep0resu': not deleting directories as there were IO errors run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestSyncImmutable (1.61s) === RUN TestSyncIgnoreCase run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:47:21 DEBUG : existing: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:21 DEBUG : existing: Unchanged skipping 2025/04/14 04:47:21 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:47:21 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:47:21 DEBUG : Waiting for deletions to finish 2025/04/14 04:47:21 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (0.80s) === RUN TestFixCase run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" sync_test.go:2635: Skipping test as local or remote are case-sensitive --- SKIP: TestFixCase (0.17s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" sync_test.go:2674: This test only runs on local === RUN TestMaxTransfer/Soft run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" sync_test.go:2674: This test only runs on local === RUN TestMaxTransfer/Cautious run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" sync_test.go:2674: This test only runs on local --- PASS: TestMaxTransfer (0.49s) --- SKIP: TestMaxTransfer/Hard (0.17s) --- SKIP: TestMaxTransfer/Soft (0.17s) --- SKIP: TestMaxTransfer/Cautious (0.16s) === RUN TestSyncConcurrentDelete run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:47:31 DEBUG : both0: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:31 DEBUG : both1: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:31 DEBUG : both10: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:31 DEBUG : both11: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:31 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:47:31 DEBUG : both0: Unchanged skipping 2025/04/14 04:47:31 DEBUG : both12: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:31 DEBUG : both12: Unchanged skipping 2025/04/14 04:47:31 DEBUG : both13: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:31 DEBUG : both1: Unchanged skipping 2025/04/14 04:47:31 DEBUG : both14: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:31 DEBUG : both14: Unchanged skipping 2025/04/14 04:47:31 DEBUG : both15: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:31 DEBUG : both15: Unchanged skipping 2025/04/14 04:47:31 DEBUG : both16: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:31 DEBUG : both16: Unchanged skipping 2025/04/14 04:47:31 DEBUG : both17: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:31 DEBUG : both17: Unchanged skipping 2025/04/14 04:47:31 DEBUG : both18: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:31 DEBUG : both18: Unchanged skipping 2025/04/14 04:47:31 DEBUG : both19: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:31 DEBUG : both19: Unchanged skipping 2025/04/14 04:47:31 DEBUG : both2: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:31 DEBUG : both2: Unchanged skipping 2025/04/14 04:47:31 DEBUG : both3: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:31 DEBUG : both3: Unchanged skipping 2025/04/14 04:47:31 DEBUG : both4: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:31 DEBUG : both4: Unchanged skipping 2025/04/14 04:47:31 DEBUG : both5: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:31 DEBUG : both5: Unchanged skipping 2025/04/14 04:47:31 DEBUG : both6: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:31 DEBUG : both6: Unchanged skipping 2025/04/14 04:47:31 DEBUG : both7: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:31 DEBUG : both7: Unchanged skipping 2025/04/14 04:47:31 DEBUG : both8: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:31 DEBUG : both8: Unchanged skipping 2025/04/14 04:47:31 DEBUG : both9: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:31 DEBUG : both9: Unchanged skipping 2025/04/14 04:47:31 DEBUG : both10: Unchanged skipping 2025/04/14 04:47:31 DEBUG : both11: Unchanged skipping 2025/04/14 04:47:31 DEBUG : both13: Unchanged skipping 2025/04/14 04:47:31 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:47:31 DEBUG : Waiting for deletions to finish 2025/04/14 04:47:32 INFO : only10: Deleted 2025/04/14 04:47:32 INFO : only2: Deleted 2025/04/14 04:47:32 INFO : only18: Deleted 2025/04/14 04:47:32 INFO : only14: Deleted 2025/04/14 04:47:32 INFO : only19: Deleted 2025/04/14 04:47:32 INFO : only5: Deleted 2025/04/14 04:47:32 INFO : only7: Deleted 2025/04/14 04:47:32 INFO : only1: Deleted 2025/04/14 04:47:32 INFO : only11: Deleted 2025/04/14 04:47:32 INFO : only12: Deleted 2025/04/14 04:47:32 INFO : only13: Deleted 2025/04/14 04:47:32 INFO : only16: Deleted 2025/04/14 04:47:32 INFO : only9: Deleted 2025/04/14 04:47:32 INFO : only0: Deleted 2025/04/14 04:47:32 INFO : only15: Deleted 2025/04/14 04:47:32 INFO : only17: Deleted 2025/04/14 04:47:32 INFO : only3: Deleted 2025/04/14 04:47:32 INFO : only4: Deleted 2025/04/14 04:47:32 INFO : only8: Deleted 2025/04/14 04:47:32 INFO : only6: Deleted 2025/04/14 04:47:32 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestSyncConcurrentDelete (14.04s) === RUN TestSyncConcurrentTruncate run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:47:45 DEBUG : both1: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:45 DEBUG : both0: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:45 DEBUG : both10: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:45 DEBUG : both11: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:45 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for checks to finish 2025/04/14 04:47:45 DEBUG : both1: Unchanged skipping 2025/04/14 04:47:45 DEBUG : both12: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:45 DEBUG : both12: Unchanged skipping 2025/04/14 04:47:45 DEBUG : both13: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:45 DEBUG : both0: Unchanged skipping 2025/04/14 04:47:45 DEBUG : both14: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:45 DEBUG : both14: Unchanged skipping 2025/04/14 04:47:45 DEBUG : both15: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:45 DEBUG : both15: Unchanged skipping 2025/04/14 04:47:45 DEBUG : both16: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:45 DEBUG : both16: Unchanged skipping 2025/04/14 04:47:45 DEBUG : both17: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:45 DEBUG : both17: Unchanged skipping 2025/04/14 04:47:45 DEBUG : both18: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:45 DEBUG : both18: Unchanged skipping 2025/04/14 04:47:45 DEBUG : both19: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:45 DEBUG : both19: Unchanged skipping 2025/04/14 04:47:45 DEBUG : both2: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:45 DEBUG : both2: Unchanged skipping 2025/04/14 04:47:45 DEBUG : both3: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:45 DEBUG : both3: Unchanged skipping 2025/04/14 04:47:45 DEBUG : both4: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:45 DEBUG : both4: Unchanged skipping 2025/04/14 04:47:45 DEBUG : both5: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:45 DEBUG : both5: Unchanged skipping 2025/04/14 04:47:45 DEBUG : both6: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:45 DEBUG : both6: Unchanged skipping 2025/04/14 04:47:45 DEBUG : both7: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:45 DEBUG : both7: Unchanged skipping 2025/04/14 04:47:45 DEBUG : both8: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:45 DEBUG : both8: Unchanged skipping 2025/04/14 04:47:45 DEBUG : both9: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/04/14 04:47:45 DEBUG : both9: Unchanged skipping 2025/04/14 04:47:45 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2025/04/14 04:47:45 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2025/04/14 04:47:45 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2025/04/14 04:47:45 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2025/04/14 04:47:45 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2025/04/14 04:47:45 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2025/04/14 04:47:45 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2025/04/14 04:47:45 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2025/04/14 04:47:45 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2025/04/14 04:47:45 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2025/04/14 04:47:45 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2025/04/14 04:47:45 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2025/04/14 04:47:45 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2025/04/14 04:47:45 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2025/04/14 04:47:45 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2025/04/14 04:47:45 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2025/04/14 04:47:45 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2025/04/14 04:47:45 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2025/04/14 04:47:45 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2025/04/14 04:47:45 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2025/04/14 04:47:45 DEBUG : both10: Unchanged skipping 2025/04/14 04:47:45 DEBUG : both11: Unchanged skipping 2025/04/14 04:47:45 DEBUG : both13: Unchanged skipping 2025/04/14 04:47:45 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Waiting for transfers to finish 2025/04/14 04:47:45 DEBUG : only0: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/04/14 04:47:45 DEBUG : only10: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/04/14 04:47:45 DEBUG : only11: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/04/14 04:47:45 DEBUG : only0.5b6d5609.partial: renamed to: only0 2025/04/14 04:47:45 INFO : only0: Copied (replaced existing) 2025/04/14 04:47:45 DEBUG : only10.5b6d5609.partial: renamed to: only10 2025/04/14 04:47:45 INFO : only10: Copied (replaced existing) 2025/04/14 04:47:45 DEBUG : only11.5b6d5609.partial: renamed to: only11 2025/04/14 04:47:45 INFO : only11: Copied (replaced existing) 2025/04/14 04:47:45 DEBUG : only1: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/04/14 04:47:45 DEBUG : only12: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/04/14 04:47:45 DEBUG : only12.5b6d5609.partial: renamed to: only12 2025/04/14 04:47:45 INFO : only12: Copied (replaced existing) 2025/04/14 04:47:46 DEBUG : only13: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/04/14 04:47:46 DEBUG : only15: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/04/14 04:47:46 DEBUG : only1.5b6d5609.partial: renamed to: only1 2025/04/14 04:47:46 INFO : only1: Copied (replaced existing) 2025/04/14 04:47:46 DEBUG : only15.5b6d5609.partial: renamed to: only15 2025/04/14 04:47:46 INFO : only15: Copied (replaced existing) 2025/04/14 04:47:46 DEBUG : only16: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/04/14 04:47:46 DEBUG : only17: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/04/14 04:47:46 DEBUG : only16.5b6d5609.partial: renamed to: only16 2025/04/14 04:47:46 INFO : only16: Copied (replaced existing) 2025/04/14 04:47:46 DEBUG : only17.5b6d5609.partial: renamed to: only17 2025/04/14 04:47:46 INFO : only17: Copied (replaced existing) 2025/04/14 04:47:46 DEBUG : only18: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/04/14 04:47:46 DEBUG : only19: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/04/14 04:47:46 DEBUG : only19.5b6d5609.partial: renamed to: only19 2025/04/14 04:47:46 INFO : only19: Copied (replaced existing) 2025/04/14 04:47:46 DEBUG : only2: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/04/14 04:47:46 DEBUG : only14: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/04/14 04:47:46 DEBUG : only2.5b6d5609.partial: renamed to: only2 2025/04/14 04:47:46 INFO : only2: Copied (replaced existing) 2025/04/14 04:47:47 DEBUG : only14.5b6d5609.partial: renamed to: only14 2025/04/14 04:47:47 INFO : only14: Copied (replaced existing) 2025/04/14 04:47:47 DEBUG : only3: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/04/14 04:47:47 DEBUG : only4: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/04/14 04:47:47 DEBUG : only3.5b6d5609.partial: renamed to: only3 2025/04/14 04:47:47 INFO : only3: Copied (replaced existing) 2025/04/14 04:47:47 DEBUG : only13.5b6d5609.partial: renamed to: only13 2025/04/14 04:47:47 INFO : only13: Copied (replaced existing) 2025/04/14 04:47:47 DEBUG : only4.5b6d5609.partial: renamed to: only4 2025/04/14 04:47:47 INFO : only4: Copied (replaced existing) 2025/04/14 04:47:47 DEBUG : only5: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/04/14 04:47:47 DEBUG : only6: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/04/14 04:47:47 DEBUG : only7: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/04/14 04:47:47 DEBUG : only5.5b6d5609.partial: renamed to: only5 2025/04/14 04:47:47 INFO : only5: Copied (replaced existing) 2025/04/14 04:47:47 DEBUG : only6.5b6d5609.partial: renamed to: only6 2025/04/14 04:47:47 INFO : only6: Copied (replaced existing) 2025/04/14 04:47:47 DEBUG : only8: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/04/14 04:47:47 DEBUG : only9: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/04/14 04:47:47 DEBUG : only18.5b6d5609.partial: renamed to: only18 2025/04/14 04:47:47 INFO : only18: Copied (replaced existing) 2025/04/14 04:47:47 DEBUG : only8.5b6d5609.partial: renamed to: only8 2025/04/14 04:47:47 INFO : only8: Copied (replaced existing) 2025/04/14 04:47:47 DEBUG : only9.5b6d5609.partial: renamed to: only9 2025/04/14 04:47:47 INFO : only9: Copied (replaced existing) 2025/04/14 04:47:48 DEBUG : only7.5b6d5609.partial: renamed to: only7 2025/04/14 04:47:48 INFO : only7: Copied (replaced existing) 2025/04/14 04:47:48 DEBUG : Waiting for deletions to finish run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:295: Flushing the directory cache fstest.go:286: Sleeping for 7s just to make sure run.go:125: removing file "both4" failed - try 1/3: pcloud error: File not found. (2009) run.go:125: removing file "both6" failed - try 1/3: pcloud error: File not found. (2009) run.go:125: removing file "both7" failed - try 1/3: pcloud error: File not found. (2009) run.go:125: removing file "both7" failed - try 2/3: pcloud error: File not found. (2009) run.go:125: removing file "both7" failed - try 3/3: pcloud error: File not found. (2009) run.go:128: removing file "both7" failed: pcloud error: File not found. (2009) run.go:125: removing file "both9" failed - try 1/3: pcloud error: File not found. (2009) run.go:125: removing file "both9" failed - try 2/3: pcloud error: File not found. (2009) run.go:125: removing file "only4" failed - try 1/3: pcloud error: File not found. (2009) fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:295: Flushing the directory cache fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:295: Flushing the directory cache fstest.go:299: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:299 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncConcurrentTruncate Messages: listing wrong, want got both10 (6), both11 (6), both12 (6), both13 (6), both14 (6), both15 (6), both16 (6), both17 (6), both18 (6), both19 (6), only0 (0), only1 (0), only10 (0), only11 (0), only12 (0), only13 (0), only14 (0), only15 (0), only16 (0), only17 (0), only18 (0), only19 (0), only2 (0), only3 (0), only4 (0), only5 (0), only6 (0), only7 (0), only8 (0), only9 (0) fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "both10" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "both11" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "both12" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "both13" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "both14" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "both15" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "both16" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "both17" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "both18" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "both19" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "only0" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "only1" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "only10" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "only11" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "only12" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "only13" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "only14" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "only15" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "only16" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "only17" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "only18" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "only19" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "only2" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "only3" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "only4" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "only5" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "only6" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "only7" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "only8" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:173 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1176 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1354 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1684 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "only9" --- FAIL: TestSyncConcurrentTruncate (50.21s) === RUN TestSyncReplaceDirModTime run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:48:26 DEBUG : empty_dir: Making directory with metadata 2025/04/14 04:48:26 INFO : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/14 04:48:26 DEBUG : empty_on_remote: Making directory with metadata 2025/04/14 04:48:26 INFO : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/14 04:48:26 INFO : empty_on_remote: Making directory 2025/04/14 04:48:27 INFO : empty_on_remote: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:48:28 INFO : test_dir1: Set directory modification time (using DirSetModTime) 2025/04/14 04:48:28 INFO : test_dir2: Set directory modification time (using DirSetModTime) 2025/04/14 04:48:28 INFO : test_dir2/sub_dir: Set directory modification time (using DirSetModTime) 2025/04/14 04:48:28 INFO : empty_on_remote: Set directory modification time (using DirSetModTime) run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:295: Flushing the directory cache fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:295: Flushing the directory cache fstest.go:299: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:299 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2826 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2833 Error: Should be true Test: TestSyncReplaceDirModTime Messages: listing wrong, want file1 (5), test_dir1/file2 (5), test_dir2/sub_dir/file3 (5) got both10 (6), both11 (6), both12 (6), both13 (6), both14 (6), both15 (6), both16 (6), both17 (6), both18 (6), both19 (6), file1 (5), only0 (0), only1 (0), only10 (0), only11 (0), only12 (0), only13 (0), only14 (0), only15 (0), only16 (0), only17 (0), only18 (0), only19 (0), only2 (0), only3 (0), only4 (0), only5 (0), only6 (0), only7 (0), only8 (0), only9 (0), test_dir1/file2 (5), test_dir2/sub_dir/file3 (5) fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2826 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2833 Error: Should be true Test: TestSyncReplaceDirModTime Messages: Unexpected file "both10" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2826 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2833 Error: Should be true Test: TestSyncReplaceDirModTime Messages: Unexpected file "both11" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2826 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2833 Error: Should be true Test: TestSyncReplaceDirModTime Messages: Unexpected file "both12" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2826 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2833 Error: Should be true Test: TestSyncReplaceDirModTime Messages: Unexpected file "both13" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2826 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2833 Error: Should be true Test: TestSyncReplaceDirModTime Messages: Unexpected file "both14" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2826 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2833 Error: Should be true Test: TestSyncReplaceDirModTime Messages: Unexpected file "both15" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2826 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2833 Error: Should be true Test: TestSyncReplaceDirModTime Messages: Unexpected file "both16" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2826 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2833 Error: Should be true Test: TestSyncReplaceDirModTime Messages: Unexpected file "both17" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2826 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2833 Error: Should be true Test: TestSyncReplaceDirModTime Messages: Unexpected file "both18" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2826 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2833 Error: Should be true Test: TestSyncReplaceDirModTime Messages: Unexpected file "both19" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2826 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2833 Error: Should be true Test: TestSyncReplaceDirModTime Messages: Unexpected file "only0" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2826 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2833 Error: Should be true Test: TestSyncReplaceDirModTime Messages: Unexpected file "only1" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2826 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2833 Error: Should be true Test: TestSyncReplaceDirModTime Messages: Unexpected file "only10" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2826 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2833 Error: Should be true Test: TestSyncReplaceDirModTime Messages: Unexpected file "only11" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2826 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2833 Error: Should be true Test: TestSyncReplaceDirModTime Messages: Unexpected file "only12" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2826 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2833 Error: Should be true Test: TestSyncReplaceDirModTime Messages: Unexpected file "only13" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2826 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2833 Error: Should be true Test: TestSyncReplaceDirModTime Messages: Unexpected file "only14" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2826 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2833 Error: Should be true Test: TestSyncReplaceDirModTime Messages: Unexpected file "only15" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2826 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2833 Error: Should be true Test: TestSyncReplaceDirModTime Messages: Unexpected file "only16" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2826 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2833 Error: Should be true Test: TestSyncReplaceDirModTime Messages: Unexpected file "only17" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2826 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2833 Error: Should be true Test: TestSyncReplaceDirModTime Messages: Unexpected file "only18" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2826 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2833 Error: Should be true Test: TestSyncReplaceDirModTime Messages: Unexpected file "only19" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2826 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2833 Error: Should be true Test: TestSyncReplaceDirModTime Messages: Unexpected file "only2" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2826 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2833 Error: Should be true Test: TestSyncReplaceDirModTime Messages: Unexpected file "only3" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2826 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2833 Error: Should be true Test: TestSyncReplaceDirModTime Messages: Unexpected file "only4" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2826 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2833 Error: Should be true Test: TestSyncReplaceDirModTime Messages: Unexpected file "only5" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2826 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2833 Error: Should be true Test: TestSyncReplaceDirModTime Messages: Unexpected file "only6" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2826 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2833 Error: Should be true Test: TestSyncReplaceDirModTime Messages: Unexpected file "only7" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2826 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2833 Error: Should be true Test: TestSyncReplaceDirModTime Messages: Unexpected file "only8" fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2826 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2833 Error: Should be true Test: TestSyncReplaceDirModTime Messages: Unexpected file "only9" --- FAIL: TestSyncReplaceDirModTime (14.37s) === RUN TestSyncReplaceDirModTimeWithEmptyDirs run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:48:41 DEBUG : empty_dir: Making directory with metadata 2025/04/14 04:48:41 INFO : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/14 04:48:41 DEBUG : empty_on_remote: Making directory with metadata 2025/04/14 04:48:41 INFO : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/14 04:48:41 INFO : empty_on_remote: Making directory 2025/04/14 04:48:41 INFO : empty_on_remote: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:48:42 INFO : test_dir1: Set directory modification time (using DirSetModTime) 2025/04/14 04:48:42 INFO : test_dir2: Set directory modification time (using DirSetModTime) 2025/04/14 04:48:42 INFO : test_dir2/sub_dir: Set directory modification time (using DirSetModTime) 2025/04/14 04:48:42 INFO : empty_on_remote: Set directory modification time (using DirSetModTime) 2025/04/14 04:48:42 INFO : empty_dir: Set directory modification time (using DirSetModTime) run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestSyncReplaceDirModTimeWithEmptyDirs (2.78s) === RUN TestNothingToTransferWithEmptyDirs run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:48:43 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/04/14 04:48:43 INFO : sub dir: Making directory 2025/04/14 04:48:44 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestNothingToTransferWithEmptyDirs (3.83s) === RUN TestNothingToTransferWithoutEmptyDirs run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" 2025/04/14 04:48:47 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/04/14 04:48:47 INFO : sub dir: Making directory 2025/04/14 04:48:47 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-bafaqep0resu'", Local "Local file system at /tmp/rclone2607998092", Modify Window "1s" --- PASS: TestNothingToTransferWithoutEmptyDirs (4.08s) FAIL 2025/04/14 04:48:51 DEBUG : pcloud root 'rclone-test-bafaqep0resu': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose -fast-list" - Finished ERROR in 11m37.899223482s (try 1/5): exit status 1: Failed [TestServerSideCopyOverSelf TestMoveOverSelf TestServerSideMoveOverSelf TestCopyAfterDelete TestCopyRedownload TestSyncBasedOnCheckSum TestSyncIgnoreErrors TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors TestSyncDeleteDuring TestSyncDeleteBefore TestSyncOverlapWithFilter TestSyncCopyDest TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncSuffixKeepExtension TestSyncUTFNorm TestSyncConcurrentTruncate TestSyncReplaceDirModTime]