"./operations.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestCaseInsensitiveMoveFile|TestCaseInsensitiveMoveFileDryRun|TestCopyURL|TestDirMove|TestMoveFile|TestMoveFileBackupDir|TestMoveFileWithIgnoreExisting|TestPurge|TestRcatSize|TestRemoveExisting|TestRmdirsLeaveRoot|TestRmdirsWithFilter|TestTouchDir)$|^TestRcat$/^(withChecksum=false,ignoreChecksum=false|withChecksum=false,ignoreChecksum=true|withChecksum=true,ignoreChecksum=false|withChecksum=true,ignoreChecksum=true)$'" - Starting (try 2/5) 2025/12/29 01:43:08 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-bemahex2lubu" 2025/12/29 01:43:08 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/12/29 01:43:09 DEBUG : Starting OpenDrive session with ID: 4a6628f802b2ddc2ca7c41fa4618eff0a4f61c29380583eece6e6a145d703ae3 2025/12/29 01:43:09 DEBUG : Creating backend with remote "/tmp/rclone2507543397" === RUN TestPurge 2025/12/29 01:43:09 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-kubofuw8lupa" 2025/12/29 01:43:09 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/12/29 01:43:09 DEBUG : Starting OpenDrive session with ID: c5887bb444e00bc1c78238954cc8932d82248f5593818ead2a2ac7a7f6c00070 2025/12/29 01:43:10 DEBUG : Creating backend with remote "/tmp/rclone4185352997" run.go:185: Remote "OpenDrive root 'rclone-test-kubofuw8lupa'", Local "Local file system at /tmp/rclone4185352997", Modify Window "1s" 2025/12/29 01:43:12 DEBUG : A1/B1/C1/one: Uploading chunk 0, size=3, remain=0 2025/12/29 01:43:13 INFO : A2: Making directory 2025/12/29 01:43:13 INFO : A1/B2: Making directory 2025/12/29 01:43:14 INFO : A1/B2/C2: Making directory 2025/12/29 01:43:14 INFO : A1/B1/C3: Making directory 2025/12/29 01:43:14 INFO : A3: Making directory 2025/12/29 01:43:15 INFO : A3/B3: Making directory operations_test.go:585: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:585 Error: Received unexpected error: failed to get folder list: Directory doesn't exist (Error 404) Test: TestPurge 2025/12/29 01:43:15 DEBUG : OpenDrive root 'rclone-test-kubofuw8lupa': Purge remote --- FAIL: TestPurge (6.31s) === RUN TestRmdirsLeaveRoot run.go:185: Remote "OpenDrive root 'rclone-test-bemahex2lubu'", Local "Local file system at /tmp/rclone2507543397", Modify Window "1s" 2025/12/29 01:43:16 INFO : A1: Making directory 2025/12/29 01:43:16 INFO : A1/B1: Making directory 2025/12/29 01:43:16 INFO : A1/B1/C1: Making directory 2025/12/29 01:43:18 DEBUG : removing 1 level 3 directories 2025/12/29 01:43:18 INFO : A1/B1/C1: Removing directory 2025/12/29 01:43:18 DEBUG : removing 1 level 2 directories 2025/12/29 01:43:18 INFO : A1/B1: Removing directory fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestRmdirsLeaveRoot (19.78s) === RUN TestRmdirsWithFilter run.go:185: Remote "OpenDrive root 'rclone-test-bemahex2lubu'", Local "Local file system at /tmp/rclone2507543397", Modify Window "1s" 2025/12/29 01:43:35 INFO : A1: Making directory 2025/12/29 01:43:35 INFO : A1/B1: Making directory 2025/12/29 01:43:36 INFO : A1/B1/C1: Making directory operations_test.go:787: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:787 Error: Received unexpected error: failed to get folder list: Directory doesn't exist (Error 404) Test: TestRmdirsWithFilter fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- FAIL: TestRmdirsWithFilter (9.79s) === RUN TestCopyURL run.go:185: Remote "OpenDrive root 'rclone-test-bemahex2lubu'", Local "Local file system at /tmp/rclone2507543397", Modify Window "1s" 2025/12/29 01:43:46 DEBUG : file1: Uploading chunk 0, size=14, remain=0 2025/12/29 01:43:47 DEBUG : filename.txt: File name found in url 2025/12/29 01:43:48 DEBUG : filename.txt: Uploading chunk 0, size=14, remain=0 2025/12/29 01:43:49 DEBUG : headerfilename.txt: filename found in Content-Disposition header. 2025/12/29 01:43:50 DEBUG : headerfilename.txt: Uploading chunk 0, size=14, remain=0 2025/12/29 01:43:51 DEBUG : file2: Uploading chunk 0, size=14, remain=0 --- PASS: TestCopyURL (8.74s) === RUN TestMoveFile run.go:185: Remote "OpenDrive root 'rclone-test-bemahex2lubu'", Local "Local file system at /tmp/rclone2507543397", Modify Window "1s" 2025/12/29 01:43:54 DEBUG : file1: Need to transfer - File not found at Destination 2025/12/29 01:43:55 DEBUG : sub/file2: Uploading chunk 0, size=14, remain=0 2025/12/29 01:43:56 DEBUG : sub/file2: size = 14 OK 2025/12/29 01:43:56 DEBUG : file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK 2025/12/29 01:43:56 INFO : file1: Copied (new) to: sub/file2 2025/12/29 01:43:56 INFO : file1: Deleted 2025/12/29 01:43:56 DEBUG : sub/file2: size = 14 OK 2025/12/29 01:43:56 DEBUG : file1: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/12/29 01:43:56 DEBUG : file1: Unchanged skipping 2025/12/29 01:43:56 INFO : file1: Deleted 2025/12/29 01:43:57 DEBUG : OpenDrive root 'rclone-test-bemahex2lubu': don't need to copy/move sub/file2, it is already at target location --- PASS: TestMoveFile (4.71s) === RUN TestMoveFileWithIgnoreExisting run.go:185: Remote "OpenDrive root 'rclone-test-bemahex2lubu'", Local "Local file system at /tmp/rclone2507543397", Modify Window "1s" 2025/12/29 01:43:58 DEBUG : file1: Need to transfer - File not found at Destination 2025/12/29 01:43:59 DEBUG : file1: Uploading chunk 0, size=14, remain=0 2025/12/29 01:44:00 DEBUG : file1: size = 14 OK 2025/12/29 01:44:00 DEBUG : file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK 2025/12/29 01:44:00 INFO : file1: Copied (new) 2025/12/29 01:44:00 INFO : file1: Deleted 2025/12/29 01:44:01 DEBUG : file1: Destination exists, skipping 2025/12/29 01:44:01 DEBUG : file1: Not removing source file as destination file exists and --ignore-existing is set --- PASS: TestMoveFileWithIgnoreExisting (3.11s) === RUN TestCaseInsensitiveMoveFile run.go:185: Remote "OpenDrive root 'rclone-test-bemahex2lubu'", Local "Local file system at /tmp/rclone2507543397", Modify Window "1s" 2025/12/29 01:44:01 DEBUG : file1: Need to transfer - File not found at Destination 2025/12/29 01:44:03 DEBUG : sub/file2: Uploading chunk 0, size=14, remain=0 2025/12/29 01:44:04 DEBUG : sub/file2: size = 14 OK 2025/12/29 01:44:04 DEBUG : file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK 2025/12/29 01:44:04 INFO : file1: Copied (new) to: sub/file2 2025/12/29 01:44:04 INFO : file1: Deleted 2025/12/29 01:44:04 DEBUG : sub/file2: size = 14 OK 2025/12/29 01:44:04 DEBUG : file1: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/12/29 01:44:04 DEBUG : file1: Unchanged skipping 2025/12/29 01:44:04 INFO : file1: Deleted 2025/12/29 01:44:05 DEBUG : sub/file2: moving to sub/File2-rclone-move-bamaqof2 2025/12/29 01:44:05 DEBUG : sub/file2: same parent dir (ODFfOTY2NzM1OF9JYm4wdw) - using file/rename instead of move_copy for sub/File2-rclone-move-bamaqof2 2025/12/29 01:44:05 INFO : sub/file2: Moved (server-side) to: sub/File2-rclone-move-bamaqof2 2025/12/29 01:44:05 DEBUG : sub/file2: moving to sub/File2 2025/12/29 01:44:06 DEBUG : sub/File2-rclone-move-bamaqof2: same parent dir (ODFfOTY2NzM1OF9JYm4wdw) - using file/rename instead of move_copy for sub/File2 2025/12/29 01:44:06 INFO : sub/File2-rclone-move-bamaqof2: Moved (server-side) to: sub/File2 --- PASS: TestCaseInsensitiveMoveFile (5.94s) === RUN TestCaseInsensitiveMoveFileDryRun run.go:185: Remote "OpenDrive root 'rclone-test-bemahex2lubu'", Local "Local file system at /tmp/rclone2507543397", Modify Window "1s" 2025/12/29 01:44:08 DEBUG : hello: Uploading chunk 0, size=5, remain=0 2025/12/29 01:44:10 NOTICE: hello: Skipped rename to HELLO as --dry-run is set --- PASS: TestCaseInsensitiveMoveFileDryRun (2.98s) === RUN TestMoveFileBackupDir run.go:185: Remote "OpenDrive root 'rclone-test-bemahex2lubu'", Local "Local file system at /tmp/rclone2507543397", Modify Window "1s" 2025/12/29 01:44:11 DEBUG : dst/file1: Uploading chunk 0, size=18, remain=0 2025/12/29 01:44:13 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-bemahex2lubu/backup" 2025/12/29 01:44:13 DEBUG : Starting OpenDrive session with ID: d56effe314f5c06a50ace30dda1696f3705ba024bae252c4b95299d111950829 2025/12/29 01:44:14 DEBUG : dst/file1: size = 14 (Local file system at /tmp/rclone2507543397) 2025/12/29 01:44:14 DEBUG : dst/file1: size = 18 (OpenDrive root 'rclone-test-bemahex2lubu') 2025/12/29 01:44:14 DEBUG : dst/file1: Sizes differ 2025/12/29 01:44:15 ERROR : dst/file1: Couldn't move: failed to get folder list: Directory doesn't exist (Error 404) operations_test.go:1052: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1052 Error: Received unexpected error: moving to --backup-dir failed: failed to get folder list: Directory doesn't exist (Error 404) Test: TestMoveFileBackupDir fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 /usr/local/go/src/runtime/panic.go:636 /usr/local/go/src/testing/testing.go:1041 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1052 Error: Not equal: expected: []string{} actual : []string{"backup"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=6) "backup" } Test: TestMoveFileBackupDir Messages: directories --- FAIL: TestMoveFileBackupDir (13.93s) === RUN TestDirMove run.go:185: Remote "OpenDrive root 'rclone-test-bemahex2lubu'", Local "Local file system at /tmp/rclone2507543397", Modify Window "1s" 2025/12/29 01:44:25 DEBUG : A1/one: Uploading chunk 0, size=3, remain=0 2025/12/29 01:44:27 DEBUG : A1/two: Uploading chunk 0, size=3, remain=0 2025/12/29 01:44:29 DEBUG : A1/B1/three: Uploading chunk 0, size=5, remain=0 2025/12/29 01:44:31 DEBUG : A1/B1/C1/four: Uploading chunk 0, size=4, remain=0 2025/12/29 01:44:34 DEBUG : A1/B1/C2/five: Uploading chunk 0, size=4, remain=0 2025/12/29 01:44:35 INFO : A1/B2: Making directory 2025/12/29 01:44:35 INFO : A1/B1/C3: Making directory fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1373 Error: Not equal: expected: []string{"A1", "A1/B1", "A1/B1/C1", "A1/B1/C2", "A1/B1/C3", "A1/B2"} actual : []string{"A1", "A1/B1", "A1/B1/C1", "A1/B1/C2", "A1/B1/C3", "A1/B2", "backup"} Diff: --- Expected +++ Actual @@ -1,2 +1,2 @@ -([]string) (len=6) { +([]string) (len=7) { (string) (len=2) "A1", @@ -6,3 +6,4 @@ (string) (len=8) "A1/B1/C3", - (string) (len=5) "A1/B2" + (string) (len=5) "A1/B2", + (string) (len=6) "backup" } Test: TestDirMove Messages: directories 2025/12/29 01:44:46 DEBUG : A2: same parent dir (ODFfOTY2NzM1MV9rZVFaRw) - using folder/rename instead of move_copy fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1394 Error: Not equal: expected: []string{"A2", "A2/B1", "A2/B1/C1", "A2/B1/C2", "A2/B1/C3", "A2/B2"} actual : []string{"A2", "A2/B1", "A2/B1/C1", "A2/B1/C2", "A2/B1/C3", "A2/B2", "backup"} Diff: --- Expected +++ Actual @@ -1,2 +1,2 @@ -([]string) (len=6) { +([]string) (len=7) { (string) (len=2) "A2", @@ -6,3 +6,4 @@ (string) (len=8) "A2/B1/C3", - (string) (len=5) "A2/B2" + (string) (len=5) "A2/B2", + (string) (len=6) "backup" } Test: TestDirMove Messages: directories 2025/12/29 01:45:00 INFO : A2/one: Moved (server-side) to: A3/one 2025/12/29 01:45:00 INFO : A2/B1/three: Moved (server-side) to: A3/B1/three 2025/12/29 01:45:00 INFO : A2/two: Moved (server-side) to: A3/two 2025/12/29 01:45:00 INFO : A2/B1/C1/four: Moved (server-side) to: A3/B1/C1/four 2025/12/29 01:45:00 INFO : A2/B1/C2/five: Moved (server-side) to: A3/B1/C2/five fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1419 Error: Not equal: expected: []string{"A3", "A3/B1", "A3/B1/C1", "A3/B1/C2", "A3/B1/C3", "A3/B2"} actual : []string{"A3", "A3/B1", "A3/B1/C1", "A3/B1/C2", "A3/B1/C3", "A3/B2", "backup"} Diff: --- Expected +++ Actual @@ -1,2 +1,2 @@ -([]string) (len=6) { +([]string) (len=7) { (string) (len=2) "A3", @@ -6,3 +6,4 @@ (string) (len=8) "A3/B1/C3", - (string) (len=5) "A3/B2" + (string) (len=5) "A3/B2", + (string) (len=6) "backup" } Test: TestDirMove Messages: directories 2025/12/29 01:45:12 INFO : OpenDrive root 'rclone-test-bemahex2lubu': Can't DirMove - falling back to file moves: can't move directory - incompatible remotes 2025/12/29 01:45:16 INFO : A3/two: Moved (server-side) to: A4/two 2025/12/29 01:45:16 INFO : A3/one: Moved (server-side) to: A4/one 2025/12/29 01:45:16 INFO : A3/B1/three: Moved (server-side) to: A4/B1/three 2025/12/29 01:45:16 INFO : A3/B1/C2/five: Moved (server-side) to: A4/B1/C2/five 2025/12/29 01:45:16 INFO : A3/B1/C1/four: Moved (server-side) to: A4/B1/C1/four fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1447 Error: Not equal: expected: []string{"A4", "A4/B1", "A4/B1/C1", "A4/B1/C2", "A4/B1/C3", "A4/B2"} actual : []string{"A4", "A4/B1", "A4/B1/C1", "A4/B1/C2", "A4/B1/C3", "A4/B2", "backup"} Diff: --- Expected +++ Actual @@ -1,2 +1,2 @@ -([]string) (len=6) { +([]string) (len=7) { (string) (len=2) "A4", @@ -6,3 +6,4 @@ (string) (len=8) "A4/B1/C3", - (string) (len=5) "A4/B2" + (string) (len=5) "A4/B2", + (string) (len=6) "backup" } Test: TestDirMove Messages: directories --- FAIL: TestDirMove (68.36s) === RUN TestRcat === RUN TestRcat/withChecksum=false,ignoreChecksum=false run.go:185: Remote "OpenDrive root 'rclone-test-bemahex2lubu'", Local "Local file system at /tmp/rclone2507543397", Modify Window "1s" 2025/12/29 01:45:33 DEBUG : OpenDrive root 'rclone-test-bemahex2lubu': File to upload is small (34 bytes), uploading instead of streaming 2025/12/29 01:45:33 DEBUG : no_checksum_small_file_from_pipe: Uploading chunk 0, size=34, remain=0 2025/12/29 01:45:34 DEBUG : no_checksum_small_file_from_pipe: size = 34 OK 2025/12/29 01:45:34 DEBUG : no_checksum_small_file_from_pipe: md5 = 4c762bc6ec18f21b23fcae426c7863b5 OK 2025/12/29 01:45:34 DEBUG : no_checksum_small_file_from_pipe: Size and md5 of src and dst objects identical 2025/12/29 01:45:34 DEBUG : OpenDrive root 'rclone-test-bemahex2lubu': Target remote doesn't support streaming uploads, creating temporary local FS to spool file 2025/12/29 01:45:36 DEBUG : no_checksum_big_file_from_pipe: Uploading chunk 0, size=102401, remain=0 2025/12/29 01:45:37 DEBUG : no_checksum_big_file_from_pipe: size = 102401 OK 2025/12/29 01:45:37 DEBUG : no_checksum_big_file_from_pipe: md5 = fffc7956ba9a7b58a63c01b6ce1ddc45 OK 2025/12/29 01:45:37 DEBUG : no_checksum_big_file_from_pipe: Size and md5 of src and dst objects identical === RUN TestRcat/withChecksum=true,ignoreChecksum=false run.go:185: Remote "OpenDrive root 'rclone-test-bemahex2lubu'", Local "Local file system at /tmp/rclone2507543397", Modify Window "1s" 2025/12/29 01:45:38 DEBUG : OpenDrive root 'rclone-test-bemahex2lubu': File to upload is small (34 bytes), uploading instead of streaming 2025/12/29 01:45:39 DEBUG : with_checksum_small_file_from_pipe: Uploading chunk 0, size=34, remain=0 2025/12/29 01:45:40 DEBUG : with_checksum_small_file_from_pipe: size = 34 OK 2025/12/29 01:45:40 DEBUG : with_checksum_small_file_from_pipe: md5 = 4c762bc6ec18f21b23fcae426c7863b5 OK 2025/12/29 01:45:40 DEBUG : with_checksum_small_file_from_pipe: Size and md5 of src and dst objects identical 2025/12/29 01:45:40 DEBUG : OpenDrive root 'rclone-test-bemahex2lubu': Target remote doesn't support streaming uploads, creating temporary local FS to spool file 2025/12/29 01:45:41 DEBUG : with_checksum_big_file_from_pipe: Uploading chunk 0, size=102401, remain=0 2025/12/29 01:45:43 DEBUG : with_checksum_big_file_from_pipe: size = 102401 OK 2025/12/29 01:45:43 DEBUG : with_checksum_big_file_from_pipe: md5 = fffc7956ba9a7b58a63c01b6ce1ddc45 OK 2025/12/29 01:45:43 DEBUG : with_checksum_big_file_from_pipe: Size and md5 of src and dst objects identical === RUN TestRcat/withChecksum=false,ignoreChecksum=true run.go:185: Remote "OpenDrive root 'rclone-test-bemahex2lubu'", Local "Local file system at /tmp/rclone2507543397", Modify Window "1s" 2025/12/29 01:45:44 DEBUG : OpenDrive root 'rclone-test-bemahex2lubu': File to upload is small (34 bytes), uploading instead of streaming 2025/12/29 01:45:44 DEBUG : ignore_checksum_small_file_from_pipe: Uploading chunk 0, size=34, remain=0 2025/12/29 01:45:45 DEBUG : ignore_checksum_small_file_from_pipe: size = 34 OK 2025/12/29 01:45:45 DEBUG : ignore_checksum_small_file_from_pipe: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/12/29 01:45:45 DEBUG : OpenDrive root 'rclone-test-bemahex2lubu': Target remote doesn't support streaming uploads, creating temporary local FS to spool file 2025/12/29 01:45:46 DEBUG : ignore_checksum_big_file_from_pipe: Uploading chunk 0, size=102401, remain=0 2025/12/29 01:45:48 DEBUG : ignore_checksum_big_file_from_pipe: size = 102401 OK 2025/12/29 01:45:48 DEBUG : ignore_checksum_big_file_from_pipe: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) === RUN TestRcat/withChecksum=true,ignoreChecksum=true run.go:185: Remote "OpenDrive root 'rclone-test-bemahex2lubu'", Local "Local file system at /tmp/rclone2507543397", Modify Window "1s" 2025/12/29 01:45:49 DEBUG : OpenDrive root 'rclone-test-bemahex2lubu': File to upload is small (34 bytes), uploading instead of streaming 2025/12/29 01:45:50 DEBUG : ignore_checksum_small_file_from_pipe: Uploading chunk 0, size=34, remain=0 2025/12/29 01:45:51 DEBUG : ignore_checksum_small_file_from_pipe: size = 34 OK 2025/12/29 01:45:51 DEBUG : ignore_checksum_small_file_from_pipe: Src hash empty - aborting Dst hash check 2025/12/29 01:45:51 DEBUG : ignore_checksum_small_file_from_pipe: Size of src and dst objects identical 2025/12/29 01:45:51 DEBUG : OpenDrive root 'rclone-test-bemahex2lubu': Target remote doesn't support streaming uploads, creating temporary local FS to spool file 2025/12/29 01:45:51 DEBUG : ignore_checksum_big_file_from_pipe: Uploading chunk 0, size=102401, remain=0 2025/12/29 01:45:53 DEBUG : ignore_checksum_big_file_from_pipe: size = 102401 OK 2025/12/29 01:45:53 DEBUG : ignore_checksum_big_file_from_pipe: Src hash empty - aborting Dst hash check 2025/12/29 01:45:53 DEBUG : ignore_checksum_big_file_from_pipe: Size of src and dst objects identical --- PASS: TestRcat (21.23s) --- PASS: TestRcat/withChecksum=false,ignoreChecksum=false (5.76s) --- PASS: TestRcat/withChecksum=true,ignoreChecksum=false (5.11s) --- PASS: TestRcat/withChecksum=false,ignoreChecksum=true (5.25s) --- PASS: TestRcat/withChecksum=true,ignoreChecksum=true (5.11s) === RUN TestRcatSize run.go:185: Remote "OpenDrive root 'rclone-test-bemahex2lubu'", Local "Local file system at /tmp/rclone2507543397", Modify Window "1s" 2025/12/29 01:45:55 DEBUG : potato1: Uploading chunk 0, size=60, remain=0 2025/12/29 01:45:55 DEBUG : OpenDrive root 'rclone-test-bemahex2lubu': File to upload is small (60 bytes), uploading instead of streaming 2025/12/29 01:45:56 DEBUG : potato2: Uploading chunk 0, size=60, remain=0 2025/12/29 01:45:57 DEBUG : potato2: size = 60 OK 2025/12/29 01:45:57 DEBUG : potato2: md5 = d6548b156ea68a4e003e786df99eee76 OK 2025/12/29 01:45:57 DEBUG : potato2: Size and md5 of src and dst objects identical fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestRcatSize (11.63s) === RUN TestTouchDir run.go:185: Remote "OpenDrive root 'rclone-test-bemahex2lubu'", Local "Local file system at /tmp/rclone2507543397", Modify Window "1s" 2025/12/29 01:46:06 DEBUG : potato2: Uploading chunk 0, size=60, remain=0 2025/12/29 01:46:08 DEBUG : empty space: Uploading chunk 0, size=1, remain=0 2025/12/29 01:46:10 DEBUG : sub dir/potato3: Uploading chunk 0, size=5, remain=0 2025/12/29 01:46:11 DEBUG : OpenDrive root 'rclone-test-bemahex2lubu': Touching "empty space" 2025/12/29 01:46:11 DEBUG : OpenDrive root 'rclone-test-bemahex2lubu': Touching "potato2" 2025/12/29 01:46:12 DEBUG : OpenDrive root 'rclone-test-bemahex2lubu': Touching "sub dir/potato3" --- PASS: TestTouchDir (8.05s) === RUN TestRemoveExisting run.go:185: Remote "OpenDrive root 'rclone-test-bemahex2lubu'", Local "Local file system at /tmp/rclone2507543397", Modify Window "1s" 2025/12/29 01:46:15 DEBUG : sub dir/test remove existing: Uploading chunk 0, size=11, remain=0 2025/12/29 01:46:16 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: Uploading chunk 0, size=21, remain=0 2025/12/29 01:46:19 DEBUG : sub dir/test remove existing: TEST: renaming existing object to "sub dir/test remove existing.xexuket8" before starting 2025/12/29 01:46:19 DEBUG : sub dir/test remove existing: same parent dir (ODFfOTY2NzM4MF9RR2o2Nw) - using file/rename instead of move_copy for sub dir/test remove existing.xexuket8 2025/12/29 01:46:19 DEBUG : sub dir/test remove existing.xexuket8: TEST: removing renamed existing file after operation 2025/12/29 01:46:20 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: TEST: renaming existing object to "sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.zuloyud6" before starting 2025/12/29 01:46:20 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: same parent dir (ODFfOTY2NzM4MF9RR2o2Nw) - using file/rename instead of move_copy for sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.zuloyud6 2025/12/29 01:46:21 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.zuloyud6: TEST: renaming existing back after failed operation 2025/12/29 01:46:21 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.zuloyud6: same parent dir (ODFfOTY2NzM4MF9RR2o2Nw) - using file/rename instead of move_copy for sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789 2025/12/29 01:46:22 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: TEST: renaming existing object to "sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.soqujir3" before starting 2025/12/29 01:46:22 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: same parent dir (ODFfOTY2NzM4MF9RR2o2Nw) - using file/rename instead of move_copy for sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.soqujir3 2025/12/29 01:46:22 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.soqujir3: TEST: removing renamed existing file after operation --- PASS: TestRemoveExisting (10.19s) FAIL 2025/12/29 01:46:24 DEBUG : OpenDrive root 'rclone-test-bemahex2lubu': Purge remote "./operations.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestCaseInsensitiveMoveFile|TestCaseInsensitiveMoveFileDryRun|TestCopyURL|TestDirMove|TestMoveFile|TestMoveFileBackupDir|TestMoveFileWithIgnoreExisting|TestPurge|TestRcatSize|TestRemoveExisting|TestRmdirsLeaveRoot|TestRmdirsWithFilter|TestTouchDir)$|^TestRcat$/^(withChecksum=false,ignoreChecksum=false|withChecksum=false,ignoreChecksum=true|withChecksum=true,ignoreChecksum=false|withChecksum=true,ignoreChecksum=true)$'" - Finished ERROR in 3m16.095053783s (try 2/5): exit status 1: Failed [TestPurge TestRmdirsWithFilter TestMoveFileBackupDir TestDirMove]