"./operations.test -test.v -test.timeout 1h0m0s -remote TestFilesCom: -verbose -test.run '^(TestCopyURL|TestDirMove|TestRcatSize|TestRemoveExisting|TestRmdirsWithFilter)$'" - Starting (try 2/5)
2026/01/26 05:02:15 DEBUG : Creating backend with remote "TestFilesCom:rclone-test-fewafag5dehi"
2026/01/26 05:02:15 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/01/26 05:02:16 DEBUG : Creating backend with remote "/tmp/rclone2913128626"
=== RUN   TestRmdirsWithFilter
    run.go:185: Remote "files root 'rclone-test-fewafag5dehi'", Local "Local file system at /tmp/rclone2913128626", Modify Window "1s"
2026/01/26 05:02:16 INFO  : A1: Making directory
2026/01/26 05:02:17 INFO  : A1/B1: Making directory
2026/01/26 05:02:17 INFO  : A1/B1/C1: Making directory
2026/01/26 05:02:19 DEBUG : removing 1 level 3 directories
2026/01/26 05:02:19 INFO  : A1/B1/C1: Removing directory
2026/01/26 05:02:19 DEBUG : removing 1 level 2 directories
2026/01/26 05:02:19 INFO  : A1/B1: Removing directory
2026/01/26 05:02:19 DEBUG : pacer: low level retry 1/10 (error Folder Not Empty - `Folder rclone-test-fewafag5dehi/A1/B1 not empty`)
2026/01/26 05:02:19 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/01/26 05:02:19 DEBUG : pacer: low level retry 2/10 (error Folder Not Empty - `Folder rclone-test-fewafag5dehi/A1/B1 not empty`)
2026/01/26 05:02:19 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2026/01/26 05:02:19 DEBUG : pacer: low level retry 3/10 (error Folder Not Empty - `Folder rclone-test-fewafag5dehi/A1/B1 not empty`)
2026/01/26 05:02:19 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2026/01/26 05:02:20 DEBUG : pacer: low level retry 4/10 (error Folder Not Empty - `Folder rclone-test-fewafag5dehi/A1/B1 not empty`)
2026/01/26 05:02:20 DEBUG : pacer: Rate limited, increasing sleep to 160ms
2026/01/26 05:02:20 DEBUG : pacer: low level retry 5/10 (error Folder Not Empty - `Folder rclone-test-fewafag5dehi/A1/B1 not empty`)
2026/01/26 05:02:20 DEBUG : pacer: Rate limited, increasing sleep to 320ms
2026/01/26 05:02:20 DEBUG : pacer: low level retry 6/10 (error Folder Not Empty - `Folder rclone-test-fewafag5dehi/A1/B1 not empty`)
2026/01/26 05:02:20 DEBUG : pacer: Rate limited, increasing sleep to 640ms
2026/01/26 05:02:20 DEBUG : pacer: Reducing sleep to 480ms
2026/01/26 05:02:21 DEBUG : pacer: Reducing sleep to 360ms
2026/01/26 05:02:21 DEBUG : pacer: Reducing sleep to 270ms
2026/01/26 05:02:22 DEBUG : pacer: Reducing sleep to 202.5ms
2026/01/26 05:02:22 DEBUG : pacer: Reducing sleep to 151.875ms
2026/01/26 05:02:22 DEBUG : pacer: Reducing sleep to 113.90625ms
2026/01/26 05:02:22 DEBUG : pacer: Reducing sleep to 85.429687ms
--- PASS: TestRmdirsWithFilter (6.63s)
=== RUN   TestCopyURL
    run.go:185: Remote "files root 'rclone-test-fewafag5dehi'", Local "Local file system at /tmp/rclone2913128626", Modify Window "1s"
2026/01/26 05:02:22 DEBUG : pacer: Reducing sleep to 64.072265ms
2026/01/26 05:02:23 DEBUG : pacer: Reducing sleep to 48.054198ms
2026/01/26 05:02:23 ERROR : file1: Post request put error: internal error: ReadAt not implemented for io.nopCloser
    operations_test.go:843: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:843
        	Error:      	Received unexpected error:
        	            	internal error: ReadAt not implemented for io.nopCloser
        	Test:       	TestCopyURL
2026/01/26 05:02:23 DEBUG : pacer: Reducing sleep to 36.040648ms
2026/01/26 05:02:23 DEBUG : pacer: Reducing sleep to 27.030486ms
--- FAIL: TestCopyURL (0.57s)
=== RUN   TestDirMove
    run.go:185: Remote "files root 'rclone-test-fewafag5dehi'", Local "Local file system at /tmp/rclone2913128626", Modify Window "1s"
