"./vfs.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestDirCreate|TestDirFileOpen|TestDirForgetAll|TestDirForgetPath|TestDirHandleMethods|TestDirHandleReaddir|TestDirHandleReaddirnames|TestDirMetadataExtension|TestDirMethods|TestDirMkdir|TestDirMkdirSub|TestDirOpen|TestDirReadDirAll|TestDirRemove|TestDirRemoveAll|TestDirRemoveName|TestDirRename|TestDirSetModTime|TestDirStat|TestDirWalk|TestFileMethods|TestFileOpenRead|TestFileOpenWrite|TestFileRemove|TestFileRemoveAll)$|^TestFileSetModTime$/^(cache=full,open=false,write=false|cache=full,open=true,write=false|cache=full,open=true,write=true|cache=off,open=false,write=false|cache=off,open=true,write=false|cache=off,open=true,write=true)$'" - Starting (try 2/5) 2025/04/28 06:04:32 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-tojawiz0teha" 2025/04/28 06:04:32 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/04/28 06:04:33 DEBUG : Creating backend with remote "/tmp/rclone1175395552" === RUN TestDirHandleMethods run.go:180: Remote "Linkbox root 'rclone-test-tojawiz0teha'", Local "Local file system at /tmp/rclone1175395552", Modify Window "876000h0m0s" 2025/04/28 06:04:33 INFO : Linkbox root 'rclone-test-tojawiz0teha': poll-interval is not supported by this remote 2025/04/28 06:04:33 NOTICE: Linkbox root 'rclone-test-tojawiz0teha': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/04/28 06:04:39 DEBUG : dir/file1: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 06:04:39 DEBUG : dir/file1: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 06:04:39 DEBUG : dir/file1: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 06:04:40 DEBUG : dir/file1: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 06:04:40 DEBUG : dir/file1: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 06:04:42 DEBUG : dir/file1: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 06:04:45 DEBUG : dir/file1: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 06:04:52 DEBUG : dir/file1: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 06:05:05 DEBUG : dir/file1: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 06:05:30 DEBUG : dir/file1: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "dir/file1" to "Linkbox root 'rclone-test-tojawiz0teha'": object not found 2025/04/28 06:06:21 DEBUG : WaitForWriters: timeout=30s 2025/04/28 06:06:21 DEBUG : : Looking for writers 2025/04/28 06:06:21 DEBUG : >WaitForWriters: run.go:125: removing dir "dir" failed - try 1/3: directory not empty run.go:125: removing dir "dir" failed - try 2/3: directory not empty run.go:125: removing dir "dir" failed - try 3/3: directory not empty run.go:128: removing dir "dir" failed: directory not empty fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 06:06:28 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestDirHandleMethods (121.50s) === RUN TestDirHandleReaddir run.go:180: Remote "Linkbox root 'rclone-test-tojawiz0teha'", Local "Local file system at /tmp/rclone1175395552", Modify Window "876000h0m0s" 2025/04/28 06:06:34 INFO : Linkbox root 'rclone-test-tojawiz0teha': poll-interval is not supported by this remote 2025/04/28 06:06:34 NOTICE: Linkbox root 'rclone-test-tojawiz0teha': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/04/28 06:06:36 DEBUG : dir/file1: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 06:06:36 DEBUG : dir/file1: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 06:06:36 DEBUG : dir/file1: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 06:06:36 DEBUG : dir/file1: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 06:06:37 DEBUG : dir/file1: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 06:06:39 DEBUG : dir/file1: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 06:06:42 DEBUG : dir/file1: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 06:06:49 DEBUG : dir/file1: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 06:07:01 DEBUG : dir/file1: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 06:07:27 DEBUG : dir/file1: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "dir/file1" to "Linkbox root 'rclone-test-tojawiz0teha'": object not found 2025/04/28 06:08:18 DEBUG : WaitForWriters: timeout=30s 2025/04/28 06:08:18 DEBUG : : Looking for writers 2025/04/28 06:08:18 DEBUG : >WaitForWriters: run.go:125: removing dir "dir" failed - try 1/3: directory not empty run.go:125: removing dir "dir" failed - try 2/3: directory not empty run.go:125: removing dir "dir" failed - try 3/3: directory not empty run.go:128: removing dir "dir" failed: directory not empty fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 06:08:23 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestDirHandleReaddir (114.94s) === RUN TestDirHandleReaddirnames run.go:180: Remote "Linkbox root 'rclone-test-tojawiz0teha'", Local "Local file system at /tmp/rclone1175395552", Modify Window "876000h0m0s" 2025/04/28 06:08:29 INFO : Linkbox root 'rclone-test-tojawiz0teha': poll-interval is not supported by this remote 2025/04/28 06:08:29 NOTICE: Linkbox root 'rclone-test-tojawiz0teha': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/04/28 06:08:31 DEBUG : dir/file1: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 06:08:31 DEBUG : dir/file1: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 06:08:31 DEBUG : dir/file1: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 06:08:31 DEBUG : dir/file1: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 06:08:32 DEBUG : dir/file1: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 06:08:34 DEBUG : dir/file1: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 06:08:37 DEBUG : dir/file1: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 06:08:43 DEBUG : dir/file1: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 06:08:56 DEBUG : dir/file1: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 06:09:22 DEBUG : dir/file1: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "dir/file1" to "Linkbox root 'rclone-test-tojawiz0teha'": object not found 2025/04/28 06:10:13 DEBUG : WaitForWriters: timeout=30s 2025/04/28 06:10:13 DEBUG : : Looking for writers 2025/04/28 06:10:13 DEBUG : >WaitForWriters: run.go:125: removing dir "dir" failed - try 1/3: directory not empty run.go:125: removing dir "dir" failed - try 2/3: directory not empty run.go:125: removing dir "dir" failed - try 3/3: directory not empty run.go:128: removing dir "dir" failed: directory not empty fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 06:10:18 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestDirHandleReaddirnames (114.95s) === RUN TestDirMethods run.go:180: Remote "Linkbox root 'rclone-test-tojawiz0teha'", Local "Local file system at /tmp/rclone1175395552", Modify Window "876000h0m0s" 2025/04/28 06:10:24 INFO : Linkbox root 'rclone-test-tojawiz0teha': poll-interval is not supported by this remote 2025/04/28 06:10:24 NOTICE: Linkbox root 'rclone-test-tojawiz0teha': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/04/28 06:10:25 DEBUG : dir/file1: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 06:10:26 DEBUG : dir/file1: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 06:10:26 DEBUG : dir/file1: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 06:10:26 DEBUG : dir/file1: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 06:10:27 DEBUG : dir/file1: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 06:10:29 DEBUG : dir/file1: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 06:10:32 DEBUG : dir/file1: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 06:10:38 DEBUG : dir/file1: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 06:10:51 DEBUG : dir/file1: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 06:11:17 DEBUG : dir/file1: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "dir/file1" to "Linkbox root 'rclone-test-tojawiz0teha'": object not found 2025/04/28 06:12:08 DEBUG : WaitForWriters: timeout=30s 2025/04/28 06:12:08 DEBUG : : Looking for writers 2025/04/28 06:12:08 DEBUG : >WaitForWriters: run.go:125: removing dir "dir" failed - try 1/3: directory not empty run.go:125: removing dir "dir" failed - try 2/3: directory not empty run.go:125: removing dir "dir" failed - try 3/3: directory not empty run.go:128: removing dir "dir" failed: directory not empty fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 06:12:13 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestDirMethods (114.95s) === RUN TestDirForgetAll run.go:180: Remote "Linkbox root 'rclone-test-tojawiz0teha'", Local "Local file system at /tmp/rclone1175395552", Modify Window "876000h0m0s" 2025/04/28 06:12:19 INFO : Linkbox root 'rclone-test-tojawiz0teha': poll-interval is not supported by this remote 2025/04/28 06:12:19 NOTICE: Linkbox root 'rclone-test-tojawiz0teha': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/04/28 06:12:20 DEBUG : dir/file1: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 06:12:21 DEBUG : dir/file1: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 06:12:21 DEBUG : dir/file1: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 06:12:21 DEBUG : dir/file1: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 06:12:22 DEBUG : dir/file1: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 06:12:24 DEBUG : dir/file1: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 06:12:27 DEBUG : dir/file1: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 06:12:33 DEBUG : dir/file1: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 06:12:46 DEBUG : dir/file1: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 06:13:12 DEBUG : dir/file1: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "dir/file1" to "Linkbox root 'rclone-test-tojawiz0teha'": object not found 2025/04/28 06:14:03 DEBUG : WaitForWriters: timeout=30s 2025/04/28 06:14:03 DEBUG : : Looking for writers 2025/04/28 06:14:03 DEBUG : >WaitForWriters: run.go:125: removing dir "dir" failed - try 1/3: directory not empty run.go:125: removing dir "dir" failed - try 2/3: directory not empty run.go:125: removing dir "dir" failed - try 3/3: directory not empty run.go:128: removing dir "dir" failed: directory not empty fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 06:14:08 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestDirForgetAll (114.95s) === RUN TestDirForgetPath run.go:180: Remote "Linkbox root 'rclone-test-tojawiz0teha'", Local "Local file system at /tmp/rclone1175395552", Modify Window "876000h0m0s" 2025/04/28 06:14:14 INFO : Linkbox root 'rclone-test-tojawiz0teha': poll-interval is not supported by this remote 2025/04/28 06:14:14 NOTICE: Linkbox root 'rclone-test-tojawiz0teha': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/04/28 06:14:15 DEBUG : dir/file1: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 06:14:16 DEBUG : dir/file1: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 06:14:16 DEBUG : dir/file1: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 06:14:16 DEBUG : dir/file1: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 06:14:17 DEBUG : dir/file1: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 06:14:19 DEBUG : dir/file1: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 06:14:22 DEBUG : dir/file1: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 06:14:28 DEBUG : dir/file1: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 06:14:33 DEBUG : : forgetting directory cache 2025/04/28 06:14:41 DEBUG : dir/file1: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 06:15:07 DEBUG : dir/file1: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "dir/file1" to "Linkbox root 'rclone-test-tojawiz0teha'": object not found 2025/04/28 06:15:58 DEBUG : WaitForWriters: timeout=30s 2025/04/28 06:15:58 DEBUG : : Looking for writers 2025/04/28 06:15:58 DEBUG : >WaitForWriters: run.go:125: removing dir "dir" failed - try 1/3: directory not empty run.go:125: removing dir "dir" failed - try 2/3: directory not empty run.go:125: removing dir "dir" failed - try 3/3: directory not empty run.go:128: removing dir "dir" failed: directory not empty fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 06:16:03 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestDirForgetPath (114.95s) === RUN TestDirWalk run.go:180: Remote "Linkbox root 'rclone-test-tojawiz0teha'", Local "Local file system at /tmp/rclone1175395552", Modify Window "876000h0m0s" 2025/04/28 06:16:09 INFO : Linkbox root 'rclone-test-tojawiz0teha': poll-interval is not supported by this remote 2025/04/28 06:16:09 NOTICE: Linkbox root 'rclone-test-tojawiz0teha': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/04/28 06:16:10 DEBUG : dir/file1: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 06:16:11 DEBUG : dir/file1: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 06:16:11 DEBUG : dir/file1: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 06:16:11 DEBUG : dir/file1: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 06:16:12 DEBUG : dir/file1: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 06:16:14 DEBUG : dir/file1: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 06:16:17 DEBUG : dir/file1: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 06:16:23 DEBUG : dir/file1: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 06:16:34 DEBUG : : forgetting directory cache 2025/04/28 06:16:36 DEBUG : dir/file1: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 06:17:02 DEBUG : dir/file1: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "dir/file1" to "Linkbox root 'rclone-test-tojawiz0teha'": object not found 2025/04/28 06:17:53 DEBUG : WaitForWriters: timeout=30s 2025/04/28 06:17:53 DEBUG : : Looking for writers 2025/04/28 06:17:53 DEBUG : >WaitForWriters: run.go:125: removing dir "dir" failed - try 1/3: directory not empty run.go:125: removing dir "dir" failed - try 2/3: directory not empty run.go:125: removing dir "dir" failed - try 3/3: directory not empty run.go:128: removing dir "dir" failed: directory not empty fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 06:17:58 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestDirWalk (114.95s) === RUN TestDirSetModTime run.go:180: Remote "Linkbox root 'rclone-test-tojawiz0teha'", Local "Local file system at /tmp/rclone1175395552", Modify Window "876000h0m0s" 2025/04/28 06:18:04 INFO : Linkbox root 'rclone-test-tojawiz0teha': poll-interval is not supported by this remote 2025/04/28 06:18:04 NOTICE: Linkbox root 'rclone-test-tojawiz0teha': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/04/28 06:18:05 DEBUG : dir/file1: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 06:18:05 DEBUG : dir/file1: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 06:18:06 DEBUG : dir/file1: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 06:18:06 DEBUG : dir/file1: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 06:18:07 DEBUG : dir/file1: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 06:18:09 DEBUG : dir/file1: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 06:18:12 DEBUG : dir/file1: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 06:18:18 DEBUG : dir/file1: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 06:18:29 DEBUG : : forgetting directory cache 2025/04/28 06:18:31 DEBUG : dir/file1: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 06:18:57 DEBUG : dir/file1: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "dir/file1" to "Linkbox root 'rclone-test-tojawiz0teha'": object not found 2025/04/28 06:19:48 DEBUG : WaitForWriters: timeout=30s 2025/04/28 06:19:48 DEBUG : : Looking for writers 2025/04/28 06:19:48 DEBUG : >WaitForWriters: run.go:125: removing dir "dir" failed - try 1/3: directory not empty run.go:125: removing dir "dir" failed - try 2/3: directory not empty run.go:125: removing dir "dir" failed - try 3/3: directory not empty run.go:128: removing dir "dir" failed: directory not empty fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 06:19:53 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestDirSetModTime (114.97s) === RUN TestDirStat run.go:180: Remote "Linkbox root 'rclone-test-tojawiz0teha'", Local "Local file system at /tmp/rclone1175395552", Modify Window "876000h0m0s" 2025/04/28 06:19:59 INFO : Linkbox root 'rclone-test-tojawiz0teha': poll-interval is not supported by this remote 2025/04/28 06:19:59 NOTICE: Linkbox root 'rclone-test-tojawiz0teha': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/04/28 06:20:00 DEBUG : dir/file1: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 06:20:00 DEBUG : dir/file1: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 06:20:01 DEBUG : dir/file1: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 06:20:01 DEBUG : dir/file1: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 06:20:02 DEBUG : dir/file1: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 06:20:04 DEBUG : dir/file1: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 06:20:07 DEBUG : dir/file1: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 06:20:13 DEBUG : dir/file1: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 06:20:24 DEBUG : : forgetting directory cache 2025/04/28 06:20:26 DEBUG : dir/file1: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 06:20:52 DEBUG : dir/file1: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "dir/file1" to "Linkbox root 'rclone-test-tojawiz0teha'": object not found 2025/04/28 06:21:43 DEBUG : WaitForWriters: timeout=30s 2025/04/28 06:21:43 DEBUG : : Looking for writers 2025/04/28 06:21:43 DEBUG : >WaitForWriters: run.go:125: removing dir "dir" failed - try 1/3: directory not empty run.go:125: removing dir "dir" failed - try 2/3: directory not empty run.go:125: removing dir "dir" failed - try 3/3: directory not empty run.go:128: removing dir "dir" failed: directory not empty fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 06:21:48 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestDirStat (114.95s) === RUN TestDirReadDirAll run.go:180: Remote "Linkbox root 'rclone-test-tojawiz0teha'", Local "Local file system at /tmp/rclone1175395552", Modify Window "876000h0m0s" 2025/04/28 06:21:54 INFO : Linkbox root 'rclone-test-tojawiz0teha': poll-interval is not supported by this remote 2025/04/28 06:21:54 NOTICE: Linkbox root 'rclone-test-tojawiz0teha': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/04/28 06:21:55 DEBUG : dir/file1: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 06:21:55 DEBUG : dir/file1: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 06:21:56 DEBUG : dir/file1: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 06:21:56 DEBUG : dir/file1: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 06:21:57 DEBUG : dir/file1: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 06:21:58 DEBUG : dir/file1: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 06:22:02 DEBUG : dir/file1: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 06:22:08 DEBUG : dir/file1: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 06:22:19 DEBUG : : forgetting directory cache 2025/04/28 06:22:21 DEBUG : dir/file1: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 06:22:47 DEBUG : dir/file1: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "dir/file1" to "Linkbox root 'rclone-test-tojawiz0teha'": object not found 2025/04/28 06:23:38 DEBUG : WaitForWriters: timeout=30s 2025/04/28 06:23:38 DEBUG : : Looking for writers 2025/04/28 06:23:38 DEBUG : >WaitForWriters: run.go:125: removing dir "dir" failed - try 1/3: directory not empty run.go:125: removing dir "dir" failed - try 2/3: directory not empty run.go:125: removing dir "dir" failed - try 3/3: directory not empty run.go:128: removing dir "dir" failed: directory not empty fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 06:23:43 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestDirReadDirAll (114.96s) === RUN TestDirOpen run.go:180: Remote "Linkbox root 'rclone-test-tojawiz0teha'", Local "Local file system at /tmp/rclone1175395552", Modify Window "876000h0m0s" 2025/04/28 06:23:49 INFO : Linkbox root 'rclone-test-tojawiz0teha': poll-interval is not supported by this remote 2025/04/28 06:23:49 NOTICE: Linkbox root 'rclone-test-tojawiz0teha': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/04/28 06:23:50 DEBUG : dir/file1: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 06:23:50 DEBUG : dir/file1: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 06:23:51 DEBUG : dir/file1: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 06:23:51 DEBUG : dir/file1: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 06:23:52 DEBUG : dir/file1: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 06:23:53 DEBUG : dir/file1: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 06:23:57 DEBUG : dir/file1: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 06:24:03 DEBUG : dir/file1: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 06:24:14 DEBUG : : forgetting directory cache 2025/04/28 06:24:16 DEBUG : dir/file1: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 06:24:42 DEBUG : dir/file1: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "dir/file1" to "Linkbox root 'rclone-test-tojawiz0teha'": object not found 2025/04/28 06:25:33 DEBUG : WaitForWriters: timeout=30s 2025/04/28 06:25:33 DEBUG : : Looking for writers 2025/04/28 06:25:33 DEBUG : >WaitForWriters: run.go:125: removing dir "dir" failed - try 1/3: directory not empty run.go:125: removing dir "dir" failed - try 2/3: directory not empty run.go:125: removing dir "dir" failed - try 3/3: directory not empty run.go:128: removing dir "dir" failed: directory not empty fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 06:25:38 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestDirOpen (114.95s) === RUN TestDirCreate run.go:180: Remote "Linkbox root 'rclone-test-tojawiz0teha'", Local "Local file system at /tmp/rclone1175395552", Modify Window "876000h0m0s" 2025/04/28 06:25:44 INFO : Linkbox root 'rclone-test-tojawiz0teha': poll-interval is not supported by this remote 2025/04/28 06:25:44 NOTICE: Linkbox root 'rclone-test-tojawiz0teha': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/04/28 06:25:45 DEBUG : dir/file1: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 06:25:45 DEBUG : dir/file1: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 06:25:46 DEBUG : dir/file1: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 06:25:46 DEBUG : dir/file1: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 06:25:47 DEBUG : dir/file1: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 06:25:48 DEBUG : dir/file1: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 06:25:52 DEBUG : dir/file1: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 06:25:58 DEBUG : dir/file1: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 06:26:09 DEBUG : : forgetting directory cache 2025/04/28 06:26:11 DEBUG : dir/file1: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 06:26:36 DEBUG : dir/file1: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "dir/file1" to "Linkbox root 'rclone-test-tojawiz0teha'": object not found 2025/04/28 06:27:28 DEBUG : WaitForWriters: timeout=30s 2025/04/28 06:27:28 DEBUG : : Looking for writers 2025/04/28 06:27:28 DEBUG : >WaitForWriters: run.go:125: removing dir "dir" failed - try 1/3: directory not empty run.go:125: removing dir "dir" failed - try 2/3: directory not empty run.go:125: removing dir "dir" failed - try 3/3: directory not empty run.go:128: removing dir "dir" failed: directory not empty fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 06:27:33 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestDirCreate (114.95s) === RUN TestDirMkdir run.go:180: Remote "Linkbox root 'rclone-test-tojawiz0teha'", Local "Local file system at /tmp/rclone1175395552", Modify Window "876000h0m0s" 2025/04/28 06:27:39 INFO : Linkbox root 'rclone-test-tojawiz0teha': poll-interval is not supported by this remote 2025/04/28 06:27:39 NOTICE: Linkbox root 'rclone-test-tojawiz0teha': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/04/28 06:27:40 DEBUG : dir/file1: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 06:27:40 DEBUG : dir/file1: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 06:27:40 DEBUG : dir/file1: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 06:27:41 DEBUG : dir/file1: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 06:27:42 DEBUG : dir/file1: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 06:27:43 DEBUG : dir/file1: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 06:27:47 DEBUG : dir/file1: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 06:27:53 DEBUG : dir/file1: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 06:28:04 DEBUG : : forgetting directory cache 2025/04/28 06:28:06 DEBUG : dir/file1: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 06:28:31 DEBUG : dir/file1: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "dir/file1" to "Linkbox root 'rclone-test-tojawiz0teha'": object not found 2025/04/28 06:29:23 DEBUG : WaitForWriters: timeout=30s 2025/04/28 06:29:23 DEBUG : : Looking for writers 2025/04/28 06:29:23 DEBUG : >WaitForWriters: run.go:125: removing dir "dir" failed - try 1/3: directory not empty run.go:125: removing dir "dir" failed - try 2/3: directory not empty run.go:125: removing dir "dir" failed - try 3/3: directory not empty run.go:128: removing dir "dir" failed: directory not empty fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 06:29:28 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestDirMkdir (114.94s) === RUN TestDirMkdirSub run.go:180: Remote "Linkbox root 'rclone-test-tojawiz0teha'", Local "Local file system at /tmp/rclone1175395552", Modify Window "876000h0m0s" 2025/04/28 06:29:34 INFO : Linkbox root 'rclone-test-tojawiz0teha': poll-interval is not supported by this remote 2025/04/28 06:29:34 NOTICE: Linkbox root 'rclone-test-tojawiz0teha': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/04/28 06:29:35 DEBUG : dir/file1: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 06:29:35 DEBUG : dir/file1: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 06:29:35 DEBUG : dir/file1: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 06:29:36 DEBUG : dir/file1: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 06:29:37 DEBUG : dir/file1: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 06:29:38 DEBUG : dir/file1: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 06:29:41 DEBUG : dir/file1: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 06:29:48 DEBUG : dir/file1: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 06:29:59 DEBUG : : forgetting directory cache 2025/04/28 06:30:01 DEBUG : dir/file1: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 06:30:26 DEBUG : dir/file1: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "dir/file1" to "Linkbox root 'rclone-test-tojawiz0teha'": object not found 2025/04/28 06:31:18 DEBUG : WaitForWriters: timeout=30s 2025/04/28 06:31:18 DEBUG : : Looking for writers 2025/04/28 06:31:18 DEBUG : >WaitForWriters: run.go:125: removing dir "dir" failed - try 1/3: directory not empty run.go:125: removing dir "dir" failed - try 2/3: directory not empty run.go:125: removing dir "dir" failed - try 3/3: directory not empty run.go:128: removing dir "dir" failed: directory not empty fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 06:31:22 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestDirMkdirSub (114.96s) === RUN TestDirRemove run.go:180: Remote "Linkbox root 'rclone-test-tojawiz0teha'", Local "Local file system at /tmp/rclone1175395552", Modify Window "876000h0m0s" 2025/04/28 06:31:28 INFO : Linkbox root 'rclone-test-tojawiz0teha': poll-interval is not supported by this remote 2025/04/28 06:31:28 NOTICE: Linkbox root 'rclone-test-tojawiz0teha': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/04/28 06:31:30 DEBUG : dir/file1: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 06:31:30 DEBUG : dir/file1: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 06:31:30 DEBUG : dir/file1: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 06:31:31 DEBUG : dir/file1: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 06:31:32 DEBUG : dir/file1: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 06:31:33 DEBUG : dir/file1: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 06:31:36 DEBUG : dir/file1: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 06:31:43 DEBUG : dir/file1: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 06:31:54 DEBUG : : forgetting directory cache 2025/04/28 06:31:56 DEBUG : dir/file1: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 06:32:21 DEBUG : dir/file1: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "dir/file1" to "Linkbox root 'rclone-test-tojawiz0teha'": object not found 2025/04/28 06:33:13 DEBUG : WaitForWriters: timeout=30s 2025/04/28 06:33:13 DEBUG : : Looking for writers 2025/04/28 06:33:13 DEBUG : >WaitForWriters: run.go:125: removing dir "dir" failed - try 1/3: directory not empty run.go:125: removing dir "dir" failed - try 2/3: directory not empty run.go:125: removing dir "dir" failed - try 3/3: directory not empty run.go:128: removing dir "dir" failed: directory not empty fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 06:33:17 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestDirRemove (114.97s) === RUN TestDirRemoveAll run.go:180: Remote "Linkbox root 'rclone-test-tojawiz0teha'", Local "Local file system at /tmp/rclone1175395552", Modify Window "876000h0m0s" 2025/04/28 06:33:23 INFO : Linkbox root 'rclone-test-tojawiz0teha': poll-interval is not supported by this remote 2025/04/28 06:33:23 NOTICE: Linkbox root 'rclone-test-tojawiz0teha': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/04/28 06:33:25 DEBUG : dir/file1: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 06:33:25 DEBUG : dir/file1: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 06:33:25 DEBUG : dir/file1: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 06:33:26 DEBUG : dir/file1: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 06:33:27 DEBUG : dir/file1: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 06:33:28 DEBUG : dir/file1: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 06:33:31 DEBUG : dir/file1: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 06:33:38 DEBUG : dir/file1: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 06:33:49 DEBUG : : forgetting directory cache 2025/04/28 06:33:51 DEBUG : dir/file1: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 06:34:16 DEBUG : dir/file1: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "dir/file1" to "Linkbox root 'rclone-test-tojawiz0teha'": object not found 2025/04/28 06:35:08 DEBUG : WaitForWriters: timeout=30s 2025/04/28 06:35:08 DEBUG : : Looking for writers 2025/04/28 06:35:08 DEBUG : >WaitForWriters: run.go:125: removing dir "dir" failed - try 1/3: directory not empty run.go:125: removing dir "dir" failed - try 2/3: directory not empty run.go:125: removing dir "dir" failed - try 3/3: directory not empty run.go:128: removing dir "dir" failed: directory not empty fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 06:35:12 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestDirRemoveAll (114.98s) === RUN TestDirRemoveName run.go:180: Remote "Linkbox root 'rclone-test-tojawiz0teha'", Local "Local file system at /tmp/rclone1175395552", Modify Window "876000h0m0s" 2025/04/28 06:35:18 INFO : Linkbox root 'rclone-test-tojawiz0teha': poll-interval is not supported by this remote 2025/04/28 06:35:18 NOTICE: Linkbox root 'rclone-test-tojawiz0teha': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/04/28 06:35:20 DEBUG : dir/file1: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 06:35:20 DEBUG : dir/file1: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 06:35:20 DEBUG : dir/file1: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 06:35:21 DEBUG : dir/file1: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 06:35:22 DEBUG : dir/file1: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 06:35:23 DEBUG : dir/file1: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 06:35:26 DEBUG : dir/file1: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 06:35:33 DEBUG : dir/file1: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 06:35:44 DEBUG : : forgetting directory cache 2025/04/28 06:35:46 DEBUG : dir/file1: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 06:36:11 DEBUG : dir/file1: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "dir/file1" to "Linkbox root 'rclone-test-tojawiz0teha'": object not found 2025/04/28 06:37:02 DEBUG : WaitForWriters: timeout=30s 2025/04/28 06:37:02 DEBUG : : Looking for writers 2025/04/28 06:37:02 DEBUG : >WaitForWriters: run.go:125: removing dir "dir" failed - try 1/3: directory not empty run.go:125: removing dir "dir" failed - try 2/3: directory not empty run.go:125: removing dir "dir" failed - try 3/3: directory not empty run.go:128: removing dir "dir" failed: directory not empty fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 06:37:07 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestDirRemoveName (114.95s) === RUN TestDirRename run.go:180: Remote "Linkbox root 'rclone-test-tojawiz0teha'", Local "Local file system at /tmp/rclone1175395552", Modify Window "876000h0m0s" 2025/04/28 06:37:13 INFO : Linkbox root 'rclone-test-tojawiz0teha': poll-interval is not supported by this remote 2025/04/28 06:37:13 NOTICE: Linkbox root 'rclone-test-tojawiz0teha': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/04/28 06:37:15 DEBUG : dir/file1: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 06:37:15 DEBUG : dir/file1: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 06:37:15 DEBUG : dir/file1: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 06:37:16 DEBUG : dir/file1: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 06:37:16 DEBUG : dir/file1: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 06:37:18 DEBUG : dir/file1: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 06:37:21 DEBUG : dir/file1: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 06:37:28 DEBUG : dir/file1: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 06:37:39 DEBUG : : forgetting directory cache 2025/04/28 06:37:41 DEBUG : dir/file1: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 06:38:06 DEBUG : dir/file1: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "dir/file1" to "Linkbox root 'rclone-test-tojawiz0teha'": object not found 2025/04/28 06:38:57 DEBUG : WaitForWriters: timeout=30s 2025/04/28 06:38:57 DEBUG : : Looking for writers 2025/04/28 06:38:57 DEBUG : >WaitForWriters: run.go:125: removing dir "dir" failed - try 1/3: directory not empty run.go:125: removing dir "dir" failed - try 2/3: directory not empty run.go:125: removing dir "dir" failed - try 3/3: directory not empty run.go:128: removing dir "dir" failed: directory not empty fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 06:39:02 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestDirRename (114.94s) === RUN TestDirFileOpen run.go:180: Remote "Linkbox root 'rclone-test-tojawiz0teha'", Local "Local file system at /tmp/rclone1175395552", Modify Window "876000h0m0s" 2025/04/28 06:39:08 INFO : Linkbox root 'rclone-test-tojawiz0teha': poll-interval is not supported by this remote 2025/04/28 06:39:08 NOTICE: Linkbox root 'rclone-test-tojawiz0teha': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/04/28 06:39:10 DEBUG : dir/file1: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 06:39:10 DEBUG : dir/file1: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 06:39:10 DEBUG : dir/file1: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 06:39:11 DEBUG : dir/file1: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 06:39:11 DEBUG : dir/file1: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 06:39:13 DEBUG : dir/file1: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 06:39:16 DEBUG : dir/file1: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 06:39:23 DEBUG : dir/file1: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 06:39:34 DEBUG : : forgetting directory cache 2025/04/28 06:39:36 DEBUG : dir/file1: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 06:40:01 DEBUG : dir/file1: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "dir/file1" to "Linkbox root 'rclone-test-tojawiz0teha'": object not found 2025/04/28 06:40:52 DEBUG : WaitForWriters: timeout=30s 2025/04/28 06:40:52 DEBUG : : Looking for writers 2025/04/28 06:40:52 DEBUG : >WaitForWriters: run.go:125: removing dir "dir" failed - try 1/3: directory not empty run.go:125: removing dir "dir" failed - try 2/3: directory not empty run.go:125: removing dir "dir" failed - try 3/3: directory not empty run.go:128: removing dir "dir" failed: directory not empty fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 06:40:57 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestDirFileOpen (114.96s) === RUN TestDirMetadataExtension run.go:180: Remote "Linkbox root 'rclone-test-tojawiz0teha'", Local "Local file system at /tmp/rclone1175395552", Modify Window "876000h0m0s" 2025/04/28 06:41:03 INFO : Linkbox root 'rclone-test-tojawiz0teha': poll-interval is not supported by this remote 2025/04/28 06:41:03 NOTICE: Linkbox root 'rclone-test-tojawiz0teha': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/04/28 06:41:05 DEBUG : dir/file1: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 06:41:05 DEBUG : dir/file1: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 06:41:05 DEBUG : dir/file1: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 06:41:06 DEBUG : dir/file1: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 06:41:06 DEBUG : dir/file1: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 06:41:08 DEBUG : dir/file1: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 06:41:11 DEBUG : dir/file1: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 06:41:18 DEBUG : dir/file1: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 06:41:28 DEBUG : : forgetting directory cache 2025/04/28 06:41:31 DEBUG : dir/file1: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 06:41:56 DEBUG : dir/file1: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "dir/file1" to "Linkbox root 'rclone-test-tojawiz0teha'": object not found 2025/04/28 06:42:47 DEBUG : WaitForWriters: timeout=30s 2025/04/28 06:42:47 DEBUG : : Looking for writers 2025/04/28 06:42:47 DEBUG : >WaitForWriters: run.go:125: removing dir "dir" failed - try 1/3: directory not empty run.go:125: removing dir "dir" failed - try 2/3: directory not empty run.go:125: removing dir "dir" failed - try 3/3: directory not empty run.go:128: removing dir "dir" failed: directory not empty fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 06:42:52 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestDirMetadataExtension (114.95s) === RUN TestFileMethods run.go:180: Remote "Linkbox root 'rclone-test-tojawiz0teha'", Local "Local file system at /tmp/rclone1175395552", Modify Window "876000h0m0s" 2025/04/28 06:42:58 INFO : Linkbox root 'rclone-test-tojawiz0teha': poll-interval is not supported by this remote 2025/04/28 06:42:58 NOTICE: Linkbox root 'rclone-test-tojawiz0teha': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/04/28 06:43:00 DEBUG : dir/file1: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 06:43:00 DEBUG : dir/file1: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 06:43:00 DEBUG : dir/file1: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 06:43:01 DEBUG : dir/file1: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 06:43:01 DEBUG : dir/file1: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 06:43:03 DEBUG : dir/file1: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 06:43:06 DEBUG : dir/file1: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 06:43:13 DEBUG : dir/file1: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 06:43:23 DEBUG : : forgetting directory cache 2025/04/28 06:43:25 DEBUG : dir/file1: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 06:43:51 DEBUG : dir/file1: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "dir/file1" to "Linkbox root 'rclone-test-tojawiz0teha'": object not found 2025/04/28 06:44:42 DEBUG : WaitForWriters: timeout=30s 2025/04/28 06:44:42 DEBUG : : Looking for writers 2025/04/28 06:44:42 DEBUG : >WaitForWriters: run.go:125: removing dir "dir" failed - try 1/3: directory not empty run.go:125: removing dir "dir" failed - try 2/3: directory not empty run.go:125: removing dir "dir" failed - try 3/3: directory not empty run.go:128: removing dir "dir" failed: directory not empty fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 06:44:47 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure --- FAIL: TestFileMethods (114.97s) === RUN TestFileSetModTime === RUN TestFileSetModTime/cache=off,open=false,write=false run.go:180: Remote "Linkbox root 'rclone-test-tojawiz0teha'", Local "Local file system at /tmp/rclone1175395552", Modify Window "876000h0m0s" 2025/04/28 06:44:53 INFO : Linkbox root 'rclone-test-tojawiz0teha': poll-interval is not supported by this remote 2025/04/28 06:44:53 NOTICE: Linkbox root 'rclone-test-tojawiz0teha': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/04/28 06:44:55 DEBUG : dir/file1: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 06:44:55 DEBUG : dir/file1: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 06:44:55 DEBUG : dir/file1: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 06:44:56 DEBUG : dir/file1: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 06:44:56 DEBUG : dir/file1: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 06:44:58 DEBUG : dir/file1: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 06:45:01 DEBUG : dir/file1: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 06:45:08 DEBUG : dir/file1: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 06:45:18 DEBUG : : forgetting directory cache 2025/04/28 06:45:20 DEBUG : dir/file1: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 06:45:46 DEBUG : dir/file1: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "dir/file1" to "Linkbox root 'rclone-test-tojawiz0teha'": object not found 2025/04/28 06:46:37 DEBUG : WaitForWriters: timeout=30s 2025/04/28 06:46:37 DEBUG : : Looking for writers 2025/04/28 06:46:37 DEBUG : >WaitForWriters: run.go:125: removing dir "dir" failed - try 1/3: directory not empty run.go:125: removing dir "dir" failed - try 2/3: directory not empty run.go:125: removing dir "dir" failed - try 3/3: directory not empty run.go:128: removing dir "dir" failed: directory not empty fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 06:46:42 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure === RUN TestFileSetModTime/cache=off,open=true,write=false run.go:180: Remote "Linkbox root 'rclone-test-tojawiz0teha'", Local "Local file system at /tmp/rclone1175395552", Modify Window "876000h0m0s" 2025/04/28 06:46:48 INFO : Linkbox root 'rclone-test-tojawiz0teha': poll-interval is not supported by this remote 2025/04/28 06:46:48 NOTICE: Linkbox root 'rclone-test-tojawiz0teha': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/04/28 06:46:50 DEBUG : dir/file1: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 06:46:50 DEBUG : dir/file1: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 06:46:50 DEBUG : dir/file1: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 06:46:51 DEBUG : dir/file1: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 06:46:51 DEBUG : dir/file1: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 06:46:53 DEBUG : dir/file1: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 06:46:56 DEBUG : dir/file1: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 06:47:03 DEBUG : dir/file1: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 06:47:13 DEBUG : : forgetting directory cache 2025/04/28 06:47:15 DEBUG : dir/file1: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 06:47:41 DEBUG : dir/file1: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "dir/file1" to "Linkbox root 'rclone-test-tojawiz0teha'": object not found 2025/04/28 06:48:32 DEBUG : WaitForWriters: timeout=30s 2025/04/28 06:48:32 DEBUG : : Looking for writers 2025/04/28 06:48:32 DEBUG : >WaitForWriters: run.go:125: removing dir "dir" failed - try 1/3: directory not empty run.go:125: removing dir "dir" failed - try 2/3: directory not empty run.go:125: removing dir "dir" failed - try 3/3: directory not empty run.go:128: removing dir "dir" failed: directory not empty fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 06:48:37 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure === RUN TestFileSetModTime/cache=off,open=true,write=true run.go:180: Remote "Linkbox root 'rclone-test-tojawiz0teha'", Local "Local file system at /tmp/rclone1175395552", Modify Window "876000h0m0s" 2025/04/28 06:48:43 INFO : Linkbox root 'rclone-test-tojawiz0teha': poll-interval is not supported by this remote 2025/04/28 06:48:43 NOTICE: Linkbox root 'rclone-test-tojawiz0teha': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/04/28 06:48:45 DEBUG : dir/file1: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 06:48:45 DEBUG : dir/file1: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 06:48:45 DEBUG : dir/file1: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 06:48:45 DEBUG : dir/file1: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 06:48:46 DEBUG : dir/file1: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 06:48:48 DEBUG : dir/file1: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 06:48:51 DEBUG : dir/file1: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 06:48:58 DEBUG : dir/file1: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 06:49:08 DEBUG : : forgetting directory cache 2025/04/28 06:49:10 DEBUG : dir/file1: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 06:49:36 DEBUG : dir/file1: Trying to read object after upload: try again in 51.2s (10/10) run.go:285: Failed to put "dir/file1" to "Linkbox root 'rclone-test-tojawiz0teha'": object not found 2025/04/28 06:50:27 DEBUG : WaitForWriters: timeout=30s 2025/04/28 06:50:27 DEBUG : : Looking for writers 2025/04/28 06:50:27 DEBUG : >WaitForWriters: run.go:125: removing dir "dir" failed - try 1/3: directory not empty run.go:125: removing dir "dir" failed - try 2/3: directory not empty run.go:125: removing dir "dir" failed - try 3/3: directory not empty run.go:128: removing dir "dir" failed: directory not empty fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 06:50:32 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure === RUN TestFileSetModTime/cache=full,open=false,write=false run.go:180: Remote "Linkbox root 'rclone-test-tojawiz0teha'", Local "Local file system at /tmp/rclone1175395552", Modify Window "876000h0m0s" 2025/04/28 06:50:38 INFO : Linkbox root 'rclone-test-tojawiz0teha': poll-interval is not supported by this remote 2025/04/28 06:50:38 DEBUG : Linkbox root 'rclone-test-tojawiz0teha': vfs cache: root is "/home/rclone/.cache/rclone" 2025/04/28 06:50:38 DEBUG : Linkbox root 'rclone-test-tojawiz0teha': vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestLinkbox/rclone-test-tojawiz0teha" 2025/04/28 06:50:38 DEBUG : Linkbox root 'rclone-test-tojawiz0teha': vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestLinkbox/rclone-test-tojawiz0teha" 2025/04/28 06:50:38 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestLinkbox/rclone-test-tojawiz0teha" 2025/04/28 06:50:38 DEBUG : Config file has changed externally - reloading 2025/04/28 06:50:38 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/04/28 06:50:38 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestLinkbox/rclone-test-tojawiz0teha" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestLinkbox/rclone-test-tojawiz0teha" 2025/04/28 06:50:38 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestLinkbox/rclone-test-tojawiz0teha" 2025/04/28 06:50:38 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/04/28 06:50:38 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestLinkbox/rclone-test-tojawiz0teha" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestLinkbox/rclone-test-tojawiz0teha" 2025/04/28 06:50:38 INFO : Linkbox root 'rclone-test-tojawiz0teha': vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0) 2025/04/28 06:50:40 DEBUG : dir/file1: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 06:50:40 DEBUG : dir/file1: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 06:50:40 DEBUG : dir/file1: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 06:50:40 DEBUG : dir/file1: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 06:50:41 DEBUG : dir/file1: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 06:50:43 DEBUG : dir/file1: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 06:50:46 DEBUG : dir/file1: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 06:50:53 DEBUG : dir/file1: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 06:51:03 DEBUG : : forgetting directory cache 2025/04/28 06:51:05 DEBUG : dir/file1: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 06:51:31 DEBUG : dir/file1: Trying to read object after upload: try again in 51.2s (10/10) 2025/04/28 06:51:38 INFO : Linkbox root 'rclone-test-tojawiz0teha': vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0) run.go:285: Failed to put "dir/file1" to "Linkbox root 'rclone-test-tojawiz0teha'": object not found 2025/04/28 06:52:22 DEBUG : WaitForWriters: timeout=30s 2025/04/28 06:52:22 DEBUG : : Looking for writers 2025/04/28 06:52:22 DEBUG : >WaitForWriters: 2025/04/28 06:52:22 DEBUG : Linkbox root 'rclone-test-tojawiz0teha': vfs cache: cleaner exiting run.go:125: removing dir "dir" failed - try 1/3: directory not empty run.go:125: removing dir "dir" failed - try 2/3: directory not empty run.go:125: removing dir "dir" failed - try 3/3: directory not empty run.go:128: removing dir "dir" failed: directory not empty fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache 2025/04/28 06:52:27 ERROR : : error listing: directory not found fstest.go:286: Sleeping for 6s just to make sure === RUN TestFileSetModTime/cache=full,open=true,write=false run.go:180: Remote "Linkbox root 'rclone-test-tojawiz0teha'", Local "Local file system at /tmp/rclone1175395552", Modify Window "876000h0m0s" 2025/04/28 06:52:33 INFO : Linkbox root 'rclone-test-tojawiz0teha': poll-interval is not supported by this remote 2025/04/28 06:52:33 DEBUG : Linkbox root 'rclone-test-tojawiz0teha': vfs cache: root is "/home/rclone/.cache/rclone" 2025/04/28 06:52:33 DEBUG : Linkbox root 'rclone-test-tojawiz0teha': vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestLinkbox/rclone-test-tojawiz0teha" 2025/04/28 06:52:33 DEBUG : Linkbox root 'rclone-test-tojawiz0teha': vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestLinkbox/rclone-test-tojawiz0teha" 2025/04/28 06:52:33 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestLinkbox/rclone-test-tojawiz0teha" 2025/04/28 06:52:33 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/04/28 06:52:33 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestLinkbox/rclone-test-tojawiz0teha" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestLinkbox/rclone-test-tojawiz0teha" 2025/04/28 06:52:33 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestLinkbox/rclone-test-tojawiz0teha" 2025/04/28 06:52:33 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/04/28 06:52:33 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestLinkbox/rclone-test-tojawiz0teha" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestLinkbox/rclone-test-tojawiz0teha" 2025/04/28 06:52:33 INFO : Linkbox root 'rclone-test-tojawiz0teha': vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0) 2025/04/28 06:52:35 DEBUG : dir/file1: Trying to read object after upload: try again in 100ms (1/10) 2025/04/28 06:52:35 DEBUG : dir/file1: Trying to read object after upload: try again in 200ms (2/10) 2025/04/28 06:52:35 DEBUG : dir/file1: Trying to read object after upload: try again in 400ms (3/10) 2025/04/28 06:52:35 DEBUG : dir/file1: Trying to read object after upload: try again in 800ms (4/10) 2025/04/28 06:52:36 DEBUG : dir/file1: Trying to read object after upload: try again in 1.6s (5/10) 2025/04/28 06:52:38 DEBUG : dir/file1: Trying to read object after upload: try again in 3.2s (6/10) 2025/04/28 06:52:41 DEBUG : dir/file1: Trying to read object after upload: try again in 6.4s (7/10) 2025/04/28 06:52:47 DEBUG : dir/file1: Trying to read object after upload: try again in 12.8s (8/10) 2025/04/28 06:52:58 DEBUG : : forgetting directory cache 2025/04/28 06:53:00 DEBUG : dir/file1: Trying to read object after upload: try again in 25.6s (9/10) 2025/04/28 06:53:26 DEBUG : dir/file1: Trying to read object after upload: try again in 51.2s (10/10) 2025/04/28 06:53:33 INFO : Linkbox root 'rclone-test-tojawiz0teha': vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0) run.go:285: Failed to put "dir/file1" to "Linkbox root 'rclone-test-tojawiz0teha'": object not found 2025/04/28 06:54:17 DEBUG : WaitForWriters: timeout=30s 2025/04/28 06:54:17 DEBUG : : Looking for writers 2025/04/28 06:54:17 DEBUG : >WaitForWriters: 2025/04/28 06:54:17 DEBUG : Linkbox root 'rclone-test-tojawiz0teha': vfs cache: cleaner exiting === RUN TestFileSetModTime/cache=full,open=true,write=true run.go:180: Remote "Linkbox root 'rclone-test-tojawiz0teha'", Local "Local file system at /tmp/rclone1175395552", Modify Window "876000h0m0s" 2025/04/28 06:54:19 INFO : Linkbox root 'rclone-test-tojawiz0teha': poll-interval is not supported by this remote 2025/04/28 06:54:19 DEBUG : Linkbox root 'rclone-test-tojawiz0teha': vfs cache: root is "/home/rclone/.cache/rclone" 2025/04/28 06:54:19 DEBUG : Linkbox root 'rclone-test-tojawiz0teha': vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestLinkbox/rclone-test-tojawiz0teha" 2025/04/28 06:54:19 DEBUG : Linkbox root 'rclone-test-tojawiz0teha': vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestLinkbox/rclone-test-tojawiz0teha" 2025/04/28 06:54:19 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestLinkbox/rclone-test-tojawiz0teha" 2025/04/28 06:54:19 DEBUG : Config file has changed externally - reloading 2025/04/28 06:54:19 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/04/28 06:54:19 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestLinkbox/rclone-test-tojawiz0teha" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestLinkbox/rclone-test-tojawiz0teha" 2025/04/28 06:54:19 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestLinkbox/rclone-test-tojawiz0teha" 2025/04/28 06:54:19 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/04/28 06:54:19 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestLinkbox/rclone-test-tojawiz0teha" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestLinkbox/rclone-test-tojawiz0teha" 2025/04/28 06:54:19 INFO : Linkbox root 'rclone-test-tojawiz0teha': vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0) 2025/04/28 06:54:29 DEBUG : Can set mod time: false file_test.go:97: can't set mod time 2025/04/28 06:54:29 DEBUG : WaitForWriters: timeout=30s 2025/04/28 06:54:29 DEBUG : dir: Looking for writers 2025/04/28 06:54:29 DEBUG : file1: reading active writers 2025/04/28 06:54:29 DEBUG : : Looking for writers 2025/04/28 06:54:29 DEBUG : dir: reading active writers 2025/04/28 06:54:29 DEBUG : >WaitForWriters: 2025/04/28 06:54:29 DEBUG : Linkbox root 'rclone-test-tojawiz0teha': vfs cache: cleaner exiting --- FAIL: TestFileSetModTime (579.36s) --- FAIL: TestFileSetModTime/cache=off,open=false,write=false (115.01s) --- FAIL: TestFileSetModTime/cache=off,open=true,write=false (114.94s) --- FAIL: TestFileSetModTime/cache=off,open=true,write=true (114.95s) --- FAIL: TestFileSetModTime/cache=full,open=false,write=false (114.95s) --- FAIL: TestFileSetModTime/cache=full,open=true,write=false (106.35s) --- SKIP: TestFileSetModTime/cache=full,open=true,write=true (13.15s) === RUN TestFileOpenRead run.go:180: Remote "Linkbox root 'rclone-test-tojawiz0teha'", Local "Local file system at /tmp/rclone1175395552", Modify Window "876000h0m0s" 2025/04/28 06:54:33 INFO : Linkbox root 'rclone-test-tojawiz0teha': poll-interval is not supported by this remote 2025/04/28 06:54:33 NOTICE: Linkbox root 'rclone-test-tojawiz0teha': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/04/28 06:54:38 DEBUG : dir/file1: Open: flags=O_RDONLY 2025/04/28 06:54:38 DEBUG : dir/file1: >Open: fd=dir/file1 (r), err= 2025/04/28 06:54:38 DEBUG : dir/file1: ChunkedReader.openRange at 0 length 134217728 file_test.go:171: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/vfs/file_test.go:171 /home/rclone/go/src/github.com/rclone/rclone/vfs/file_test.go:180 Error: Received unexpected error: Open failed: HTTP error 403 (403 Forbidden) returned body: "ip incorrect" Test: TestFileOpenRead 2025/04/28 06:54:38 DEBUG : WaitForWriters: timeout=30s 2025/04/28 06:54:38 DEBUG : dir: Looking for writers 2025/04/28 06:54:38 DEBUG : file1: reading active writers 2025/04/28 06:54:38 DEBUG : : Looking for writers 2025/04/28 06:54:38 DEBUG : dir: reading active writers 2025/04/28 06:54:38 DEBUG : >WaitForWriters: --- FAIL: TestFileOpenRead (9.31s) === RUN TestFileOpenWrite run.go:180: Remote "Linkbox root 'rclone-test-tojawiz0teha'", Local "Local file system at /tmp/rclone1175395552", Modify Window "876000h0m0s" 2025/04/28 06:54:42 INFO : Linkbox root 'rclone-test-tojawiz0teha': poll-interval is not supported by this remote 2025/04/28 06:54:42 NOTICE: Linkbox root 'rclone-test-tojawiz0teha': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/04/28 06:54:47 DEBUG : dir: Added virtual directory entry vAddFile: "file1" 2025/04/28 06:54:47 DEBUG : Linkbox root 'rclone-test-tojawiz0teha': File to upload is small (25 bytes), uploading instead of streaming 2025/04/28 06:54:47 DEBUG : dir/file1: Update: removing old file 2025/04/28 06:54:51 NOTICE: Linkbox root 'rclone-test-tojawiz0teha': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only 2025/04/28 06:54:51 DEBUG : dir/file1: Size of src and dst objects identical 2025/04/28 06:54:51 DEBUG : dir: Added virtual directory entry vAddFile: "file1" 2025/04/28 06:54:51 DEBUG : WaitForWriters: timeout=30s 2025/04/28 06:54:51 DEBUG : dir: Looking for writers 2025/04/28 06:54:51 DEBUG : file1: reading active writers 2025/04/28 06:54:51 DEBUG : : Looking for writers 2025/04/28 06:54:51 DEBUG : dir: reading active writers 2025/04/28 06:54:51 DEBUG : >WaitForWriters: 2025/04/28 06:54:53 DEBUG : : forgetting directory cache --- PASS: TestFileOpenWrite (12.80s) === RUN TestFileRemove run.go:180: Remote "Linkbox root 'rclone-test-tojawiz0teha'", Local "Local file system at /tmp/rclone1175395552", Modify Window "876000h0m0s" 2025/04/28 06:54:55 INFO : Linkbox root 'rclone-test-tojawiz0teha': poll-interval is not supported by this remote 2025/04/28 06:54:55 NOTICE: Linkbox root 'rclone-test-tojawiz0teha': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/04/28 06:55:00 DEBUG : dir/file1: Remove: 2025/04/28 06:55:01 DEBUG : dir: Added virtual directory entry vDel: "file1" 2025/04/28 06:55:01 DEBUG : dir/file1: >Remove: err= 2025/04/28 06:55:02 DEBUG : dir/file1: Remove: 2025/04/28 06:55:02 DEBUG : dir/file1: >Remove: err=Read only file system 2025/04/28 06:55:02 DEBUG : WaitForWriters: timeout=30s 2025/04/28 06:55:02 DEBUG : dir: Looking for writers 2025/04/28 06:55:02 DEBUG : : Looking for writers 2025/04/28 06:55:02 DEBUG : dir: reading active writers 2025/04/28 06:55:02 DEBUG : >WaitForWriters: --- PASS: TestFileRemove (9.55s) === RUN TestFileRemoveAll run.go:180: Remote "Linkbox root 'rclone-test-tojawiz0teha'", Local "Local file system at /tmp/rclone1175395552", Modify Window "876000h0m0s" 2025/04/28 06:55:04 INFO : Linkbox root 'rclone-test-tojawiz0teha': poll-interval is not supported by this remote 2025/04/28 06:55:04 NOTICE: Linkbox root 'rclone-test-tojawiz0teha': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/04/28 06:55:09 DEBUG : dir/file1: Remove: 2025/04/28 06:55:11 DEBUG : dir: Added virtual directory entry vDel: "file1" 2025/04/28 06:55:11 DEBUG : dir/file1: >Remove: err= 2025/04/28 06:55:11 DEBUG : dir/file1: Remove: 2025/04/28 06:55:11 DEBUG : dir/file1: >Remove: err=Read only file system 2025/04/28 06:55:11 DEBUG : WaitForWriters: timeout=30s 2025/04/28 06:55:11 DEBUG : dir: Looking for writers 2025/04/28 06:55:11 DEBUG : : Looking for writers 2025/04/28 06:55:11 DEBUG : dir: reading active writers 2025/04/28 06:55:11 DEBUG : >WaitForWriters: --- PASS: TestFileRemoveAll (9.32s) FAIL 2025/04/28 06:55:14 DEBUG : Linkbox root 'rclone-test-tojawiz0teha': Purge remote "./vfs.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestDirCreate|TestDirFileOpen|TestDirForgetAll|TestDirForgetPath|TestDirHandleMethods|TestDirHandleReaddir|TestDirHandleReaddirnames|TestDirMetadataExtension|TestDirMethods|TestDirMkdir|TestDirMkdirSub|TestDirOpen|TestDirReadDirAll|TestDirRemove|TestDirRemoveAll|TestDirRemoveName|TestDirRename|TestDirSetModTime|TestDirStat|TestDirWalk|TestFileMethods|TestFileOpenRead|TestFileOpenWrite|TestFileRemove|TestFileRemoveAll)$|^TestFileSetModTime$/^(cache=full,open=false,write=false|cache=full,open=true,write=false|cache=full,open=true,write=true|cache=off,open=false,write=false|cache=off,open=true,write=false|cache=off,open=true,write=true)$'" - Finished ERROR in 50m42.897163076s (try 2/5): exit status 1: Failed [TestDirHandleMethods TestDirHandleReaddir TestDirHandleReaddirnames TestDirMethods TestDirForgetAll TestDirForgetPath TestDirWalk TestDirSetModTime TestDirStat TestDirReadDirAll TestDirOpen TestDirCreate TestDirMkdir TestDirMkdirSub TestDirRemove TestDirRemoveAll TestDirRemoveName TestDirRename TestDirFileOpen TestDirMetadataExtension TestFileMethods TestFileSetModTime/cache=off,open=false,write=false TestFileSetModTime/cache=off,open=true,write=false TestFileSetModTime/cache=off,open=true,write=true TestFileSetModTime/cache=full,open=false,write=false TestFileSetModTime/cache=full,open=true,write=false TestFileOpenRead]