"./sync.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose" - Starting (try 1/5) 2026/10/14 04:12:03 DEBUG : Creating backend with remote "TestPcloud:rclone-test-daziwin0fiya" 2026/10/14 04:12:03 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/10/14 04:12:04 DEBUG : Creating backend with remote "/tmp/rclone3078811046" === RUN TestPipe --- PASS: TestPipe (0.00s) === RUN TestPipeConcurrent --- PASS: TestPipeConcurrent (0.03s) === RUN TestPipeOrderBy === RUN TestPipeOrderBy/#00 === RUN TestPipeOrderBy/size === RUN TestPipeOrderBy/name === RUN TestPipeOrderBy/modtime === RUN TestPipeOrderBy/size,ascending === RUN TestPipeOrderBy/name,asc === RUN TestPipeOrderBy/modtime,ascending === RUN TestPipeOrderBy/size,descending === RUN TestPipeOrderBy/name,desc === RUN TestPipeOrderBy/modtime,descending === RUN TestPipeOrderBy/size,mixed,50 === RUN TestPipeOrderBy/size,mixed,51 --- PASS: TestPipeOrderBy (0.00s) --- PASS: TestPipeOrderBy/#00 (0.00s) --- PASS: TestPipeOrderBy/size (0.00s) --- PASS: TestPipeOrderBy/name (0.00s) --- PASS: TestPipeOrderBy/modtime (0.00s) --- PASS: TestPipeOrderBy/size,ascending (0.00s) --- PASS: TestPipeOrderBy/name,asc (0.00s) --- PASS: TestPipeOrderBy/modtime,ascending (0.00s) --- PASS: TestPipeOrderBy/size,descending (0.00s) --- PASS: TestPipeOrderBy/name,desc (0.00s) --- PASS: TestPipeOrderBy/modtime,descending (0.00s) --- PASS: TestPipeOrderBy/size,mixed,50 (0.00s) --- PASS: TestPipeOrderBy/size,mixed,51 (0.00s) === RUN TestNewLess === RUN TestNewLess/blankOK === RUN TestNewLess/tooManyParts === RUN TestNewLess/tooManyParts2 === RUN TestNewLess/badMixed === RUN TestNewLess/unknownComparison === RUN TestNewLess/unknownSortDirection === RUN TestNewLess/patternNeedsGlob === RUN TestNewLess/patternRejectsEmptyGlob === RUN TestNewLess/patternRejectsBadGlob === RUN TestNewLess/patternOrder === 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/patternNeedsGlob (0.00s) --- PASS: TestNewLess/patternRejectsEmptyGlob (0.00s) --- PASS: TestNewLess/patternRejectsBadGlob (0.00s) --- PASS: TestNewLess/patternOrder (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:17: Skipping test on non local remote --- SKIP: TestRcCopy (0.00s) === RUN TestRcMove rc_test.go:17: Skipping test on non local remote --- SKIP: TestRcMove (0.00s) === RUN TestRcSync rc_test.go:17: Skipping test on non local remote --- SKIP: TestRcSync (0.00s) === RUN TestRcCopyReports rc_test.go:17: Skipping test on non local remote --- SKIP: TestRcCopyReports (0.00s) === RUN TestCopyWithDryRun run.go:198: Remote "pcloud root 'rclone-test-daziwin0fiya'", Local "Local file system at /tmp/rclone3078811046", Modify Window "1s" 2026/10/14 04:12:05 DEBUG : pacer: low level retry 1/10 (error Post "https://eapi.pcloud.com/createfolder?folderid=0&name=rclone-test-daziwin0fiya": EOF) 2026/10/14 04:12:05 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/14 04:12:05 DEBUG : pacer: Reducing sleep to 15ms 2026/10/14 04:12:05 DEBUG : pacer: Reducing sleep to 11.25ms 2026/10/14 04:12:05 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/10/14 04:12:05 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) 2026/10/14 04:12:05 DEBUG : pcloud root 'rclone-test-daziwin0fiya': Waiting for checks to finish 2026/10/14 04:12:05 DEBUG : pcloud root 'rclone-test-daziwin0fiya': Waiting for transfers to finish 2026/10/14 04:12:05 DEBUG : pacer: Reducing sleep to 10ms --- PASS: TestCopyWithDryRun (1.14s) === RUN TestCopy run.go:198: Remote "pcloud root 'rclone-test-daziwin0fiya'", Local "Local file system at /tmp/rclone3078811046", Modify Window "1s" 2026/10/14 04:12:05 INFO : sub dir: Set directory modification time (using DirSetModTime) 2026/10/14 04:12:05 DEBUG : pacer: low level retry 1/10 (error Get "https://eapi.pcloud.com/listfolder?folderid=27095852564": EOF) 2026/10/14 04:12:05 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/14 04:12:05 DEBUG : pacer: Reducing sleep to 15ms 2026/10/14 04:12:05 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/10/14 04:12:05 DEBUG : pcloud root 'rclone-test-daziwin0fiya': Waiting for checks to finish 2026/10/14 04:12:05 DEBUG : pcloud root 'rclone-test-daziwin0fiya': Waiting for transfers to finish 2026/10/14 04:12:05 DEBUG : pacer: Reducing sleep to 11.25ms 2026/10/14 04:12:05 DEBUG : pacer: low level retry 1/10 (error Post "https://eapi.pcloud.com/createfolder?folderid=27095852564&name=sub+dir": EOF) 2026/10/14 04:12:05 DEBUG : pacer: Rate limited, increasing sleep to 22.5ms 2026/10/14 04:12:06 DEBUG : pacer: Reducing sleep to 16.875ms 2026/10/14 04:12:06 DEBUG : pacer: Reducing sleep to 12.65625ms 2026/10/14 04:12:06 DEBUG : sub dir/hello world.051af1e7.partial: size = 11 OK 2026/10/14 04:12:06 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2026/10/14 04:12:06 DEBUG : pacer: Reducing sleep to 10ms 2026/10/14 04:12:06 DEBUG : sub dir/hello world.051af1e7.partial: renamed to: sub dir/hello world 2026/10/14 04:12:06 INFO : sub dir/hello world: Copied (new) 2026/10/14 04:12:06 DEBUG : pacer: low level retry 1/10 (error Get "https://eapi.pcloud.com/listfolder?folderid=27095852564&recursive=1": EOF) 2026/10/14 04:12:06 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/14 04:12:06 DEBUG : pacer: Reducing sleep to 15ms 2026/10/14 04:12:06 DEBUG : pacer: Reducing sleep to 11.25ms 2026/10/14 04:12:06 DEBUG : pcloud root 'rclone-test-daziwin0fiya': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata 2026/10/14 04:12:06 DEBUG : pacer: Reducing sleep to 10ms --- PASS: TestCopy (1.34s) === RUN TestCopyMetadata run.go:198: Remote "pcloud root 'rclone-test-daziwin0fiya'", Local "Local file system at /tmp/rclone3078811046", Modify Window "1s" sync_test.go:99: Skipping as metadata not supported --- SKIP: TestCopyMetadata (0.18s) === RUN TestCopyMetadataNoEmptyDirs run.go:198: Remote "pcloud root 'rclone-test-daziwin0fiya'", Local "Local file system at /tmp/rclone3078811046", Modify Window "1s" sync_test.go:99: Skipping as metadata not supported --- SKIP: TestCopyMetadataNoEmptyDirs (0.25s) === RUN TestCopyMissingDirectory run.go:198: Remote "pcloud root 'rclone-test-daziwin0fiya'", Local "Local file system at /tmp/rclone3078811046", Modify Window "1s" 2026/10/14 04:12:07 DEBUG : Creating backend with remote "/non-existing" 2026/10/14 04:12:07 ERROR : Local file system at /non-existing: error reading source root directory: directory not found 2026/10/14 04:12:07 DEBUG : pcloud root 'rclone-test-daziwin0fiya': Waiting for checks to finish 2026/10/14 04:12:07 DEBUG : pcloud root 'rclone-test-daziwin0fiya': Waiting for transfers to finish 2026/10/14 04:12:07 DEBUG : pacer: low level retry 1/10 (error Get "https://eapi.pcloud.com/listfolder?folderid=27095852564&recursive=1": EOF) 2026/10/14 04:12:07 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/14 04:12:07 DEBUG : pacer: Reducing sleep to 15ms 2026/10/14 04:12:07 DEBUG : pacer: Reducing sleep to 11.25ms --- PASS: TestCopyMissingDirectory (0.40s) === RUN TestCopyNoTraverse run.go:198: Remote "pcloud root 'rclone-test-daziwin0fiya'", Local "Local file system at /tmp/rclone3078811046", Modify Window "1s" 2026/10/14 04:12:07 DEBUG : pacer: Reducing sleep to 10ms 2026/10/14 04:12:07 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/10/14 04:12:07 DEBUG : pcloud root 'rclone-test-daziwin0fiya': Waiting for checks to finish 2026/10/14 04:12:07 DEBUG : pcloud root 'rclone-test-daziwin0fiya': Waiting for transfers to finish 2026/10/14 04:12:08 DEBUG : sub dir/hello world.051af1e7.partial: size = 11 OK 2026/10/14 04:12:08 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2026/10/14 04:12:08 DEBUG : sub dir/hello world.051af1e7.partial: renamed to: sub dir/hello world 2026/10/14 04:12:08 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoTraverse (1.10s) === RUN TestCopyNoTraverseDeadlock run.go:198: Remote "pcloud root 'rclone-test-daziwin0fiya'", Local "Local file system at /tmp/rclone3078811046", Modify Window "1s" sync_test.go:223: Only runs on local --- SKIP: TestCopyNoTraverseDeadlock (0.19s) === RUN TestCopyCheckFirst run.go:198: Remote "pcloud root 'rclone-test-daziwin0fiya'", Local "Local file system at /tmp/rclone3078811046", Modify Window "1s" 2026/10/14 04:12:09 INFO : pcloud root 'rclone-test-daziwin0fiya': Running all checks before starting transfers 2026/10/14 04:12:09 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/10/14 04:12:09 DEBUG : pcloud root 'rclone-test-daziwin0fiya': Waiting for checks to finish 2026/10/14 04:12:09 INFO : pcloud root 'rclone-test-daziwin0fiya': Checks finished, now starting transfers 2026/10/14 04:12:09 DEBUG : pcloud root 'rclone-test-daziwin0fiya': Waiting for transfers to finish 2026/10/14 04:12:09 DEBUG : sub dir/hello world.051af1e7.partial: size = 11 OK 2026/10/14 04:12:09 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2026/10/14 04:12:09 DEBUG : sub dir/hello world.051af1e7.partial: renamed to: sub dir/hello world 2026/10/14 04:12:09 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyCheckFirst (1.19s) === RUN TestSyncNoTraverse run.go:198: Remote "pcloud root 'rclone-test-daziwin0fiya'", Local "Local file system at /tmp/rclone3078811046", Modify Window "1s" 2026/10/14 04:12:10 ERROR : Ignoring --no-traverse with sync 2026/10/14 04:12:10 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/10/14 04:12:10 DEBUG : pcloud root 'rclone-test-daziwin0fiya': Waiting for checks to finish 2026/10/14 04:12:10 DEBUG : pcloud root 'rclone-test-daziwin0fiya': Waiting for transfers to finish 2026/10/14 04:12:10 DEBUG : sub dir/hello world.051af1e7.partial: size = 11 OK 2026/10/14 04:12:10 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2026/10/14 04:12:10 DEBUG : sub dir/hello world.051af1e7.partial: renamed to: sub dir/hello world 2026/10/14 04:12:10 INFO : sub dir/hello world: Copied (new) 2026/10/14 04:12:10 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoTraverse (1.10s) === RUN TestCopyWithDepth run.go:198: Remote "pcloud root 'rclone-test-daziwin0fiya'", Local "Local file system at /tmp/rclone3078811046", Modify Window "1s" 2026/10/14 04:12:11 DEBUG : hello world2: Need to transfer - File not found at Destination 2026/10/14 04:12:11 DEBUG : pcloud root 'rclone-test-daziwin0fiya': Waiting for checks to finish 2026/10/14 04:12:11 DEBUG : pcloud root 'rclone-test-daziwin0fiya': Waiting for transfers to finish 2026/10/14 04:12:11 DEBUG : hello world2.ed194a4a.partial: size = 12 OK 2026/10/14 04:12:11 DEBUG : hello world2: sha1 = c0bf117f9c93d02c894fe8ffd6e5cecf3545c209 OK 2026/10/14 04:12:11 DEBUG : hello world2.ed194a4a.partial: renamed to: hello world2 2026/10/14 04:12:11 INFO : hello world2: Copied (new) --- PASS: TestCopyWithDepth (0.78s) === RUN TestCopyWithFilesFrom run.go:198: Remote "pcloud root 'rclone-test-daziwin0fiya'", Local "Local file system at /tmp/rclone3078811046", Modify Window "1s" 2026/10/14 04:12:12 DEBUG : potato2: Need to transfer - File not found at Destination 2026/10/14 04:12:12 DEBUG : pcloud root 'rclone-test-daziwin0fiya': Waiting for checks to finish 2026/10/14 04:12:12 DEBUG : pcloud root 'rclone-test-daziwin0fiya': Waiting for transfers to finish 2026/10/14 04:12:12 DEBUG : potato2.160ece37.partial: size = 11 OK 2026/10/14 04:12:12 DEBUG : potato2: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2026/10/14 04:12:12 DEBUG : potato2.160ece37.partial: renamed to: potato2 2026/10/14 04:12:12 INFO : potato2: Copied (new) --- PASS: TestCopyWithFilesFrom (0.95s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:198: Remote "pcloud root 'rclone-test-daziwin0fiya'", Local "Local file system at /tmp/rclone3078811046", Modify Window "1s" 2026/10/14 04:12:13 DEBUG : potato2: Need to transfer - File not found at Destination 2026/10/14 04:12:13 DEBUG : pcloud root 'rclone-test-daziwin0fiya': Waiting for checks to finish 2026/10/14 04:12:13 DEBUG : pcloud root 'rclone-test-daziwin0fiya': Waiting for transfers to finish 2026/10/14 04:12:13 DEBUG : potato2.160ece37.partial: size = 11 OK 2026/10/14 04:12:13 DEBUG : potato2: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2026/10/14 04:12:13 DEBUG : potato2.160ece37.partial: renamed to: potato2 2026/10/14 04:12:13 INFO : potato2: Copied (new) fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:293: Sleeping for 6s just to make sure --- PASS: TestCopyWithFilesFromAndNoTraverse (8.73s) === RUN TestCopyEmptyDirectories run.go:198: Remote "pcloud root 'rclone-test-daziwin0fiya'", Local "Local file system at /tmp/rclone3078811046", Modify Window "1s" 2026/10/14 04:12:21 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2026/10/14 04:12:21 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2026/10/14 04:12:21 INFO : sub dir2: Set directory modification time (using DirSetModTime) 2026/10/14 04:12:21 INFO : sub dir: Set directory modification time (using DirSetModTime) 2026/10/14 04:12:21 INFO : sub dir2: Making directory 2026/10/14 04:12:22 INFO : sub dir: Making directory 2026/10/14 04:12:22 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/10/14 04:12:22 INFO : sub dir2/sub sub dir2: Making directory 2026/10/14 04:12:22 DEBUG : sub dir/hello world.051af1e7.partial: size = 11 OK 2026/10/14 04:12:22 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2026/10/14 04:12:22 DEBUG : pcloud root 'rclone-test-daziwin0fiya': Waiting for checks to finish 2026/10/14 04:12:22 DEBUG : pcloud root 'rclone-test-daziwin0fiya': Waiting for transfers to finish 2026/10/14 04:12:22 DEBUG : sub dir/hello world.051af1e7.partial: renamed to: sub dir/hello world 2026/10/14 04:12:22 INFO : sub dir/hello world: Copied (new) 2026/10/14 04:12:23 DEBUG : pcloud root 'rclone-test-daziwin0fiya': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata 2026/10/14 04:12:23 DEBUG : pacer: low level retry 1/10 (error Post "https://eapi.pcloud.com/deletefolder?folderid=27095854072": EOF) 2026/10/14 04:12:23 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/14 04:12:23 DEBUG : pacer: Reducing sleep to 15ms 2026/10/14 04:12:23 DEBUG : pacer: Reducing sleep to 11.25ms 2026/10/14 04:12:23 DEBUG : pacer: Reducing sleep to 10ms --- PASS: TestCopyEmptyDirectories (1.91s) === RUN TestCopyNoEmptyDirectories run.go:198: Remote "pcloud root 'rclone-test-daziwin0fiya'", Local "Local file system at /tmp/rclone3078811046", Modify Window "1s" 2026/10/14 04:12:23 INFO : sub dir2: Making directory 2026/10/14 04:12:23 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2026/10/14 04:12:23 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2026/10/14 04:12:24 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/10/14 04:12:24 DEBUG : pcloud root 'rclone-test-daziwin0fiya': Waiting for checks to finish 2026/10/14 04:12:24 DEBUG : pcloud root 'rclone-test-daziwin0fiya': Waiting for transfers to finish 2026/10/14 04:12:24 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF) 2026/10/14 04:12:24 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/14 04:12:24 DEBUG : pacer: Reducing sleep to 15ms 2026/10/14 04:12:25 DEBUG : pacer: Reducing sleep to 11.25ms 2026/10/14 04:12:26 DEBUG : pacer: Reducing sleep to 10ms 2026/10/14 04:12:29 DEBUG : sub dir/hello world: Received error: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF - low level retry 1/10 2026/10/14 04:14:30 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF) 2026/10/14 04:14:30 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/14 04:14:30 DEBUG : pacer: Reducing sleep to 15ms 2026/10/14 04:14:31 DEBUG : pacer: Reducing sleep to 11.25ms 2026/10/14 04:14:32 DEBUG : pacer: Reducing sleep to 10ms 2026/10/14 04:14:35 DEBUG : sub dir/hello world: Received error: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF - low level retry 2/10 2026/10/14 04:16:35 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF) 2026/10/14 04:16:35 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/14 04:16:35 DEBUG : pacer: low level retry 1/10 (error Get "https://eapi.pcloud.com/listfolder?folderid=27095854089": EOF) 2026/10/14 04:16:35 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2026/10/14 04:16:35 DEBUG : pacer: Reducing sleep to 30ms 2026/10/14 04:16:37 DEBUG : pacer: Reducing sleep to 22.5ms 2026/10/14 04:16:38 DEBUG : pacer: low level retry 1/10 (error Get "https://eapi.pcloud.com/listfolder?folderid=27095854089": EOF) 2026/10/14 04:16:38 DEBUG : pacer: Rate limited, increasing sleep to 45ms 2026/10/14 04:16:38 DEBUG : pacer: Reducing sleep to 33.75ms 2026/10/14 04:16:39 DEBUG : pacer: Reducing sleep to 25.3125ms 2026/10/14 04:16:40 DEBUG : pacer: Reducing sleep to 18.984375ms 2026/10/14 04:16:41 DEBUG : sub dir/hello world: Received error: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF - low level retry 3/10 2026/10/14 04:18:41 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF) 2026/10/14 04:18:41 DEBUG : pacer: Rate limited, increasing sleep to 37.96875ms 2026/10/14 04:18:41 DEBUG : pacer: Reducing sleep to 28.476562ms 2026/10/14 04:18:43 DEBUG : pacer: Reducing sleep to 21.357421ms 2026/10/14 04:18:44 DEBUG : pacer: Reducing sleep to 16.018065ms 2026/10/14 04:18:45 DEBUG : pacer: Reducing sleep to 12.013548ms 2026/10/14 04:18:46 DEBUG : pacer: low level retry 1/10 (error Get "https://eapi.pcloud.com/listfolder?folderid=27095854089": EOF) 2026/10/14 04:18:46 DEBUG : pacer: Rate limited, increasing sleep to 24.027096ms 2026/10/14 04:18:46 DEBUG : pacer: low level retry 2/10 (error Get "https://eapi.pcloud.com/listfolder?folderid=27095854089": read tcp 65.108.87.141:56018->45.131.247.15:443: read: connection reset by peer) 2026/10/14 04:18:46 DEBUG : pacer: Rate limited, increasing sleep to 48.054192ms 2026/10/14 04:18:46 DEBUG : pacer: Reducing sleep to 36.040644ms 2026/10/14 04:18:47 DEBUG : sub dir/hello world: Received error: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF - low level retry 4/10 2026/10/14 04:20:47 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF) 2026/10/14 04:20:47 DEBUG : pacer: Rate limited, increasing sleep to 72.081288ms 2026/10/14 04:20:47 DEBUG : pacer: Reducing sleep to 54.060966ms 2026/10/14 04:20:49 DEBUG : pacer: Reducing sleep to 40.545724ms 2026/10/14 04:20:50 DEBUG : pacer: Reducing sleep to 30.409293ms 2026/10/14 04:20:51 DEBUG : pacer: Reducing sleep to 22.806969ms 2026/10/14 04:20:52 DEBUG : pacer: Reducing sleep to 17.105226ms 2026/10/14 04:20:53 DEBUG : sub dir/hello world: Received error: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF - low level retry 5/10 2026/10/14 04:22:53 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF) 2026/10/14 04:22:53 DEBUG : pacer: Rate limited, increasing sleep to 34.210452ms 2026/10/14 04:22:53 DEBUG : pacer: Reducing sleep to 25.657839ms 2026/10/14 04:22:54 DEBUG : pacer: Reducing sleep to 19.243379ms 2026/10/14 04:22:55 DEBUG : pacer: Reducing sleep to 14.432534ms 2026/10/14 04:22:56 DEBUG : pacer: Reducing sleep to 10.8244ms 2026/10/14 04:22:58 DEBUG : pacer: Reducing sleep to 10ms 2026/10/14 04:22:59 DEBUG : sub dir/hello world: Received error: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF - low level retry 6/10 2026/10/14 04:24:59 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF) 2026/10/14 04:24:59 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/14 04:24:59 DEBUG : pacer: Reducing sleep to 15ms 2026/10/14 04:25:00 DEBUG : pacer: Reducing sleep to 11.25ms 2026/10/14 04:25:01 DEBUG : pacer: Reducing sleep to 10ms 2026/10/14 04:25:04 DEBUG : sub dir/hello world: Received error: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF - low level retry 7/10 2026/10/14 04:27:04 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF) 2026/10/14 04:27:04 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/14 04:27:05 DEBUG : pacer: Reducing sleep to 15ms 2026/10/14 04:27:06 DEBUG : pacer: Reducing sleep to 11.25ms 2026/10/14 04:27:07 DEBUG : pacer: Reducing sleep to 10ms 2026/10/14 04:27:10 DEBUG : sub dir/hello world: Received error: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF - low level retry 8/10 2026/10/14 04:29:10 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF) 2026/10/14 04:29:10 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/14 04:29:10 DEBUG : pacer: Reducing sleep to 15ms 2026/10/14 04:29:12 DEBUG : pacer: Reducing sleep to 11.25ms 2026/10/14 04:29:13 DEBUG : pacer: Reducing sleep to 10ms 2026/10/14 04:29:16 DEBUG : sub dir/hello world: Received error: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF - low level retry 9/10 2026/10/14 04:31:16 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF) 2026/10/14 04:31:16 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/14 04:31:16 DEBUG : pacer: Reducing sleep to 15ms 2026/10/14 04:31:17 DEBUG : pacer: Reducing sleep to 11.25ms 2026/10/14 04:31:18 DEBUG : pacer: Reducing sleep to 10ms 2026/10/14 04:31:22 DEBUG : sub dir/hello world: Received error: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF - low level retry 10/10 2026/10/14 04:31:22 ERROR : sub dir/hello world: Failed to copy: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF 2026/10/14 04:31:22 INFO : sub dir/hello world.051af1e7.partial: Failed to remove failed partial copy: couldn't list files: pcloud error: Directory does not exist. (2005) sync_test.go:387: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:387 Error: Received unexpected error: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF Test: TestCopyNoEmptyDirectories --- FAIL: TestCopyNoEmptyDirectories (1138.78s) === RUN TestMoveEmptyDirectories run.go:198: Remote "pcloud root 'rclone-test-daziwin0fiya'", Local "Local file system at /tmp/rclone3078811046", Modify Window "1s" 2026/10/14 04:31:22 DEBUG : sub dir2: Making directory with metadata 2026/10/14 04:31:22 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2026/10/14 04:31:22 INFO : sub dir2: Making directory 2026/10/14 04:31:22 INFO : sub dir: Making directory 2026/10/14 04:31:22 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/10/14 04:31:22 DEBUG : pcloud root 'rclone-test-daziwin0fiya': Waiting for checks to finish 2026/10/14 04:31:22 DEBUG : pcloud root 'rclone-test-daziwin0fiya': Waiting for transfers to finish 2026/10/14 04:31:28 ERROR : sub dir/hello world: Failed to copy: pcloud error: Directory does not exist. (2005) 2026/10/14 04:31:28 INFO : sub dir/hello world.051af1e7.partial: Failed to remove failed partial copy: couldn't list files: pcloud error: Directory does not exist. (2005) 2026/10/14 04:31:28 ERROR : sub dir/hello world: Not deleting source as copy failed: pcloud error: Directory does not exist. (2005) sync_test.go:413: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:413 Error: Received unexpected error: pcloud error: Directory does not exist. (2005) Test: TestMoveEmptyDirectories --- FAIL: TestMoveEmptyDirectories (6.51s) === RUN TestSyncNoUpdateDirModtime run.go:198: Remote "pcloud root 'rclone-test-daziwin0fiya'", Local "Local file system at /tmp/rclone3078811046", Modify Window "1s" sync_test.go:439: Skipping test as backend does not support DirSetModTime --- SKIP: TestSyncNoUpdateDirModtime (0.19s) === RUN TestMoveNoEmptyDirectories run.go:198: Remote "pcloud root 'rclone-test-daziwin0fiya'", Local "Local file system at /tmp/rclone3078811046", Modify Window "1s" 2026/10/14 04:31:29 INFO : sub dir2: Making directory 2026/10/14 04:31:29 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/10/14 04:31:29 DEBUG : pcloud root 'rclone-test-daziwin0fiya': Waiting for checks to finish 2026/10/14 04:31:29 DEBUG : pcloud root 'rclone-test-daziwin0fiya': Waiting for transfers to finish 2026/10/14 04:33:29 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF) 2026/10/14 04:33:29 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/14 04:33:29 DEBUG : pacer: Reducing sleep to 15ms 2026/10/14 04:33:30 DEBUG : pacer: Reducing sleep to 11.25ms 2026/10/14 04:33:31 DEBUG : pacer: Reducing sleep to 10ms 2026/10/14 04:33:34 DEBUG : sub dir/hello world: Received error: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF - low level retry 1/10 2026/10/14 04:35:34 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF) 2026/10/14 04:35:34 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/14 04:35:35 DEBUG : pacer: Reducing sleep to 15ms 2026/10/14 04:35:36 DEBUG : pacer: Reducing sleep to 11.25ms 2026/10/14 04:35:37 DEBUG : pacer: Reducing sleep to 10ms 2026/10/14 04:35:40 DEBUG : sub dir/hello world: Received error: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF - low level retry 2/10 2026/10/14 04:37:40 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF) 2026/10/14 04:37:40 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/14 04:37:40 DEBUG : pacer: Reducing sleep to 15ms 2026/10/14 04:37:41 DEBUG : pacer: Reducing sleep to 11.25ms 2026/10/14 04:37:42 DEBUG : pacer: Reducing sleep to 10ms 2026/10/14 04:37:46 DEBUG : sub dir/hello world: Received error: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF - low level retry 3/10 2026/10/14 04:39:46 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF) 2026/10/14 04:39:46 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/14 04:39:46 DEBUG : pacer: Reducing sleep to 15ms 2026/10/14 04:39:47 DEBUG : pacer: Reducing sleep to 11.25ms 2026/10/14 04:39:48 DEBUG : pacer: Reducing sleep to 10ms 2026/10/14 04:39:51 DEBUG : sub dir/hello world: Received error: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF - low level retry 4/10 2026/10/14 04:41:51 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF) 2026/10/14 04:41:51 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/14 04:41:51 DEBUG : pacer: Reducing sleep to 15ms 2026/10/14 04:41:53 DEBUG : pacer: Reducing sleep to 11.25ms 2026/10/14 04:41:54 DEBUG : pacer: Reducing sleep to 10ms 2026/10/14 04:41:57 DEBUG : sub dir/hello world: Received error: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF - low level retry 5/10 2026/10/14 04:43:57 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF) 2026/10/14 04:43:57 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/14 04:43:57 DEBUG : pacer: Reducing sleep to 15ms 2026/10/14 04:43:58 DEBUG : pacer: Reducing sleep to 11.25ms 2026/10/14 04:43:59 DEBUG : pacer: Reducing sleep to 10ms 2026/10/14 04:44:03 DEBUG : sub dir/hello world: Received error: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF - low level retry 6/10 2026/10/14 04:46:03 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF) 2026/10/14 04:46:03 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/14 04:46:03 DEBUG : pacer: Reducing sleep to 15ms 2026/10/14 04:46:04 DEBUG : pacer: Reducing sleep to 11.25ms 2026/10/14 04:46:05 DEBUG : pacer: Reducing sleep to 10ms 2026/10/14 04:46:08 DEBUG : sub dir/hello world: Received error: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF - low level retry 7/10 2026/10/14 04:48:08 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF) 2026/10/14 04:48:08 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/14 04:48:08 DEBUG : pacer: Reducing sleep to 15ms 2026/10/14 04:48:09 DEBUG : pacer: Reducing sleep to 11.25ms 2026/10/14 04:48:11 DEBUG : pacer: Reducing sleep to 10ms 2026/10/14 04:48:14 DEBUG : sub dir/hello world: Received error: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF - low level retry 8/10 2026/10/14 04:50:14 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF) 2026/10/14 04:50:14 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/14 04:50:14 DEBUG : pacer: Reducing sleep to 15ms 2026/10/14 04:50:15 DEBUG : pacer: Reducing sleep to 11.25ms 2026/10/14 04:50:16 DEBUG : pacer: Reducing sleep to 10ms 2026/10/14 04:50:19 DEBUG : sub dir/hello world: Received error: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF - low level retry 9/10 2026/10/14 04:52:19 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF) 2026/10/14 04:52:19 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/14 04:52:20 DEBUG : pacer: Reducing sleep to 15ms 2026/10/14 04:52:21 DEBUG : pacer: Reducing sleep to 11.25ms 2026/10/14 04:52:22 DEBUG : pacer: Reducing sleep to 10ms 2026/10/14 04:52:25 DEBUG : sub dir/hello world: Received error: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF - low level retry 10/10 2026/10/14 04:52:25 ERROR : sub dir/hello world: Failed to copy: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF 2026/10/14 04:52:25 INFO : sub dir/hello world.051af1e7.partial: Failed to remove failed partial copy: couldn't list files: pcloud error: Directory does not exist. (2005) 2026/10/14 04:52:25 ERROR : sub dir/hello world: Not deleting source as copy failed: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF sync_test.go:484: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:484 Error: Received unexpected error: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF Test: TestMoveNoEmptyDirectories --- FAIL: TestMoveNoEmptyDirectories (1256.69s) === RUN TestSyncEmptyDirectories run.go:198: Remote "pcloud root 'rclone-test-daziwin0fiya'", Local "Local file system at /tmp/rclone3078811046", Modify Window "1s" 2026/10/14 04:52:25 DEBUG : sub dir2: Making directory with metadata 2026/10/14 04:52:25 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2026/10/14 04:52:25 INFO : sub dir: Set directory modification time (using DirSetModTime) 2026/10/14 04:52:25 INFO : sub dir2: Making directory 2026/10/14 04:52:25 INFO : sub dir: Making directory 2026/10/14 04:52:25 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/10/14 04:52:25 DEBUG : pcloud root 'rclone-test-daziwin0fiya': Waiting for checks to finish 2026/10/14 04:52:25 DEBUG : pcloud root 'rclone-test-daziwin0fiya': Waiting for transfers to finish 2026/10/14 04:54:26 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF) 2026/10/14 04:54:26 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/14 04:54:26 DEBUG : pacer: Reducing sleep to 15ms 2026/10/14 04:54:27 DEBUG : pacer: Reducing sleep to 11.25ms 2026/10/14 04:54:28 DEBUG : pacer: Reducing sleep to 10ms 2026/10/14 04:54:31 DEBUG : sub dir/hello world: Received error: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF - low level retry 1/10 2026/10/14 04:56:31 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF) 2026/10/14 04:56:31 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/14 04:56:31 DEBUG : pacer: Reducing sleep to 15ms 2026/10/14 04:56:33 DEBUG : pacer: Reducing sleep to 11.25ms 2026/10/14 04:56:34 DEBUG : pacer: Reducing sleep to 10ms 2026/10/14 04:56:37 DEBUG : sub dir/hello world: Received error: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF - low level retry 2/10 2026/10/14 04:58:38 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF) 2026/10/14 04:58:38 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/14 04:58:38 DEBUG : pacer: Reducing sleep to 15ms 2026/10/14 04:58:39 DEBUG : pacer: Reducing sleep to 11.25ms 2026/10/14 04:58:41 DEBUG : pacer: Reducing sleep to 10ms 2026/10/14 04:58:44 DEBUG : sub dir/hello world: Received error: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF - low level retry 3/10 2026/10/14 05:00:44 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF) 2026/10/14 05:00:44 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/14 05:00:44 DEBUG : pacer: Reducing sleep to 15ms 2026/10/14 05:00:45 DEBUG : pacer: Reducing sleep to 11.25ms 2026/10/14 05:00:46 DEBUG : pacer: Reducing sleep to 10ms 2026/10/14 05:00:49 DEBUG : sub dir/hello world: Received error: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF - low level retry 4/10 2026/10/14 05:02:49 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF) 2026/10/14 05:02:49 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/14 05:02:50 DEBUG : pacer: Reducing sleep to 15ms 2026/10/14 05:02:51 DEBUG : pacer: Reducing sleep to 11.25ms 2026/10/14 05:02:52 DEBUG : pacer: Reducing sleep to 10ms 2026/10/14 05:02:55 DEBUG : sub dir/hello world: Received error: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF - low level retry 5/10 2026/10/14 05:04:55 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF) 2026/10/14 05:04:55 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/14 05:04:55 DEBUG : pacer: Reducing sleep to 15ms 2026/10/14 05:04:56 DEBUG : pacer: Reducing sleep to 11.25ms 2026/10/14 05:04:57 DEBUG : pacer: Reducing sleep to 10ms 2026/10/14 05:05:01 DEBUG : sub dir/hello world: Received error: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF - low level retry 6/10 2026/10/14 05:07:01 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF) 2026/10/14 05:07:01 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/14 05:07:01 DEBUG : pacer: Reducing sleep to 15ms 2026/10/14 05:07:02 DEBUG : pacer: Reducing sleep to 11.25ms 2026/10/14 05:07:03 DEBUG : pacer: Reducing sleep to 10ms 2026/10/14 05:07:06 DEBUG : sub dir/hello world: Received error: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF - low level retry 7/10 2026/10/14 05:09:06 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF) 2026/10/14 05:09:06 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/14 05:09:06 DEBUG : pacer: Reducing sleep to 15ms 2026/10/14 05:09:07 DEBUG : pacer: Reducing sleep to 11.25ms 2026/10/14 05:09:09 DEBUG : pacer: Reducing sleep to 10ms 2026/10/14 05:09:12 DEBUG : sub dir/hello world: Received error: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF - low level retry 8/10 2026/10/14 05:11:12 DEBUG : pacer: low level retry 1/1 (error Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF) 2026/10/14 05:11:12 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/14 05:11:12 DEBUG : pacer: Reducing sleep to 15ms 2026/10/14 05:11:13 DEBUG : pacer: Reducing sleep to 11.25ms 2026/10/14 05:11:14 DEBUG : pacer: Reducing sleep to 10ms 2026/10/14 05:11:17 DEBUG : sub dir/hello world: Received error: Put "https://eapi.pcloud.com/uploadfile?filename=hello+world.051af1e7.partial&folderid=27095854089&mtime=981173106&nopartial=1": EOF - low level retry 9/10 panic: test timed out after 1h0m0s running tests: TestSyncEmptyDirectories (19m39s) goroutine 3085 [running]: testing.(*M).startAlarm.func1() /usr/local/go/src/testing/testing.go:2959 +0x34a created by time.goFunc /usr/local/go/src/time/sleep.go:182 +0x2d goroutine 1 [chan receive, 20 minutes]: testing.(*T).Run(0x348902962488, {0x253d865?, 0x34890237ba58?}, 0x48ed138) /usr/local/go/src/testing/testing.go:2266 +0x4f2 testing.runTests.func1(0x348902962488) /usr/local/go/src/testing/testing.go:2742 +0x37 testing.tRunner(0x348902962488, 0x34890237bb80) /usr/local/go/src/testing/testing.go:2193 +0xea testing.runTests({0x253d8c5, 0x18}, {0x25614a1, 0x20}, 0x348902d199f8, {0x4bc6840, 0x6d, 0x6d}, {0xc2abe1a91999ad6b, 0x3467660191d, ...}) /usr/local/go/src/testing/testing.go:2740 +0x510 testing.(*M).Run(0x3489029d88c0) /usr/local/go/src/testing/testing.go:2600 +0x6af github.com/rclone/rclone/fstest.TestMain(0x3489029d88c0) /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:75 +0xa6 github.com/rclone/rclone/fs/sync.TestMain(...) /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:46 main.main() _testmain.go:264 +0xa6 goroutine 35 [syscall, 60 minutes]: os/signal.signal_recv() /usr/local/go/src/runtime/sigqueue.go:152 +0x98 os/signal.loop() /usr/local/go/src/os/signal/signal_unix.go:23 +0x13 created by os/signal.Notify.func2.1 in goroutine 1 /usr/local/go/src/os/signal/signal.go:164 +0x1f goroutine 36 [chan receive, 60 minutes]: github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler.func1() /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:24 +0x27 created by github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler in goroutine 1 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xae goroutine 37 [select, 60 minutes]: github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0x348902a3f580) /home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x85 created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 1 /home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xfa goroutine 2657 [sync.WaitGroup.Wait, 20 minutes]: sync.runtime_SemacquireWaitGroup(0x0?, 0x0?) /usr/local/go/src/runtime/sema.go:114 +0x2e sync.(*WaitGroup).Wait(0x34890298d018) /usr/local/go/src/sync/waitgroup.go:206 +0x85 github.com/rclone/rclone/fs/sync.(*syncCopyMove).stopTransfers(0x34890298cf08) /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:529 +0x6f github.com/rclone/rclone/fs/sync.(*syncCopyMove).run(0x34890298cf08) /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:845 +0x33f github.com/rclone/rclone/fs/sync.runSyncCopyMove({0x48d32d8, 0x34890243bbf0}, {0x48e2140, 0x34890243c2c0}, {0x48e1a40, 0x3489024d9440}, 0x3, 0x0, 0x0, 0x1, ...) /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:1249 +0x236 github.com/rclone/rclone/fs/sync.Sync({0x48d32d8, 0x34890243bbf0}, {0x48e2140, 0x34890243c2c0}, {0x48e1a40, 0x3489024d9440}, 0x1) /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:1255 +0x77 github.com/rclone/rclone/fs/sync.TestSyncEmptyDirectories(0x348902962d88) /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:513 +0x231 testing.tRunner(0x348902962d88, 0x48ed138) /usr/local/go/src/testing/testing.go:2193 +0xea created by testing.(*T).Run in goroutine 1 /usr/local/go/src/testing/testing.go:2258 +0x4d4 goroutine 2707 [select]: github.com/rclone/rclone/fs/accounting.(*StatsInfo).averageLoop(0x348902d02f00, {0x48d3310, 0x348902e8d3b0}) /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:352 +0x145 created by github.com/rclone/rclone/fs/accounting.(*StatsInfo)._startAverageLoop in goroutine 2682 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:389 +0x12c goroutine 262 [chan receive, 59 minutes]: github.com/rclone/rclone/lib/atexit.Register.func1.1() /home/rclone/go/src/github.com/rclone/rclone/lib/atexit/atexit.go:45 +0x29 created by github.com/rclone/rclone/lib/atexit.Register.func1 in goroutine 209 /home/rclone/go/src/github.com/rclone/rclone/lib/atexit/atexit.go:44 +0x68 goroutine 3158 [IO wait, 2 minutes]: internal/poll.runtime_pollWait(0x73ed28e41200, 0x72) /usr/local/go/src/runtime/netpoll.go:351 +0x85 internal/poll.(*pollDesc).wait(0x3489024f1a00?, 0x348902d9f980?, 0x0) /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 internal/poll.(*pollDesc).waitRead(...) /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 internal/poll.(*FD).Read(0x3489024f1a00, {0x348902d9f980, 0x1980, 0x1980}) /usr/local/go/src/internal/poll/fd_unix.go:170 +0x2a8 net.(*netFD).Read(0x3489024f1a00, {0x348902d9f980?, 0x348902d9f985?, 0x3489023128c0?}) /usr/local/go/src/net/fd_posix.go:68 +0x25 net.(*conn).Read(0x3489023128c0, {0x348902d9f980?, 0xb5679e?, 0x17003489023a4a10?}) /usr/local/go/src/net/net.go:196 +0x45 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0x348902d185d0, {0x348902d9f980?, 0x73ecdafbac60?, 0x73ed28ec72f8?}) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29 crypto/tls.(*Conn).readFromUntil(0x3489029bc408, {0x73ecda63e510, 0x348902d185d0}, 0x348902b710f9?) /usr/local/go/src/crypto/tls/conn.go:820 +0xf4 crypto/tls.(*Conn).readRecordOrCCS(0x3489029bc408, 0x0) /usr/local/go/src/crypto/tls/conn.go:626 +0x3fb crypto/tls.(*Conn).readRecord(...) /usr/local/go/src/crypto/tls/conn.go:588 crypto/tls.(*Conn).Read(0x3489029bc408, {0x3489029ff000, 0x1000, 0x70?}) /usr/local/go/src/crypto/tls/conn.go:1392 +0x148 net/http.(*persistConn).Read(0x348902437cc0, {0x3489029ff000?, 0x70?, 0x0?}) /usr/local/go/src/net/http/transport.go:2300 +0x47 bufio.(*Reader).fill(0x348902d98660) /usr/local/go/src/bufio/bufio.go:113 +0x103 bufio.(*Reader).Peek(0x348902d98660, 0x1) /usr/local/go/src/bufio/bufio.go:152 +0x52 net/http.(*persistConn).readLoop(0x348902437cc0) /usr/local/go/src/net/http/transport.go:2483 +0x172 created by net/http.(*Transport).dialConn in goroutine 2865 /usr/local/go/src/net/http/transport.go:2123 +0x1da5 goroutine 3159 [select, 2 minutes]: net/http.(*persistConn).writeLoop(0x348902437cc0) /usr/local/go/src/net/http/transport.go:2810 +0xe6 created by net/http.(*Transport).dialConn in goroutine 2865 /usr/local/go/src/net/http/transport.go:2124 +0x1e05 goroutine 2682 [select, 2 minutes]: net/http.(*persistConn).roundTrip(0x348902437cc0, 0x348902e8c4b0) /usr/local/go/src/net/http/transport.go:3069 +0x84b net/http.(*Transport).roundTrip(0x3489024388c0, 0x348902437a40) /usr/local/go/src/net/http/transport.go:725 +0xada net/http.(*Transport).RoundTrip(...) /usr/local/go/src/net/http/roundtrip.go:33 github.com/rclone/rclone/fs/fshttp.(*Transport).RoundTrip(0x34890262e3c0, 0x348902437a40) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/http.go:709 +0x63b golang.org/x/oauth2.(*Transport).RoundTrip(0x348902a2d6e0, 0x348902437400) /home/rclone/go/pkg/mod/golang.org/x/oauth2@v0.36.0/transport.go:55 +0x15b net/http.send(0x348902437400, {0x48aef20, 0x348902a2d6e0}, {0x348902bb8c40?, 0x497406?, 0x0?}) /usr/local/go/src/net/http/client.go:266 +0x654 net/http.(*Client).send(0x3489025c2720, 0x348902437400, {0x26ac930?, 0x1?, 0x0?}) /usr/local/go/src/net/http/client.go:187 +0x250 net/http.(*Client).do(0x3489025c2720, 0x348902437400) /usr/local/go/src/net/http/client.go:745 +0x9f7 net/http.(*Client).Do(...) /usr/local/go/src/net/http/client.go:604 github.com/rclone/rclone/lib/rest.(*Client).Call(0x3489029661e0, {0x48d3310, 0x348902e8cc30}, 0x348902a574a0) /home/rclone/go/src/github.com/rclone/rclone/lib/rest/rest.go:511 +0xe85 github.com/rclone/rclone/lib/rest.(*Client).callCodec(0x3489029661e0, {0x48d3310, 0x348902e8cc30}, 0x3489029ec960?, {0x0?, 0x0?}, {0x4088130, 0x348902cde420}, 0x4498c38?, 0x48ee8c8, ...) /home/rclone/go/src/github.com/rclone/rclone/lib/rest/rest.go:757 +0x4e8 github.com/rclone/rclone/lib/rest.(*Client).CallJSON(...) /home/rclone/go/src/github.com/rclone/rclone/lib/rest/rest.go:694 github.com/rclone/rclone/backend/pcloud.(*Object).Update.func1() /home/rclone/go/src/github.com/rclone/rclone/backend/pcloud/pcloud.go:1551 +0x93 github.com/rclone/rclone/fs.pacerInvoker(0x1, 0x1, 0x9?) /home/rclone/go/src/github.com/rclone/rclone/fs/pacer.go:86 +0x32 github.com/rclone/rclone/lib/pacer.(*Pacer).call(0x34890262e480, 0x348902a3f9c0, 0x1) /home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:228 +0xd2 github.com/rclone/rclone/lib/pacer.(*Pacer).CallNoRetry(...) /home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:256 github.com/rclone/rclone/backend/pcloud.(*Object).Update(0x3489029c7170, {0x48d3310, 0x348902e8cc30}, {0x48ab640, 0x348902882000}, {0x48dbf68, 0x348902a2c7a0}, {0x348902d22750, 0x1, 0x1}) /home/rclone/go/src/github.com/rclone/rclone/backend/pcloud/pcloud.go:1550 +0xbf0 github.com/rclone/rclone/backend/pcloud.(*Fs).Put(0x34890243c2c0, {0x48d3310, 0x348902e8cc30}, {0x48ab640, 0x348902882000}, {0x48dbf68, 0x348902a2c7a0}, {0x348902d22750, 0x1, 0x1}) /home/rclone/go/src/github.com/rclone/rclone/backend/pcloud/pcloud.go:781 +0x14c github.com/rclone/rclone/fs/operations.(*copy).updateOrPut(0x348902f185a0, {0x48d3310, 0x348902e8cc30}, {0x48bf118?, 0x348902aaa0f0?}, {0x348902d22750, 0x1, 0x1}) /home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:228 +0x225 github.com/rclone/rclone/fs/operations.(*copy).manualCopy(0x348902f185a0, {0x48d3310, 0x348902e8cc30}) /home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:286 +0x776 github.com/rclone/rclone/fs/operations.(*copy).copy(0x348902f185a0, {0x48d3310, 0x348902e8cc30}) /home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:326 +0x165 github.com/rclone/rclone/fs/operations.Copy({0x48d3310, 0x348902e8cc30}, {0x48e2140, 0x34890243c2c0}, {0x0, 0x0}, {0x348902b724f8, 0x13}, {0x48e1ab0, 0x348902cdf380}) /home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:431 +0x4dc github.com/rclone/rclone/fs/sync.(*syncCopyMove).pairCopyOrMove(0x34890298cf08, {0x48d3310, 0x348902e8cc30}, 0x348902e8cb90, {0x48e2140, 0x34890243c2c0}, 0x0, 0x0?) /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:491 +0x1fe created by github.com/rclone/rclone/fs/sync.(*syncCopyMove).startTransfers in goroutine 2657 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:521 +0x7d goroutine 2863 [select]: github.com/rclone/rclone/fs/accounting.(*Account).averageLoop(0x348902882000) /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting.go:222 +0xec created by github.com/rclone/rclone/fs/accounting.newAccountSizeName in goroutine 2682 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting.go:120 +0x449 "./sync.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose" - Finished ERROR in 1h0m1.189359868s (try 1/5): exit status 2: Failed [TestCopyNoEmptyDirectories TestMoveEmptyDirectories TestMoveNoEmptyDirectories]