"./operations.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestDirMove|TestMoveFileBackupDir|TestPurge)$'" - Starting (try 2/5) 2025/12/31 01:21:24 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-suricer5gibi" 2025/12/31 01:21:24 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/12/31 01:21:25 DEBUG : Starting OpenDrive session with ID: 36fce2736912922bbf6a41e86489459aed6263d1ce26c26c6d11e367d6011057 2025/12/31 01:21:25 DEBUG : Creating backend with remote "/tmp/rclone964525780" === RUN TestPurge 2025/12/31 01:21:25 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-tabesew3cixa" 2025/12/31 01:21:25 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/12/31 01:21:25 DEBUG : Starting OpenDrive session with ID: e6dc8dd75f1b5a3b244a733a08400b9631b459d794fa9072655c157dc3589b90 2025/12/31 01:21:26 DEBUG : Creating backend with remote "/tmp/rclone2880424261" run.go:185: Remote "OpenDrive root 'rclone-test-tabesew3cixa'", Local "Local file system at /tmp/rclone2880424261", Modify Window "1s" 2025/12/31 01:21:28 DEBUG : A1/B1/C1/one: Uploading chunk 0, size=3, remain=0 2025/12/31 01:21:29 INFO : A2: Making directory 2025/12/31 01:21:30 INFO : A1/B2: Making directory 2025/12/31 01:21:30 INFO : A1/B2/C2: Making directory 2025/12/31 01:21:30 INFO : A1/B1/C3: Making directory 2025/12/31 01:21:31 INFO : A3: Making directory 2025/12/31 01:21:31 INFO : A3/B3: Making directory 2025/12/31 01:21:32 INFO : A3/B3/C4: Making directory 2025/12/31 01:21:33 DEBUG : A1/two: Uploading chunk 0, size=3, remain=0 2025/12/31 01:21:36 ERROR : error listing: directory not found 2025/12/31 01:21:36 DEBUG : OpenDrive root 'rclone-test-tabesew3cixa': Purge remote 2025/12/31 01:21:37 NOTICE: purge failed: directory not found --- PASS: TestPurge (11.63s) === RUN TestMoveFileBackupDir run.go:185: Remote "OpenDrive root 'rclone-test-suricer5gibi'", Local "Local file system at /tmp/rclone964525780", Modify Window "1s" 2025/12/31 01:21:38 DEBUG : dst/file1: Uploading chunk 0, size=18, remain=0 2025/12/31 01:21:40 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-suricer5gibi/backup" 2025/12/31 01:21:40 DEBUG : Starting OpenDrive session with ID: be8b986e5994eff818af2656a7d0c4d80c26205b975ca409de6a7843b8792136 2025/12/31 01:21:41 DEBUG : dst/file1: size = 14 (Local file system at /tmp/rclone964525780) 2025/12/31 01:21:41 DEBUG : dst/file1: size = 18 (OpenDrive root 'rclone-test-suricer5gibi') 2025/12/31 01:21:41 DEBUG : dst/file1: Sizes differ 2025/12/31 01:21:42 INFO : dst/file1: Moved (server-side) 2025/12/31 01:21:43 DEBUG : dst/file1: Uploading chunk 0, size=14, remain=0 2025/12/31 01:21:44 DEBUG : dst/file1: size = 14 OK 2025/12/31 01:21:44 DEBUG : dst/file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK 2025/12/31 01:21:44 INFO : dst/file1: Copied (new) 2025/12/31 01:21:44 INFO : dst/file1: Deleted 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:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1055 Error: Should be true Test: TestMoveFileBackupDir Messages: listing wrong, want backup/dst/file1 (18), dst/file1 (14) got backup/dst/file1 (14) fstest.go:143: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:143 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:149 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:195 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1055 Error: Should be true Test: TestMoveFileBackupDir Messages: OpenDrive root 'rclone-test-suricer5gibi'/backup/dst/file1: md5 hash incorrect - expecting "05164b153084ba910184c26e561a7c18" got "0ef726ce9b1a7692357ff70dd321d595" fstest.go:150: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:150 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:195 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1055 Error: Not equal: expected: 18 actual : 14 Test: TestMoveFileBackupDir Messages: backup/dst/file1: size incorrect file=18 vs obj=14 fstest.go:203: Not found "dst/file1" fstest.go:206: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1055 /usr/local/go/src/runtime/asm_amd64.s:1700 Error: Not equal: expected: 0 actual : 1 Test: TestMoveFileBackupDir Messages: 1 objects not found --- FAIL: TestMoveFileBackupDir (18.19s) === RUN TestDirMove run.go:185: Remote "OpenDrive root 'rclone-test-suricer5gibi'", Local "Local file system at /tmp/rclone964525780", Modify Window "1s" 2025/12/31 01:21:56 DEBUG : A1/one: Uploading chunk 0, size=3, remain=0 2025/12/31 01:21:58 DEBUG : A1/two: Uploading chunk 0, size=3, remain=0 2025/12/31 01:22:00 DEBUG : A1/B1/three: Uploading chunk 0, size=5, remain=0 2025/12/31 01:22:02 DEBUG : A1/B1/C1/four: Uploading chunk 0, size=4, remain=0 2025/12/31 01:22:04 DEBUG : A1/B1/C2/five: Uploading chunk 0, size=4, remain=0 2025/12/31 01:22:05 INFO : A1/B2: Making directory 2025/12/31 01:22:05 INFO : A1/B1/C3: Making directory 2025/12/31 01:22:07 DEBUG : A2: same parent dir (ODFfOTY2ODUyNV93ejBLdQ) - using folder/rename instead of move_copy 2025/12/31 01:22:11 INFO : A2/B1/C2/five: Moved (server-side) to: A3/B1/C2/five 2025/12/31 01:22:11 INFO : A2/one: Moved (server-side) to: A3/one 2025/12/31 01:22:11 INFO : A2/B1/C1/four: Moved (server-side) to: A3/B1/C1/four 2025/12/31 01:22:11 INFO : A2/two: Moved (server-side) to: A3/two 2025/12/31 01:22:11 INFO : A2/B1/three: Moved (server-side) to: A3/B1/three 2025/12/31 01:22:14 INFO : OpenDrive root 'rclone-test-suricer5gibi': Can't DirMove - falling back to file moves: can't move directory - incompatible remotes 2025/12/31 01:22:18 INFO : A3/one: Moved (server-side) to: A4/one 2025/12/31 01:22:18 INFO : A3/B1/three: Moved (server-side) to: A4/B1/three 2025/12/31 01:22:18 INFO : A3/two: Moved (server-side) to: A4/two 2025/12/31 01:22:18 INFO : A3/B1/C2/five: Moved (server-side) to: A4/B1/C2/five 2025/12/31 01:22:18 INFO : A3/B1/C1/four: Moved (server-side) to: A4/B1/C1/four --- PASS: TestDirMove (30.56s) FAIL 2025/12/31 01:22:25 DEBUG : OpenDrive root 'rclone-test-suricer5gibi': Purge remote "./operations.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestDirMove|TestMoveFileBackupDir|TestPurge)$'" - Finished ERROR in 1m1.769316695s (try 2/5): exit status 1: Failed [TestMoveFileBackupDir]