"./operations.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestCheckSum|TestCopyFileBackupDir|TestCopyFileCopyDest|TestCopyFileMaxTransfer|TestDirMove|TestMoveFileBackupDir|TestPurge|TestRemoveExisting|TestRmdirsLeaveRoot|TestRmdirsNoLeaveRoot|TestRmdirsWithFilter|TestTouchDir)$'" - Starting (try 2/5) 2025/01/22 03:11:49 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-cekozew5qaro" 2025/01/22 03:11:49 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/01/22 03:11:49 DEBUG : Starting OpenDrive session with ID: a6dc4ab614ef7478ac96455d2505a768c8b4ec67f77621cbe0787dc2d3bce235 2025/01/22 03:11:50 DEBUG : Creating backend with remote "/tmp/rclone964997541" === RUN TestCheckSum run.go:180: Remote "OpenDrive root 'rclone-test-cekozew5qaro'", Local "Local file system at /tmp/rclone964997541", Modify Window "1s" 2025/01/22 03:11:50 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-cekozew5qaro/data" 2025/01/22 03:11:50 DEBUG : Starting OpenDrive session with ID: 13a7727ed7ca878a36e328f776007026969f55ae12f38f8332fc35440cc09b29 2025/01/22 03:11:53 DEBUG : data/banana: Uploading chunk 0, size=13, remain=0 2025/01/22 03:11:54 DEBUG : test.sum: Uploading chunk 0, size=41, remain=0 fstest.go:121: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:121 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:126 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:145 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:189 /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/operations/check_test.go:440 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:541 Error: Should be true Test: TestCheckSum Messages: test.sum: Modification time difference too big |-210095h6m48.500000001s| > 1s (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2025-01-22 03:11:55 +0000 UTC) (precision 1s) === RUN TestCheckSum/subtest1 2025/01/22 03:11:57 DEBUG : data/potato: Uploading chunk 0, size=15, remain=0 2025/01/22 03:11:59 DEBUG : test.sum: Uploading chunk 0, size=41, remain=0 === RUN TestCheckSum/subtest2 2025/01/22 03:12:02 DEBUG : test.sum: Uploading chunk 0, size=82, remain=0 === RUN TestCheckSum/subtest3 2025/01/22 03:12:04 DEBUG : test.sum: Uploading chunk 0, size=82, remain=0 === RUN TestCheckSum/subtest4 2025/01/22 03:12:07 DEBUG : test.sum: Uploading chunk 0, size=123, remain=0 === RUN TestCheckSum/subtest5 2025/01/22 03:12:10 DEBUG : test.sum: Uploading chunk 0, size=123, remain=0 === RUN TestCheckSum/subtest6 2025/01/22 03:12:13 DEBUG : data/banana: Uploading chunk 0, size=13, remain=0 2025/01/22 03:12:14 DEBUG : data/potato: Uploading chunk 0, size=15, remain=0 2025/01/22 03:12:15 DEBUG : test.sum: Uploading chunk 0, size=82, remain=0 === RUN TestCheckSum/subtest7 --- FAIL: TestCheckSum (29.27s) --- PASS: TestCheckSum/subtest1 (0.95s) --- PASS: TestCheckSum/subtest2 (0.62s) --- PASS: TestCheckSum/subtest3 (0.54s) --- PASS: TestCheckSum/subtest4 (0.75s) --- PASS: TestCheckSum/subtest5 (0.55s) --- PASS: TestCheckSum/subtest6 (0.55s) --- PASS: TestCheckSum/subtest7 (0.54s) === RUN TestCopyFileBackupDir run.go:180: Remote "OpenDrive root 'rclone-test-cekozew5qaro'", Local "Local file system at /tmp/rclone964997541", Modify Window "1s" 2025/01/22 03:12:21 DEBUG : dst/file1: Uploading chunk 0, size=18, remain=0 2025/01/22 03:12:22 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-cekozew5qaro/backup" 2025/01/22 03:12:23 DEBUG : Starting OpenDrive session with ID: 25411579642fa81f473f76df6c1ae0a20977da1d7f457aa10a763f104fdfbeb9 2025/01/22 03:12:23 DEBUG : dst/file1: Sizes differ (src 14 vs dst 18) 2025/01/22 03:12:25 INFO : dst/file1: Moved (server-side) 2025/01/22 03:12:26 DEBUG : dst/file1: Uploading chunk 0, size=14, remain=0 2025/01/22 03:12:28 DEBUG : dst/file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK 2025/01/22 03:12:28 INFO : dst/file1: Copied (new) 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: TestCopyFileBackupDir (19.04s) === RUN TestCopyFileCopyDest run.go:180: Remote "OpenDrive root 'rclone-test-cekozew5qaro'", Local "Local file system at /tmp/rclone964997541", Modify Window "1s" 2025/01/22 03:12:38 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-cekozew5qaro/dst" 2025/01/22 03:12:39 DEBUG : Starting OpenDrive session with ID: af083bae057f1738723e824fc91f72bfda665173e822a47d824da0264d178d32 2025/01/22 03:12:40 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-cekozew5qaro/CopyDest" 2025/01/22 03:12:40 DEBUG : Starting OpenDrive session with ID: d681f66788b476e23063aefedfd7ede480dc0bad181f4d11c1a5541ccefdc2cc 2025/01/22 03:12:41 DEBUG : one: Need to transfer - File not found at Destination 2025/01/22 03:12:42 DEBUG : one: Uploading chunk 0, size=3, remain=0 2025/01/22 03:12:43 DEBUG : one: md5 = f97c5d29941bfb1b2fdab0874906ab82 OK 2025/01/22 03:12:43 INFO : one: Copied (new) 2025/01/22 03:12:44 DEBUG : one: Need to transfer - File not found at Destination 2025/01/22 03:12:45 DEBUG : one: Uploading chunk 0, size=5, remain=0 2025/01/22 03:12:46 DEBUG : one: md5 = 07912d142f5d63ee918b34796b5a2432 OK 2025/01/22 03:12:46 INFO : one: Copied (new) 2025/01/22 03:12:47 DEBUG : dst/one: Uploading chunk 0, size=3, remain=0 2025/01/22 03:12:49 DEBUG : CopyDest/one: Uploading chunk 0, size=5, remain=0 2025/01/22 03:12:51 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-cekozew5qaro/BackupDir" 2025/01/22 03:12:52 DEBUG : Starting OpenDrive session with ID: 1deeca7fd024355effc51a40e5bf30e868f389e8a7bb5df67cf0b3504548490f 2025/01/22 03:12:53 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/01/22 03:12:53 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/01/22 03:12:53 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/01/22 03:12:54 INFO : one: Moved (server-side) 2025/01/22 03:12:54 DEBUG : one: Dst hash empty - aborting Src hash check 2025/01/22 03:12:54 INFO : one: Copied (server-side copy) 2025/01/22 03:12:54 DEBUG : one: Destination found in --copy-dest, using server-side copy 2025/01/22 03:12:56 DEBUG : CopyDest/two: Uploading chunk 0, size=3, remain=0 2025/01/22 03:12:57 DEBUG : two: Need to transfer - File not found at Destination 2025/01/22 03:12:57 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/01/22 03:12:58 DEBUG : two: Dst hash empty - aborting Src hash check 2025/01/22 03:12:58 INFO : two: Copied (server-side copy) 2025/01/22 03:12:58 DEBUG : two: Destination found in --copy-dest, using server-side copy 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 2025/01/22 03:13:06 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2025/01/22 03:13:06 DEBUG : two: Unchanged skipping 2025/01/22 03:13:08 DEBUG : CopyDest/three: Uploading chunk 0, size=5, remain=0 2025/01/22 03:13:10 DEBUG : three: Need to transfer - File not found at Destination 2025/01/22 03:13:10 DEBUG : three: Sizes differ (src 7 vs dst 5) 2025/01/22 03:13:10 DEBUG : three: Destination not found in --copy-dest 2025/01/22 03:13:11 DEBUG : three: Uploading chunk 0, size=7, remain=0 2025/01/22 03:13:12 DEBUG : three: md5 = 1bccb9dccb3e9f6a3f9d2a8bdb54b7f5 OK 2025/01/22 03:13:12 INFO : three: Copied (new) fstest.go:121: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:121 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:126 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:145 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:189 /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/operations/copy_test.go:361 Error: Should be true Test: TestCopyFileCopyDest Messages: dst/three: Modification time difference too big |-114518h13m12s| > 1s (want 2011-12-30 12:59:59 +0000 UTC vs got 2025-01-22 03:13:11 +0000 UTC) (precision 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 --- FAIL: TestCopyFileCopyDest (44.54s) === RUN TestCopyFileMaxTransfer run.go:180: Remote "OpenDrive root 'rclone-test-cekozew5qaro'", Local "Local file system at /tmp/rclone964997541", Modify Window "1s" 2025/01/22 03:13:23 DEBUG : TestCopyFileMaxTransfer/file1: Need to transfer - File not found at Destination 2025/01/22 03:13:24 DEBUG : TestCopyFileMaxTransfer/file1: Uploading chunk 0, size=14, remain=0 2025/01/22 03:13:25 DEBUG : TestCopyFileMaxTransfer/file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK 2025/01/22 03:13:25 INFO : TestCopyFileMaxTransfer/file1: Copied (new) 2025/01/22 03:13:26 DEBUG : TestCopyFileMaxTransfer/file2: Need to transfer - File not found at Destination 2025/01/22 03:13:27 DEBUG : TestCopyFileMaxTransfer/file2: Uploading chunk 0, size=2062, remain=0 2025/01/22 03:13:27 ERROR : TestCopyFileMaxTransfer/file2: Failed to copy: failed to create file: Post "https://dev.opendrive.com/api/v1/upload/upload_file_chunk.json": failed to copy data: max transfer limit reached as set by --max-transfer 2025/01/22 03:13:27 DEBUG : TestCopyFileMaxTransfer/file3: Need to transfer - File not found at Destination 2025/01/22 03:13:28 DEBUG : TestCopyFileMaxTransfer/file4: Need to transfer - File not found at Destination 2025/01/22 03:13:28 DEBUG : TestCopyFileMaxTransfer/file4: Uploading chunk 0, size=2062, remain=0 2025/01/22 03:13:30 DEBUG : TestCopyFileMaxTransfer/file4: md5 = fe90e07a74d2526ab3225bc6f2abf382 OK 2025/01/22 03:13:30 INFO : TestCopyFileMaxTransfer/file4: Copied (new) --- PASS: TestCopyFileMaxTransfer (8.84s) === RUN TestPurge 2025/01/22 03:13:32 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-vofupih9rafi" 2025/01/22 03:13:32 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/01/22 03:13:32 DEBUG : Starting OpenDrive session with ID: f673b6d67821ce8bdbe8472b2a1d18bd83b481c767cf07f90bba8d7e17eb41d8 2025/01/22 03:13:33 DEBUG : Creating backend with remote "/tmp/rclone669011836" run.go:180: Remote "OpenDrive root 'rclone-test-vofupih9rafi'", Local "Local file system at /tmp/rclone669011836", Modify Window "1s" run.go:285: Failed to put "A1/B1/C1/one" to "OpenDrive root 'rclone-test-vofupih9rafi'": failed to get folder list: Directory doesn't exist (Error 404) 2025/01/22 03:13:34 DEBUG : OpenDrive root 'rclone-test-vofupih9rafi': Purge remote --- FAIL: TestPurge (2.73s) === RUN TestRmdirsNoLeaveRoot run.go:180: Remote "OpenDrive root 'rclone-test-cekozew5qaro'", Local "Local file system at /tmp/rclone964997541", Modify Window "1s" run.go:285: Failed to put "A1/B1/C1/one" to "OpenDrive root 'rclone-test-cekozew5qaro'": failed to get folder list: Directory doesn't exist (Error 404) --- FAIL: TestRmdirsNoLeaveRoot (1.37s) === RUN TestRmdirsLeaveRoot run.go:180: Remote "OpenDrive root 'rclone-test-cekozew5qaro'", Local "Local file system at /tmp/rclone964997541", Modify Window "1s" 2025/01/22 03:13:36 INFO : A1: Making directory 2025/01/22 03:13:36 INFO : A1/B1: Making directory operations_test.go:747: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:747 Error: Received unexpected error: failed to get folder list: Directory doesn't exist (Error 404) Test: TestRmdirsLeaveRoot run.go:125: removing dir "A1" failed - try 1/3: Folder is already deleted (Error 403) run.go:125: removing dir "A1" failed - try 2/3: Folder is already deleted (Error 403) run.go:125: removing dir "A1" failed - try 3/3: Folder is already deleted (Error 403) run.go:128: removing dir "A1" failed: Folder is already deleted (Error 403) 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.22.0.linux-amd64/src/testing/testing.go:1175 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.22.0.linux-amd64/src/testing/testing.go:1353 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.22.0.linux-amd64/src/testing/testing.go:1683 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.22.0.linux-amd64/src/runtime/panic.go:626 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.22.0.linux-amd64/src/testing/testing.go:1005 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:747 Error: Not equal: expected: []string{} actual : []string{"A1"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=2) "A1" } Test: TestRmdirsLeaveRoot Messages: directories --- FAIL: TestRmdirsLeaveRoot (13.01s) === RUN TestRmdirsWithFilter run.go:180: Remote "OpenDrive root 'rclone-test-cekozew5qaro'", Local "Local file system at /tmp/rclone964997541", Modify Window "1s" 2025/01/22 03:13:49 INFO : A1: Making directory 2025/01/22 03:13:49 INFO : A1/B1: Making directory 2025/01/22 03:13:49 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 --- FAIL: TestRmdirsWithFilter (2.81s) === RUN TestMoveFileBackupDir run.go:180: Remote "OpenDrive root 'rclone-test-cekozew5qaro'", Local "Local file system at /tmp/rclone964997541", Modify Window "1s" 2025/01/22 03:13:53 DEBUG : dst/file1: Uploading chunk 0, size=18, remain=0 2025/01/22 03:13:55 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-cekozew5qaro/backup" 2025/01/22 03:13:56 DEBUG : Starting OpenDrive session with ID: 872f0116c74212430506ea9d43094874a24d85570a5a4eac80605ebd4f2e2828 2025/01/22 03:13:57 DEBUG : dst/file1: Sizes differ (src 14 vs dst 18) 2025/01/22 03:13:58 INFO : dst/file1: Moved (server-side) 2025/01/22 03:13:59 DEBUG : dst/file1: Uploading chunk 0, size=14, remain=0 2025/01/22 03:14:00 DEBUG : dst/file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK 2025/01/22 03:14:00 INFO : dst/file1: Copied (new) 2025/01/22 03:14:00 INFO : dst/file1: Deleted --- PASS: TestMoveFileBackupDir (11.48s) === RUN TestDirMove run.go:180: Remote "OpenDrive root 'rclone-test-cekozew5qaro'", Local "Local file system at /tmp/rclone964997541", Modify Window "1s" 2025/01/22 03:14:04 DEBUG : A1/one: Uploading chunk 0, size=3, remain=0 2025/01/22 03:14:06 DEBUG : A1/two: Uploading chunk 0, size=3, remain=0 2025/01/22 03:14:09 DEBUG : A1/B1/three: Uploading chunk 0, size=5, remain=0 2025/01/22 03:14:12 DEBUG : A1/B1/C1/four: Uploading chunk 0, size=4, remain=0 2025/01/22 03:14:15 DEBUG : A1/B1/C2/five: Uploading chunk 0, size=4, remain=0 2025/01/22 03:14:16 INFO : A1/B2: Making directory 2025/01/22 03:14:16 INFO : A1/B1/C3: Making directory 2025/01/22 03:14:18 DEBUG : A2: same parent dir (ODFfNzk4ODU2Nl9OTk1mdg) - using folder/rename instead of move_copy 2025/01/22 03:14:23 INFO : A2/one: Moved (server-side) to: A3/one 2025/01/22 03:14:23 INFO : A2/B1/three: Moved (server-side) to: A3/B1/three 2025/01/22 03:14:23 INFO : A2/two: Moved (server-side) to: A3/two 2025/01/22 03:14:23 INFO : A2/B1/C2/five: Moved (server-side) to: A3/B1/C2/five 2025/01/22 03:14:23 INFO : A2/B1/C1/four: Moved (server-side) to: A3/B1/C1/four 2025/01/22 03:14:26 INFO : OpenDrive root 'rclone-test-cekozew5qaro': Can't DirMove - falling back to file moves: can't move directory - incompatible remotes operations_test.go:1433: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1433 Error: Received unexpected error: RenameDir mkdir: failed to get folder list: Directory doesn't exist (Error 404) Test: TestDirMove 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/fs/operations/operations_test.go:1439 Error: Should be true Test: TestDirMove Messages: listing wrong, want A4/B1/C1/four (4), A4/B1/C2/five (4), A4/B1/three (5), A4/one (3), A4/two (3) got A3/B1/C1/four (4), A3/B1/C2/five (4), A3/B1/three (5), A3/one (3), A3/two (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/fs/operations/operations_test.go:1439 Error: Should be true Test: TestDirMove Messages: Unexpected file "A3/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/fs/operations/operations_test.go:1439 Error: Should be true Test: TestDirMove Messages: Unexpected file "A3/two" 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/fs/operations/operations_test.go:1439 Error: Should be true Test: TestDirMove Messages: Unexpected file "A3/B1/three" 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/fs/operations/operations_test.go:1439 Error: Should be true Test: TestDirMove Messages: Unexpected file "A3/B1/C1/four" 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/fs/operations/operations_test.go:1439 Error: Should be true Test: TestDirMove Messages: Unexpected file "A3/B1/C2/five" fstest.go:197: Not found "A4/B1/three" fstest.go:197: Not found "A4/B1/C1/four" fstest.go:197: Not found "A4/B1/C2/five" fstest.go:197: Not found "A4/one" fstest.go:197: Not found "A4/two" 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/fs/operations/operations_test.go:1439 Error: Not equal: expected: 0 actual : 5 Test: TestDirMove Messages: 5 objects not found 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/fs/operations/operations_test.go:1439 Error: Not equal: expected: []string{"A4", "A4/B1", "A4/B1/C1", "A4/B1/C2", "A4/B1/C3", "A4/B2"} actual : []string{"A3", "A3/B1", "A3/B1/C1", "A3/B1/C2", "A3/B1/C3", "A3/B2", "A4", "A4/B1"} Diff: --- Expected +++ Actual @@ -1,8 +1,10 @@ -([]string) (len=6) { +([]string) (len=8) { + (string) (len=2) "A3", + (string) (len=5) "A3/B1", + (string) (len=8) "A3/B1/C1", + (string) (len=8) "A3/B1/C2", + (string) (len=8) "A3/B1/C3", + (string) (len=5) "A3/B2", (string) (len=2) "A4", - (string) (len=5) "A4/B1", - (string) (len=8) "A4/B1/C1", - (string) (len=8) "A4/B1/C2", - (string) (len=8) "A4/B1/C3", - (string) (len=5) "A4/B2" + (string) (len=5) "A4/B1" } Test: TestDirMove Messages: directories 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: TestDirMove (48.42s) === RUN TestTouchDir run.go:180: Remote "OpenDrive root 'rclone-test-cekozew5qaro'", Local "Local file system at /tmp/rclone964997541", Modify Window "1s" 2025/01/22 03:14:52 DEBUG : potato2: Uploading chunk 0, size=60, remain=0 2025/01/22 03:14:54 DEBUG : empty space: Uploading chunk 0, size=1, remain=0 2025/01/22 03:14:58 DEBUG : sub dir/potato3: Uploading chunk 0, size=5, remain=0 2025/01/22 03:14:59 DEBUG : OpenDrive root 'rclone-test-cekozew5qaro': Touching "empty space" 2025/01/22 03:15:00 DEBUG : OpenDrive root 'rclone-test-cekozew5qaro': Touching "potato2" 2025/01/22 03:15:00 DEBUG : OpenDrive root 'rclone-test-cekozew5qaro': Touching "sub dir/potato3" fstest.go:121: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:121 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:126 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:145 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:189 /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/operations/operations_test.go:1684 Error: Should be true Test: TestTouchDir Messages: sub dir/potato3: Modification time difference too big |-11357h53m53.999999996s| > 1s (want 2010-09-08 07:06:05.000000004 +0000 UTC vs got 2011-12-25 12:59:59 +0000 UTC) (precision 1s) run.go:125: removing dir "sub dir" failed - try 1/3: folder not empty --- FAIL: TestTouchDir (12.26s) === RUN TestRemoveExisting run.go:180: Remote "OpenDrive root 'rclone-test-cekozew5qaro'", Local "Local file system at /tmp/rclone964997541", Modify Window "1s" 2025/01/22 03:15:05 DEBUG : sub dir/test remove existing: Uploading chunk 0, size=11, remain=0 2025/01/22 03:15:06 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: Uploading chunk 0, size=21, remain=0 2025/01/22 03:15:10 DEBUG : sub dir/test remove existing: TEST: renaming existing object to "sub dir/test remove existing.bekisej8" before starting 2025/01/22 03:15:10 DEBUG : sub dir/test remove existing: same parent dir (ODFfNzk4ODYyMF9EbTRuNQ) - using file/rename instead of move_copy for sub dir/test remove existing.bekisej8 2025/01/22 03:15:11 DEBUG : sub dir/test remove existing.bekisej8: TEST: removing renamed existing file after operation 2025/01/22 03:15:11 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: TEST: renaming existing object to "sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.duvejej5" before starting 2025/01/22 03:15:12 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: same parent dir (ODFfNzk4ODYyMF9EbTRuNQ) - using file/rename instead of move_copy for sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.duvejej5 2025/01/22 03:15:12 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.duvejej5: TEST: renaming existing back after failed operation 2025/01/22 03:15:13 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.duvejej5: same parent dir (ODFfNzk4ODYyMF9EbTRuNQ) - using file/rename instead of move_copy for sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789 2025/01/22 03:15:14 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: TEST: renaming existing object to "sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.fivivoy9" before starting 2025/01/22 03:15:14 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: same parent dir (ODFfNzk4ODYyMF9EbTRuNQ) - using file/rename instead of move_copy for sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.fivivoy9 operations_test.go:1952: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1952 Error: " 21 sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789\n" should not contain " 21 sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789\n" Test: TestRemoveExisting 2025/01/22 03:15:14 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.fivivoy9: TEST: removing renamed existing file after operation --- FAIL: TestRemoveExisting (12.21s) FAIL 2025/01/22 03:15:16 DEBUG : OpenDrive root 'rclone-test-cekozew5qaro': Purge remote "./operations.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestCheckSum|TestCopyFileBackupDir|TestCopyFileCopyDest|TestCopyFileMaxTransfer|TestDirMove|TestMoveFileBackupDir|TestPurge|TestRemoveExisting|TestRmdirsLeaveRoot|TestRmdirsNoLeaveRoot|TestRmdirsWithFilter|TestTouchDir)$'" - Finished ERROR in 3m27.506941254s (try 2/5): exit status 1: Failed [TestCheckSum TestCopyFileCopyDest TestPurge TestRmdirsNoLeaveRoot TestRmdirsLeaveRoot TestRmdirsWithFilter TestDirMove TestTouchDir TestRemoveExisting]