"./vfs.test -test.v -test.timeout 1h0m0s -remote TestUlozto: -verbose -test.run '^TestDirRename$'" - Starting (try 5/5) 2024/04/13 05:45:23 DEBUG : Creating backend with remote "TestUlozto:rclone-test-tufesit4wuhanah7jegotir8" 2024/04/13 05:45:23 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/04/13 05:45:25 DEBUG : Creating backend with remote "/tmp/rclone802661611" === RUN TestDirRename run.go:180: Remote "uloz.to root 'rclone-test-tufesit4wuhanah7jegotir8'", Local "Local file system at /tmp/rclone802661611", Modify Window "1µs" 2024/04/13 05:45:25 INFO : uloz.to root 'rclone-test-tufesit4wuhanah7jegotir8': poll-interval is not supported by this remote 2024/04/13 05:45:25 NOTICE: uloz.to root 'rclone-test-tufesit4wuhanah7jegotir8': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2024/04/13 05:46:31 ERROR : dir/not found: Dir.Rename error: file does not exist 2024/04/13 05:46:39 DEBUG : pacer: low level retry 1/10 (error Error 130003 (429): Endpoint received too many requests. Try it again later.) 2024/04/13 05:46:39 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2024/04/13 05:46:59 DEBUG : pacer: low level retry 2/10 (error Error 130003 (429): Endpoint received too many requests. Try it again later.) 2024/04/13 05:46:59 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2024/04/13 05:47:19 DEBUG : pacer: low level retry 3/10 (error Error 130003 (429): Endpoint received too many requests. Try it again later.) 2024/04/13 05:47:19 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2024/04/13 05:47:39 DEBUG : pacer: low level retry 4/10 (error Error 130003 (429): Endpoint received too many requests. Try it again later.) 2024/04/13 05:47:39 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2024/04/13 05:47:57 DEBUG : pacer: low level retry 5/10 (error Error 130003 (429): Endpoint received too many requests. Try it again later.) 2024/04/13 05:47:57 DEBUG : pacer: Rate limited, increasing sleep to 320ms 2024/04/13 05:48:15 DEBUG : pacer: low level retry 6/10 (error Error 130003 (429): Endpoint received too many requests. Try it again later.) 2024/04/13 05:48:15 DEBUG : pacer: Rate limited, increasing sleep to 640ms 2024/04/13 05:48:35 DEBUG : pacer: low level retry 7/10 (error Error 130003 (429): Endpoint received too many requests. Try it again later.) 2024/04/13 05:48:35 DEBUG : pacer: Rate limited, increasing sleep to 1.28s 2024/04/13 05:48:54 DEBUG : pacer: low level retry 8/10 (error Error 130003 (429): Endpoint received too many requests. Try it again later.) 2024/04/13 05:48:54 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/13 05:49:13 DEBUG : pacer: low level retry 9/10 (error Error 130003 (429): Endpoint received too many requests. Try it again later.) 2024/04/13 05:49:32 DEBUG : pacer: low level retry 10/10 (error Error 130003 (429): Endpoint received too many requests. Try it again later.) 2024/04/13 05:49:32 ERROR : dir: Dir.Rename error: Error 130003 (429): Endpoint received too many requests. Try it again later. dir_test.go:535: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:535 Error: Received unexpected error: Error 130003 (429): Endpoint received too many requests. Try it again later. Test: TestDirRename dir_test.go:247: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:247 /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:536 Error: Not equal: expected: []string{"dir2,0,true"} actual : []string{"dir,0,true"} Diff: --- Expected +++ Actual @@ -1,3 +1,3 @@ ([]string) (len=1) { - (string) (len=11) "dir2,0,true" + (string) (len=10) "dir,0,true" } Test: TestDirRename 2024/04/13 05:49:32 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/13 05:49:34 DEBUG : pacer: Reducing sleep to 1.125s 2024/04/13 05:49:36 DEBUG : pacer: Reducing sleep to 843.75ms 2024/04/13 05:49:37 DEBUG : pacer: Reducing sleep to 632.8125ms fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2024/04/13 05:49:38 DEBUG : pacer: Reducing sleep to 474.609375ms 2024/04/13 05:49:39 DEBUG : pacer: Reducing sleep to 355.957031ms 2024/04/13 05:49:39 DEBUG : pacer: Reducing sleep to 266.967773ms 2024/04/13 05:49:40 DEBUG : pacer: Reducing sleep to 200.225829ms 2024/04/13 05:49:40 DEBUG : pacer: Reducing sleep to 150.169371ms fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:295: Flushing the directory cache 2024/04/13 05:49:42 DEBUG : pacer: Reducing sleep to 112.627028ms 2024/04/13 05:49:42 DEBUG : pacer: Reducing sleep to 84.470271ms 2024/04/13 05:49:42 DEBUG : pacer: Reducing sleep to 63.352703ms 2024/04/13 05:49:43 DEBUG : pacer: Reducing sleep to 47.514527ms 2024/04/13 05:49:43 DEBUG : pacer: Reducing sleep to 35.635895ms 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/vfs/dir_test.go:542 Error: Should be true Test: TestDirRename Messages: listing wrong, want dir2/file1 (14), dir2/file3 (15) got dir/file1 (14), dir/file3 (15) 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/vfs/dir_test.go:542 Error: Should be true Test: TestDirRename Messages: Unexpected file "dir/file1" 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/vfs/dir_test.go:542 Error: Should be true Test: TestDirRename Messages: Unexpected file "dir/file3" fstest.go:197: Not found "dir2/file1" fstest.go:197: Not found "dir2/file3" 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/vfs/dir_test.go:542 Error: Not equal: expected: 0 actual : 2 Test: TestDirRename Messages: 2 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/vfs/dir_test.go:542 Error: Not equal: expected: []string{"dir2"} actual : []string{"dir"} Diff: --- Expected +++ Actual @@ -1,3 +1,3 @@ ([]string) (len=1) { - (string) (len=4) "dir2" + (string) (len=3) "dir" } Test: TestDirRename Messages: directories dir_test.go:546: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:546 Error: Received unexpected error: file does not exist Test: TestDirRename 2024/04/13 05:49:47 DEBUG : WaitForWriters: timeout=30s 2024/04/13 05:49:47 DEBUG : dir: Looking for writers 2024/04/13 05:49:47 DEBUG : file1: reading active writers 2024/04/13 05:49:47 DEBUG : file3: reading active writers 2024/04/13 05:49:47 DEBUG : : Looking for writers 2024/04/13 05:49:47 DEBUG : dir: reading active writers 2024/04/13 05:49:47 DEBUG : >WaitForWriters: 2024/04/13 05:49:47 DEBUG : pacer: Reducing sleep to 26.726921ms 2024/04/13 05:49:47 DEBUG : pacer: Reducing sleep to 20.04519ms 2024/04/13 05:49:47 DEBUG : pacer: Reducing sleep to 15.033892ms 2024/04/13 05:49:47 DEBUG : pacer: Reducing sleep to 11.275419ms 2024/04/13 05:49:48 DEBUG : pacer: Reducing sleep to 10ms --- FAIL: TestDirRename (276.85s) panic: interface conversion: vfs.Node is nil, not *vfs.Dir [recovered] panic: interface conversion: vfs.Node is nil, not *vfs.Dir goroutine 70 [running]: testing.tRunner.func1.2({0x1d5d1c0, 0xc00083f890}) /usr/local/go/src/testing/testing.go:1631 +0x24a testing.tRunner.func1() /usr/local/go/src/testing/testing.go:1634 +0x377 panic({0x1d5d1c0?, 0xc00083f890?}) /usr/local/go/src/runtime/panic.go:770 +0x132 github.com/rclone/rclone/vfs.TestDirRename(0xc0005acea0) /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:547 +0xe16 testing.tRunner(0xc0005acea0, 0x2291ab8) /usr/local/go/src/testing/testing.go:1689 +0xfb created by testing.(*T).Run in goroutine 1 /usr/local/go/src/testing/testing.go:1742 +0x390 "./vfs.test -test.v -test.timeout 1h0m0s -remote TestUlozto: -verbose -test.run '^TestDirRename$'" - Finished ERROR in 4m38.689646559s (try 5/5): exit status 2: Failed [TestDirRename]