2026/01/26 05:02:23 DEBUG : pacer: Reducing sleep to 20.272864ms
2026/01/26 05:02:24 DEBUG : pacer: Reducing sleep to 15.204648ms
2026/01/26 05:02:24 DEBUG : pacer: Reducing sleep to 11.403486ms
2026/01/26 05:02:25 DEBUG : pacer: Reducing sleep to 10ms
2026/01/26 05:02:27 INFO  : A1/B2: Making directory
2026/01/26 05:02:27 INFO  : A1/B1/C3: Making directory
2026/01/26 05:02:31 INFO  : A2/B1/C2/five: Moved (server-side) to: A3/B1/C2/five
2026/01/26 05:02:31 INFO  : A2/one: Moved (server-side) to: A3/one
2026/01/26 05:02:31 INFO  : A2/B1/three: Moved (server-side) to: A3/B1/three
2026/01/26 05:02:31 INFO  : A2/two: Moved (server-side) to: A3/two
2026/01/26 05:02:31 INFO  : A2/B1/C1/four: Moved (server-side) to: A3/B1/C1/four
2026/01/26 05:02:32 DEBUG : pacer: low level retry 1/10 (error Folder Not Empty - `Folder rclone-test-fewafag5dehi/A2/B1 not empty`)
2026/01/26 05:02:32 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/01/26 05:02:32 DEBUG : pacer: low level retry 2/10 (error Folder Not Empty - `Folder rclone-test-fewafag5dehi/A2/B1 not empty`)
2026/01/26 05:02:32 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2026/01/26 05:02:33 DEBUG : pacer: Reducing sleep to 30ms
2026/01/26 05:02:33 DEBUG : pacer: low level retry 1/10 (error Folder Not Empty - `Folder rclone-test-fewafag5dehi/A2 not empty`)
2026/01/26 05:02:33 DEBUG : pacer: Rate limited, increasing sleep to 60ms
2026/01/26 05:02:33 DEBUG : pacer: low level retry 2/10 (error Folder Not Empty - `Folder rclone-test-fewafag5dehi/A2 not empty`)
2026/01/26 05:02:33 DEBUG : pacer: Rate limited, increasing sleep to 120ms
2026/01/26 05:02:33 DEBUG : pacer: low level retry 3/10 (error Folder Not Empty - `Folder rclone-test-fewafag5dehi/A2 not empty`)
2026/01/26 05:02:33 DEBUG : pacer: Rate limited, increasing sleep to 240ms
2026/01/26 05:02:33 DEBUG : pacer: Reducing sleep to 180ms
2026/01/26 05:02:33 DEBUG : pacer: Reducing sleep to 135ms
2026/01/26 05:02:33 DEBUG : pacer: Reducing sleep to 101.25ms
2026/01/26 05:02:33 DEBUG : pacer: Reducing sleep to 75.9375ms
2026/01/26 05:02:34 DEBUG : pacer: Reducing sleep to 56.953125ms
2026/01/26 05:02:34 DEBUG : pacer: Reducing sleep to 42.714843ms
2026/01/26 05:02:34 DEBUG : pacer: Reducing sleep to 32.036132ms
2026/01/26 05:02:34 DEBUG : pacer: Reducing sleep to 24.027099ms
2026/01/26 05:02:34 INFO  : files root 'rclone-test-fewafag5dehi': Can't DirMove - falling back to file moves: can't move directory - incompatible remotes
2026/01/26 05:02:34 DEBUG : pacer: Reducing sleep to 18.020324ms
2026/01/26 05:02:34 DEBUG : pacer: Reducing sleep to 13.515243ms
2026/01/26 05:02:34 DEBUG : pacer: Reducing sleep to 10.136432ms
2026/01/26 05:02:34 DEBUG : pacer: Reducing sleep to 10ms
2026/01/26 05:02:36 INFO  : A3/one: Moved (server-side) to: A4/one
2026/01/26 05:02:36 INFO  : A3/two: Moved (server-side) to: A4/two
2026/01/26 05:02:36 INFO  : A3/B1/three: Moved (server-side) to: A4/B1/three
2026/01/26 05:02:36 INFO  : A3/B1/C1/four: Moved (server-side) to: A4/B1/C1/four
2026/01/26 05:02:36 INFO  : A3/B1/C2/five: Moved (server-side) to: A4/B1/C2/five
2026/01/26 05:02:37 DEBUG : pacer: low level retry 1/10 (error Folder Not Empty - `Folder rclone-test-fewafag5dehi/A3/B1 not empty`)
2026/01/26 05:02:37 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/01/26 05:02:37 DEBUG : pacer: Reducing sleep to 15ms
2026/01/26 05:02:37 DEBUG : pacer: low level retry 1/10 (error Folder Not Empty - `Folder rclone-test-fewafag5dehi/A3 not empty`)
2026/01/26 05:02:37 DEBUG : pacer: Rate limited, increasing sleep to 30ms
2026/01/26 05:02:37 DEBUG : pacer: low level retry 2/10 (error Folder Not Empty - `Folder rclone-test-fewafag5dehi/A3 not empty`)
2026/01/26 05:02:37 DEBUG : pacer: Rate limited, increasing sleep to 60ms
2026/01/26 05:02:38 DEBUG : pacer: Reducing sleep to 45ms
2026/01/26 05:02:38 DEBUG : pacer: Reducing sleep to 33.75ms
2026/01/26 05:02:38 DEBUG : pacer: Reducing sleep to 25.3125ms
2026/01/26 05:02:38 DEBUG : pacer: Reducing sleep to 18.984375ms
2026/01/26 05:02:38 DEBUG : pacer: Reducing sleep to 14.238281ms
2026/01/26 05:02:38 DEBUG : pacer: Reducing sleep to 10.67871ms
2026/01/26 05:02:38 DEBUG : pacer: Reducing sleep to 10ms
2026/01/26 05:02:40 DEBUG : pacer: low level retry 1/10 (error Folder Not Empty - `Folder rclone-test-fewafag5dehi/A4/B1 not empty`)
2026/01/26 05:02:40 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/01/26 05:02:40 DEBUG : pacer: low level retry 2/10 (error Folder Not Empty - `Folder rclone-test-fewafag5dehi/A4/B1 not empty`)
2026/01/26 05:02:40 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2026/01/26 05:02:40 DEBUG : pacer: Reducing sleep to 30ms
2026/01/26 05:02:41 DEBUG : pacer: low level retry 1/10 (error Folder Not Empty - `Folder rclone-test-fewafag5dehi/A4 not empty`)
2026/01/26 05:02:41 DEBUG : pacer: Rate limited, increasing sleep to 60ms
2026/01/26 05:02:41 DEBUG : pacer: Reducing sleep to 45ms
2026/01/26 05:02:41 DEBUG : pacer: Reducing sleep to 33.75ms
--- PASS: TestDirMove (18.03s)
=== RUN   TestRcatSize
    run.go:185: Remote "files root 'rclone-test-fewafag5dehi'", Local "Local file system at /tmp/rclone2913128626", Modify Window "1s"
2026/01/26 05:02:41 DEBUG : pacer: Reducing sleep to 25.3125ms
2026/01/26 05:02:41 ERROR : potato1: Post request put error: internal error: ReadAt not implemented for io.nopCloserWriterTo
    operations_test.go:1601: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1601
        	Error:      	Received unexpected error:
        	            	internal error: ReadAt not implemented for io.nopCloserWriterTo
        	Test:       	TestRcatSize
2026/01/26 05:02:41 DEBUG : pacer: Reducing sleep to 18.984375ms
2026/01/26 05:02:41 DEBUG : pacer: Reducing sleep to 14.238281ms
--- FAIL: TestRcatSize (0.42s)
=== RUN   TestRemoveExisting
    run.go:185: Remote "files root 'rclone-test-fewafag5dehi'", Local "Local file system at /tmp/rclone2913128626", Modify Window "1s"
2026/01/26 05:02:42 DEBUG : pacer: Reducing sleep to 10.67871ms
2026/01/26 05:02:42 DEBUG : pacer: Reducing sleep to 10ms
2026/01/26 05:02:44 DEBUG : sub dir/test remove existing: TEST: renaming existing object to "sub dir/test remove existing.gofufol2" before starting
2026/01/26 05:02:45 DEBUG : sub dir/test remove existing.gofufol2: TEST: removing renamed existing file after operation
2026/01/26 05:02:45 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: TEST: renaming existing object to "sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.lakapem5" before starting
2026/01/26 05:02:46 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.lakapem5: TEST: renaming existing back after failed operation
2026/01/26 05:02:47 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: TEST: renaming existing object to "sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.vizenah5" before starting
2026/01/26 05:02:48 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.vizenah5: TEST: removing renamed existing file after operation
--- PASS: TestRemoveExisting (7.48s)
FAIL
2026/01/26 05:02:49 DEBUG : files root 'rclone-test-fewafag5dehi': Purge remote
"./operations.test -test.v -test.timeout 1h0m0s -remote TestFilesCom: -verbose -test.run '^(TestCopyURL|TestDirMove|TestRcatSize|TestRemoveExisting|TestRmdirsWithFilter)$'" - Finished ERROR in 34.03016109s (try 2/5): exit status 1: Failed [TestCopyURL TestRcatSize]