"./vfs.test -test.v -test.timeout 1h0m0s -remote TestShade: -verbose -test.run '^(TestDirFileOpen|TestDirMetadataExtension|TestDirRename|TestFileMethods|TestFileOpen|TestFileOpenRead|TestFileOpenWrite|TestFileRemove|TestFileRemoveAll|TestRWFileHandleFlushRead|TestRWFileHandleMethodsRead|TestRWFileHandleReadAt|TestRWFileHandleReleaseRead|TestRWFileHandleSeek|TestRWFileHandleSizeCreateExisting|TestRWFileHandleSizeTruncateExisting|TestReadFileHandleFlush|TestReadFileHandleMethods|TestReadFileHandleReadAt|TestReadFileHandleRelease|TestReadFileHandleSeek|TestVFSOpenFile|TestVFSRename|TestVFSStat|TestVFSStatParent)$|^TestFileRename$/^(full,forceCache=false|minimal,forceCache=false|minimal,forceCache=true|off,forceCache=false|writes,forceCache=false|writes,forceCache=true)$|^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 3/5) 2025/12/15 04:03:09 DEBUG : Creating backend with remote "TestShade:rclone-test-fekuwuv1qibi" 2025/12/15 04:03:09 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/12/15 04:03:09 DEBUG : Creating new ShadeFS backend with drive: cf193d00-c783-4bab-aa7a-fd84b3700d27 2025/12/15 04:03:09 DEBUG : Creating backend with remote "/tmp/rclone1670992701" === RUN TestDirRename run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:03:09 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:03:09 NOTICE: Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/12/15 04:03:10 DEBUG : dir/file1: multipart upload: starting chunk 0 size 14 offset 0/14 2025/12/15 04:03:12 DEBUG : dir/file3: multipart upload: starting chunk 0 size 15 offset 0/15 2025/12/15 04:03:14 ERROR : dir/not found: Dir.Rename error: file does not exist 2025/12/15 04:03:15 DEBUG : Directory: dir: Updating dir with dir2 0xc00076b380 2025/12/15 04:03:15 DEBUG : dir: forgetting directory cache 2025/12/15 04:03:15 DEBUG : Added virtual directory entry vDel: "dir" 2025/12/15 04:03:15 DEBUG : Added virtual directory entry vAddDir: "dir2" 2025/12/15 04:03:15 INFO : dir2/file1: Moved (server-side) to: file2 2025/12/15 04:03:15 DEBUG : file2: Updating file with file2 0xc00016e240 2025/12/15 04:03:15 DEBUG : dir2: Added virtual directory entry vDel: "file1" 2025/12/15 04:03:15 DEBUG : Added virtual directory entry vAddFile: "file2" dir_test.go:250: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:250 /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:558 Error: Not equal: expected: []string{"dir2,0,true", "file2,14,false"} actual : []string{"dir2,0,true", "file2,0,false"} Diff: --- Expected +++ Actual @@ -2,3 +2,3 @@ (string) (len=11) "dir2,0,true", - (string) (len=14) "file2,14,false" + (string) (len=13) "file2,0,false" } Test: TestDirRename 2025/12/15 04:03:16 INFO : dir2/file3: Deleted 2025/12/15 04:03:16 INFO : file2: Moved (server-side) to: dir2/file3 2025/12/15 04:03:16 DEBUG : dir2/file3: Updating file with dir2/file3 0xc00016e240 2025/12/15 04:03:16 DEBUG : Added virtual directory entry vDel: "file2" 2025/12/15 04:03:16 DEBUG : dir2: Added virtual directory entry vAddFile: "file3" dir_test.go:250: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:250 /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:569 Error: Not equal: expected: []string{"file3,14,false"} actual : []string{"file3,0,false"} Diff: --- Expected +++ Actual @@ -1,3 +1,3 @@ ([]string) (len=1) { - (string) (len=14) "file3,14,false" + (string) (len=13) "file3,0,false" } Test: TestDirRename 2025/12/15 04:03:17 DEBUG : Added virtual directory entry vAddDir: "empty directory" 2025/12/15 04:03:17 DEBUG : empty directory: Updating dir with renamed empty directory 0xc00076b930 2025/12/15 04:03:17 DEBUG : empty directory: forgetting directory cache 2025/12/15 04:03:17 DEBUG : Added virtual directory entry vDel: "empty directory" 2025/12/15 04:03:17 DEBUG : Added virtual directory entry vAddDir: "renamed empty directory" 2025/12/15 04:03:17 DEBUG : dir2: Renaming to "dir3" 2025/12/15 04:03:17 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:03:17 DEBUG : dir3: Looking for writers 2025/12/15 04:03:17 DEBUG : file3: reading active writers 2025/12/15 04:03:17 DEBUG : renamed empty directory: Looking for writers 2025/12/15 04:03:17 DEBUG : Looking for writers 2025/12/15 04:03:17 DEBUG : dir3: reading active writers 2025/12/15 04:03:17 DEBUG : renamed empty directory: reading active writers 2025/12/15 04:03:17 DEBUG : >WaitForWriters: --- FAIL: TestDirRename (9.01s) === RUN TestDirFileOpen run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:03:18 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:03:18 NOTICE: Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/12/15 04:03:18 DEBUG : dir/file1: multipart upload: starting chunk 0 size 14 offset 0/14 2025/12/15 04:03:20 DEBUG : dir/file1: Cancelling multipart upload run.go:290: Failed to put "dir/file1" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:03:20 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:03:20 DEBUG : Looking for writers 2025/12/15 04:03:20 DEBUG : >WaitForWriters: --- FAIL: TestDirFileOpen (2.50s) === RUN TestDirMetadataExtension run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:03:21 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:03:21 NOTICE: Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/12/15 04:03:21 DEBUG : dir/file1: multipart upload: starting chunk 0 size 14 offset 0/14 2025/12/15 04:03:22 DEBUG : dir/file1: Cancelling multipart upload run.go:290: Failed to put "dir/file1" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:03:23 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:03:23 DEBUG : Looking for writers 2025/12/15 04:03:23 DEBUG : >WaitForWriters: --- FAIL: TestDirMetadataExtension (2.52s) === RUN TestFileMethods run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:03:23 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:03:23 NOTICE: Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/12/15 04:03:23 DEBUG : dir/file1: multipart upload: starting chunk 0 size 14 offset 0/14 2025/12/15 04:03:25 DEBUG : dir/file1: Cancelling multipart upload run.go:290: Failed to put "dir/file1" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:03:25 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:03:25 DEBUG : Looking for writers 2025/12/15 04:03:25 DEBUG : >WaitForWriters: --- FAIL: TestFileMethods (2.53s) === RUN TestFileSetModTime === RUN TestFileSetModTime/cache=off,open=false,write=false run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:03:26 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:03:26 NOTICE: Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/12/15 04:03:26 DEBUG : dir/file1: multipart upload: starting chunk 0 size 14 offset 0/14 2025/12/15 04:03:27 DEBUG : dir/file1: Cancelling multipart upload run.go:290: Failed to put "dir/file1" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:03:28 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:03:28 DEBUG : Looking for writers 2025/12/15 04:03:28 DEBUG : >WaitForWriters: === RUN TestFileSetModTime/cache=off,open=true,write=false run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:03:28 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:03:28 NOTICE: Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/12/15 04:03:28 DEBUG : dir/file1: multipart upload: starting chunk 0 size 14 offset 0/14 2025/12/15 04:03:30 DEBUG : dir/file1: Cancelling multipart upload run.go:290: Failed to put "dir/file1" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:03:30 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:03:30 DEBUG : Looking for writers 2025/12/15 04:03:30 DEBUG : >WaitForWriters: === RUN TestFileSetModTime/cache=off,open=true,write=true run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:03:31 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:03:31 NOTICE: Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/12/15 04:03:31 DEBUG : dir/file1: multipart upload: starting chunk 0 size 14 offset 0/14 2025/12/15 04:03:32 DEBUG : dir/file1: Cancelling multipart upload run.go:290: Failed to put "dir/file1" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:03:33 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:03:33 DEBUG : Looking for writers 2025/12/15 04:03:33 DEBUG : >WaitForWriters: === RUN TestFileSetModTime/cache=full,open=false,write=false run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:03:33 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:03:33 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: root is "/home/rclone/.cache/rclone" 2025/12/15 04:03:33 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:03:33 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:03:33 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:03:33 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/12/15 04:03:33 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:03:33 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:03:33 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/12/15 04:03:33 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:03:33 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0) 2025/12/15 04:03:33 DEBUG : dir/file1: multipart upload: starting chunk 0 size 14 offset 0/14 2025/12/15 04:03:35 DEBUG : dir/file1: Cancelling multipart upload run.go:290: Failed to put "dir/file1" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:03:35 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:03:35 DEBUG : Looking for writers 2025/12/15 04:03:35 DEBUG : >WaitForWriters: 2025/12/15 04:03:35 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: cleaner exiting === RUN TestFileSetModTime/cache=full,open=true,write=false run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:03:36 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:03:36 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: root is "/home/rclone/.cache/rclone" 2025/12/15 04:03:36 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:03:36 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:03:36 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:03:36 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/12/15 04:03:36 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:03:36 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:03:36 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/12/15 04:03:36 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:03:36 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0) 2025/12/15 04:03:36 DEBUG : dir/file1: multipart upload: starting chunk 0 size 14 offset 0/14 2025/12/15 04:03:37 DEBUG : dir/file1: Cancelling multipart upload run.go:290: Failed to put "dir/file1" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:03:38 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:03:38 DEBUG : Looking for writers 2025/12/15 04:03:38 DEBUG : >WaitForWriters: 2025/12/15 04:03:38 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: cleaner exiting === RUN TestFileSetModTime/cache=full,open=true,write=true run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:03:38 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:03:38 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: root is "/home/rclone/.cache/rclone" 2025/12/15 04:03:38 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:03:38 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:03:38 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:03:38 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/12/15 04:03:38 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:03:38 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:03:38 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/12/15 04:03:38 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:03:38 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0) 2025/12/15 04:03:38 DEBUG : dir/file1: multipart upload: starting chunk 0 size 14 offset 0/14 2025/12/15 04:03:40 DEBUG : dir/file1: Cancelling multipart upload run.go:290: Failed to put "dir/file1" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:03:40 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:03:40 DEBUG : Looking for writers 2025/12/15 04:03:40 DEBUG : >WaitForWriters: 2025/12/15 04:03:40 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: cleaner exiting --- FAIL: TestFileSetModTime (15.44s) --- FAIL: TestFileSetModTime/cache=off,open=false,write=false (2.40s) --- FAIL: TestFileSetModTime/cache=off,open=true,write=false (2.54s) --- FAIL: TestFileSetModTime/cache=off,open=true,write=true (2.46s) --- FAIL: TestFileSetModTime/cache=full,open=false,write=false (2.51s) --- FAIL: TestFileSetModTime/cache=full,open=true,write=false (2.40s) --- FAIL: TestFileSetModTime/cache=full,open=true,write=true (3.12s) === RUN TestFileOpenRead run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:03:41 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:03:41 NOTICE: Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/12/15 04:03:41 DEBUG : dir/file1: multipart upload: starting chunk 0 size 14 offset 0/14 2025/12/15 04:03:43 DEBUG : dir/file1: Cancelling multipart upload run.go:290: Failed to put "dir/file1" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:03:43 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:03:43 DEBUG : Looking for writers 2025/12/15 04:03:43 DEBUG : >WaitForWriters: --- FAIL: TestFileOpenRead (2.52s) === RUN TestFileOpenWrite run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:03:44 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:03:44 NOTICE: Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/12/15 04:03:44 DEBUG : dir/file1: multipart upload: starting chunk 0 size 14 offset 0/14 2025/12/15 04:03:46 DEBUG : dir/file1: Cancelling multipart upload run.go:290: Failed to put "dir/file1" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:03:46 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:03:46 DEBUG : Looking for writers 2025/12/15 04:03:46 DEBUG : >WaitForWriters: --- FAIL: TestFileOpenWrite (2.60s) === RUN TestFileRemove run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:03:46 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:03:46 NOTICE: Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/12/15 04:03:47 DEBUG : dir/file1: multipart upload: starting chunk 0 size 14 offset 0/14 2025/12/15 04:03:48 DEBUG : dir/file1: Cancelling multipart upload run.go:290: Failed to put "dir/file1" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:03:48 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:03:48 DEBUG : Looking for writers 2025/12/15 04:03:48 DEBUG : >WaitForWriters: --- FAIL: TestFileRemove (2.47s) === RUN TestFileRemoveAll run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:03:49 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:03:49 NOTICE: Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/12/15 04:03:49 DEBUG : dir/file1: multipart upload: starting chunk 0 size 14 offset 0/14 2025/12/15 04:03:50 DEBUG : dir/file1: Cancelling multipart upload run.go:290: Failed to put "dir/file1" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:03:51 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:03:51 DEBUG : Looking for writers 2025/12/15 04:03:51 DEBUG : >WaitForWriters: --- FAIL: TestFileRemoveAll (2.46s) === RUN TestFileOpen run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:03:51 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:03:51 NOTICE: Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/12/15 04:03:52 DEBUG : dir/file1: multipart upload: starting chunk 0 size 14 offset 0/14 2025/12/15 04:03:53 DEBUG : dir/file1: Cancelling multipart upload run.go:290: Failed to put "dir/file1" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:03:53 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:03:53 DEBUG : Looking for writers 2025/12/15 04:03:53 DEBUG : >WaitForWriters: --- FAIL: TestFileOpen (2.40s) === RUN TestFileRename === RUN TestFileRename/off,forceCache=false run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:03:54 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:03:54 NOTICE: Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/12/15 04:03:54 DEBUG : dir/file1: multipart upload: starting chunk 0 size 14 offset 0/14 2025/12/15 04:03:55 DEBUG : dir/file1: Cancelling multipart upload run.go:290: Failed to put "dir/file1" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:03:56 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:03:56 DEBUG : Looking for writers 2025/12/15 04:03:56 DEBUG : >WaitForWriters: === RUN TestFileRename/minimal,forceCache=false run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:03:56 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:03:56 NOTICE: Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/12/15 04:03:56 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: root is "/home/rclone/.cache/rclone" 2025/12/15 04:03:56 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:03:56 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:03:56 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:03:56 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/12/15 04:03:56 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:03:56 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:03:56 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/12/15 04:03:56 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:03:56 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0) 2025/12/15 04:03:56 DEBUG : dir/file1: multipart upload: starting chunk 0 size 14 offset 0/14 2025/12/15 04:03:58 DEBUG : dir/file1: Cancelling multipart upload run.go:290: Failed to put "dir/file1" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:03:58 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:03:58 DEBUG : Looking for writers 2025/12/15 04:03:58 DEBUG : >WaitForWriters: 2025/12/15 04:03:58 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: cleaner exiting === RUN TestFileRename/minimal,forceCache=true run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:03:58 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:03:58 NOTICE: Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/12/15 04:03:58 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: root is "/home/rclone/.cache/rclone" 2025/12/15 04:03:58 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:03:58 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:03:58 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:03:58 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/12/15 04:03:58 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:03:58 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:03:58 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/12/15 04:03:58 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:03:58 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0) 2025/12/15 04:03:59 DEBUG : dir/file1: multipart upload: starting chunk 0 size 14 offset 0/14 2025/12/15 04:04:00 DEBUG : dir/file1: Cancelling multipart upload run.go:290: Failed to put "dir/file1" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:04:01 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:04:01 DEBUG : Looking for writers 2025/12/15 04:04:01 DEBUG : >WaitForWriters: 2025/12/15 04:04:01 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: cleaner exiting === RUN TestFileRename/writes,forceCache=false run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:04:01 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:04:01 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: root is "/home/rclone/.cache/rclone" 2025/12/15 04:04:01 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:01 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:01 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:01 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/12/15 04:04:01 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:01 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:01 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/12/15 04:04:01 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:01 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0) 2025/12/15 04:04:01 DEBUG : dir/file1: multipart upload: starting chunk 0 size 14 offset 0/14 2025/12/15 04:04:03 DEBUG : dir/file1: Cancelling multipart upload run.go:290: Failed to put "dir/file1" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:04:03 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:04:03 DEBUG : Looking for writers 2025/12/15 04:04:03 DEBUG : >WaitForWriters: 2025/12/15 04:04:03 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: cleaner exiting === RUN TestFileRename/writes,forceCache=true run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:04:03 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:04:03 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: root is "/home/rclone/.cache/rclone" 2025/12/15 04:04:03 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:03 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:03 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:03 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/12/15 04:04:03 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:03 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:03 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/12/15 04:04:03 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:03 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0) 2025/12/15 04:04:04 DEBUG : dir/file1: multipart upload: starting chunk 0 size 14 offset 0/14 2025/12/15 04:04:05 DEBUG : dir/file1: Cancelling multipart upload run.go:290: Failed to put "dir/file1" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:04:05 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:04:05 DEBUG : Looking for writers 2025/12/15 04:04:05 DEBUG : >WaitForWriters: 2025/12/15 04:04:05 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: cleaner exiting === RUN TestFileRename/full,forceCache=false run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:04:06 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:04:06 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: root is "/home/rclone/.cache/rclone" 2025/12/15 04:04:06 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:06 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:06 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:06 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/12/15 04:04:06 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:06 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:06 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/12/15 04:04:06 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:06 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0) 2025/12/15 04:04:06 DEBUG : dir/file1: multipart upload: starting chunk 0 size 14 offset 0/14 2025/12/15 04:04:08 DEBUG : dir/file1: Cancelling multipart upload run.go:290: Failed to put "dir/file1" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:04:08 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:04:08 DEBUG : Looking for writers 2025/12/15 04:04:08 DEBUG : >WaitForWriters: 2025/12/15 04:04:08 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: cleaner exiting --- FAIL: TestFileRename (14.72s) --- FAIL: TestFileRename/off,forceCache=false (2.42s) --- FAIL: TestFileRename/minimal,forceCache=false (2.40s) --- FAIL: TestFileRename/minimal,forceCache=true (2.53s) --- FAIL: TestFileRename/writes,forceCache=false (2.44s) --- FAIL: TestFileRename/writes,forceCache=true (2.44s) --- FAIL: TestFileRename/full,forceCache=false (2.48s) === RUN TestReadFileHandleMethods run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:04:08 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:04:08 NOTICE: Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/12/15 04:04:09 DEBUG : dir/file1: multipart upload: starting chunk 0 size 16 offset 0/16 2025/12/15 04:04:10 DEBUG : dir/file1: Cancelling multipart upload run.go:290: Failed to put "dir/file1" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:04:10 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:04:10 DEBUG : Looking for writers 2025/12/15 04:04:10 DEBUG : >WaitForWriters: --- FAIL: TestReadFileHandleMethods (2.49s) === RUN TestReadFileHandleSeek run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:04:11 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:04:11 NOTICE: Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/12/15 04:04:11 DEBUG : dir/file1: multipart upload: starting chunk 0 size 16 offset 0/16 2025/12/15 04:04:13 DEBUG : dir/file1: Cancelling multipart upload run.go:290: Failed to put "dir/file1" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:04:13 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:04:13 DEBUG : Looking for writers 2025/12/15 04:04:13 DEBUG : >WaitForWriters: --- FAIL: TestReadFileHandleSeek (2.46s) === RUN TestReadFileHandleReadAt run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:04:13 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:04:13 NOTICE: Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/12/15 04:04:14 DEBUG : dir/file1: multipart upload: starting chunk 0 size 16 offset 0/16 2025/12/15 04:04:15 DEBUG : dir/file1: Cancelling multipart upload run.go:290: Failed to put "dir/file1" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:04:15 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:04:15 DEBUG : Looking for writers 2025/12/15 04:04:15 DEBUG : >WaitForWriters: --- FAIL: TestReadFileHandleReadAt (2.38s) === RUN TestReadFileHandleFlush run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:04:16 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:04:16 NOTICE: Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/12/15 04:04:16 DEBUG : dir/file1: multipart upload: starting chunk 0 size 16 offset 0/16 2025/12/15 04:04:17 DEBUG : dir/file1: Cancelling multipart upload run.go:290: Failed to put "dir/file1" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:04:18 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:04:18 DEBUG : Looking for writers 2025/12/15 04:04:18 DEBUG : >WaitForWriters: --- FAIL: TestReadFileHandleFlush (2.40s) === RUN TestReadFileHandleRelease run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:04:18 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:04:18 NOTICE: Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/12/15 04:04:18 DEBUG : dir/file1: multipart upload: starting chunk 0 size 16 offset 0/16 2025/12/15 04:04:20 DEBUG : dir/file1: Cancelling multipart upload run.go:290: Failed to put "dir/file1" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:04:20 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:04:20 DEBUG : Looking for writers 2025/12/15 04:04:20 DEBUG : >WaitForWriters: --- FAIL: TestReadFileHandleRelease (2.44s) === RUN TestRWFileHandleMethodsRead run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:04:20 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:04:20 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: root is "/home/rclone/.cache/rclone" 2025/12/15 04:04:20 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:20 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:20 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:20 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/12/15 04:04:20 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:20 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:20 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/12/15 04:04:20 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:20 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0) 2025/12/15 04:04:21 DEBUG : dir/file1: multipart upload: starting chunk 0 size 16 offset 0/16 2025/12/15 04:04:22 DEBUG : dir/file1: Cancelling multipart upload run.go:290: Failed to put "dir/file1" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:04:23 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:04:23 DEBUG : Looking for writers 2025/12/15 04:04:23 DEBUG : >WaitForWriters: 2025/12/15 04:04:23 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: cleaner exiting --- FAIL: TestRWFileHandleMethodsRead (2.53s) === RUN TestRWFileHandleSeek run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:04:23 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:04:23 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: root is "/home/rclone/.cache/rclone" 2025/12/15 04:04:23 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:23 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:23 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:23 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/12/15 04:04:23 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:23 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:23 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/12/15 04:04:23 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:23 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0) 2025/12/15 04:04:23 DEBUG : dir/file1: multipart upload: starting chunk 0 size 16 offset 0/16 2025/12/15 04:04:25 DEBUG : dir/file1: Cancelling multipart upload run.go:290: Failed to put "dir/file1" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:04:25 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:04:25 DEBUG : Looking for writers 2025/12/15 04:04:25 DEBUG : >WaitForWriters: 2025/12/15 04:04:25 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: cleaner exiting --- FAIL: TestRWFileHandleSeek (2.39s) === RUN TestRWFileHandleReadAt run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:04:25 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:04:25 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: root is "/home/rclone/.cache/rclone" 2025/12/15 04:04:25 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:25 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:25 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:25 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/12/15 04:04:25 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:25 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:25 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/12/15 04:04:25 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:25 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0) 2025/12/15 04:04:26 DEBUG : dir/file1: multipart upload: starting chunk 0 size 16 offset 0/16 2025/12/15 04:04:27 DEBUG : dir/file1: Cancelling multipart upload run.go:290: Failed to put "dir/file1" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:04:27 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:04:27 DEBUG : Looking for writers 2025/12/15 04:04:27 DEBUG : >WaitForWriters: 2025/12/15 04:04:27 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: cleaner exiting --- FAIL: TestRWFileHandleReadAt (2.43s) === RUN TestRWFileHandleFlushRead run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:04:28 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:04:28 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: root is "/home/rclone/.cache/rclone" 2025/12/15 04:04:28 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:28 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:28 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:28 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/12/15 04:04:28 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:28 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:28 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/12/15 04:04:28 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:28 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0) 2025/12/15 04:04:28 DEBUG : dir/file1: multipart upload: starting chunk 0 size 16 offset 0/16 2025/12/15 04:04:30 DEBUG : dir/file1: Cancelling multipart upload run.go:290: Failed to put "dir/file1" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:04:30 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:04:30 DEBUG : Looking for writers 2025/12/15 04:04:30 DEBUG : >WaitForWriters: 2025/12/15 04:04:30 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: cleaner exiting --- FAIL: TestRWFileHandleFlushRead (2.44s) === RUN TestRWFileHandleReleaseRead run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:04:30 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:04:30 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: root is "/home/rclone/.cache/rclone" 2025/12/15 04:04:30 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:30 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:30 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:30 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/12/15 04:04:30 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:30 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:30 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/12/15 04:04:30 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:30 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0) 2025/12/15 04:04:31 DEBUG : dir/file1: multipart upload: starting chunk 0 size 16 offset 0/16 2025/12/15 04:04:32 DEBUG : dir/file1: Cancelling multipart upload run.go:290: Failed to put "dir/file1" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:04:33 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:04:33 DEBUG : Looking for writers 2025/12/15 04:04:33 DEBUG : >WaitForWriters: 2025/12/15 04:04:33 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: cleaner exiting --- FAIL: TestRWFileHandleReleaseRead (2.60s) === RUN TestRWFileHandleSizeTruncateExisting run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:04:33 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:04:33 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: root is "/home/rclone/.cache/rclone" 2025/12/15 04:04:33 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:33 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:33 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:33 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/12/15 04:04:33 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:33 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:33 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/12/15 04:04:33 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:33 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0) 2025/12/15 04:04:33 DEBUG : dir/file1: multipart upload: starting chunk 0 size 16 offset 0/16 2025/12/15 04:04:35 DEBUG : dir/file1: Cancelling multipart upload run.go:290: Failed to put "dir/file1" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:04:35 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:04:35 DEBUG : Looking for writers 2025/12/15 04:04:35 DEBUG : >WaitForWriters: 2025/12/15 04:04:35 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: cleaner exiting --- FAIL: TestRWFileHandleSizeTruncateExisting (2.52s) === RUN TestRWFileHandleSizeCreateExisting run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:04:35 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:04:35 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: root is "/home/rclone/.cache/rclone" 2025/12/15 04:04:35 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: data root is "/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:35 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: metadata root is "/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:35 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:35 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/12/15 04:04:35 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfs/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:35 DEBUG : Creating backend with remote ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:35 DEBUG : :local: detected overridden config - adding "{8un-i}" suffix to name 2025/12/15 04:04:35 DEBUG : fs cache: renaming cache item ":local,encoding='Slash,Dot',links=false:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" to be canonical ":local{8un-i}:/home/rclone/.cache/rclone/vfsMeta/TestShade/rclone-test-fekuwuv1qibi" 2025/12/15 04:04:35 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0) 2025/12/15 04:04:36 DEBUG : dir/file1: multipart upload: starting chunk 0 size 16 offset 0/16 2025/12/15 04:04:37 DEBUG : dir/file1: Cancelling multipart upload run.go:290: Failed to put "dir/file1" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:04:37 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:04:37 DEBUG : Looking for writers 2025/12/15 04:04:37 DEBUG : >WaitForWriters: 2025/12/15 04:04:37 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: vfs cache: cleaner exiting --- FAIL: TestRWFileHandleSizeCreateExisting (2.43s) === RUN TestVFSStat run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:04:38 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:04:38 NOTICE: Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/12/15 04:04:38 DEBUG : file1: multipart upload: starting chunk 0 size 14 offset 0/14 2025/12/15 04:04:40 DEBUG : dir/file2: multipart upload: starting chunk 0 size 14 offset 0/14 2025/12/15 04:04:41 DEBUG : dir/file2: Cancelling multipart upload run.go:290: Failed to put "dir/file2" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:04:42 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:04:42 DEBUG : Looking for writers 2025/12/15 04:04:42 DEBUG : >WaitForWriters: --- FAIL: TestVFSStat (4.44s) === RUN TestVFSStatParent run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:04:42 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:04:42 NOTICE: Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/12/15 04:04:43 DEBUG : file1: multipart upload: starting chunk 0 size 14 offset 0/14 2025/12/15 04:04:44 DEBUG : dir/file2: multipart upload: starting chunk 0 size 14 offset 0/14 2025/12/15 04:04:46 DEBUG : dir/file2: Cancelling multipart upload run.go:290: Failed to put "dir/file2" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:04:46 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:04:46 DEBUG : Looking for writers 2025/12/15 04:04:46 DEBUG : >WaitForWriters: --- FAIL: TestVFSStatParent (4.53s) === RUN TestVFSOpenFile run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:04:47 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:04:47 NOTICE: Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/12/15 04:04:47 DEBUG : file1: multipart upload: starting chunk 0 size 14 offset 0/14 2025/12/15 04:04:49 DEBUG : dir/file2: multipart upload: starting chunk 0 size 14 offset 0/14 2025/12/15 04:04:51 DEBUG : dir/file2: Cancelling multipart upload run.go:290: Failed to put "dir/file2" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:04:51 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:04:51 DEBUG : Looking for writers 2025/12/15 04:04:51 DEBUG : >WaitForWriters: --- FAIL: TestVFSOpenFile (4.71s) === RUN TestVFSRename run.go:185: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi", Local "Local file system at /tmp/rclone1670992701", Modify Window "876000h0m0s" 2025/12/15 04:04:51 INFO : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: poll-interval is not supported by this remote 2025/12/15 04:04:51 NOTICE: Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/12/15 04:04:52 DEBUG : dir/file2: multipart upload: starting chunk 0 size 14 offset 0/14 2025/12/15 04:04:53 DEBUG : dir/file2: Cancelling multipart upload run.go:290: Failed to put "dir/file2" to "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi": multipart upload: failed to finalise: failed to complete multipart upload: complete multipart failed with status 404: 2025/12/15 04:04:54 DEBUG : WaitForWriters: timeout=30s 2025/12/15 04:04:54 DEBUG : Looking for writers 2025/12/15 04:04:54 DEBUG : >WaitForWriters: --- FAIL: TestVFSRename (2.46s) FAIL 2025/12/15 04:04:54 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-fekuwuv1qibi: Purge dir "" "./vfs.test -test.v -test.timeout 1h0m0s -remote TestShade: -verbose -test.run '^(TestDirFileOpen|TestDirMetadataExtension|TestDirRename|TestFileMethods|TestFileOpen|TestFileOpenRead|TestFileOpenWrite|TestFileRemove|TestFileRemoveAll|TestRWFileHandleFlushRead|TestRWFileHandleMethodsRead|TestRWFileHandleReadAt|TestRWFileHandleReleaseRead|TestRWFileHandleSeek|TestRWFileHandleSizeCreateExisting|TestRWFileHandleSizeTruncateExisting|TestReadFileHandleFlush|TestReadFileHandleMethods|TestReadFileHandleReadAt|TestReadFileHandleRelease|TestReadFileHandleSeek|TestVFSOpenFile|TestVFSRename|TestVFSStat|TestVFSStatParent)$|^TestFileRename$/^(full,forceCache=false|minimal,forceCache=false|minimal,forceCache=true|off,forceCache=false|writes,forceCache=false|writes,forceCache=true)$|^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 1m45.63792307s (try 3/5): exit status 1: Failed [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 TestFileSetModTime/cache=full,open=true,write=true TestFileOpenRead TestFileOpenWrite TestFileRemove TestFileRemoveAll TestFileOpen TestFileRename/off,forceCache=false TestFileRename/minimal,forceCache=false TestFileRename/minimal,forceCache=true TestFileRename/writes,forceCache=false TestFileRename/writes,forceCache=true TestFileRename/full,forceCache=false TestReadFileHandleMethods TestReadFileHandleSeek TestReadFileHandleReadAt TestReadFileHandleFlush TestReadFileHandleRelease TestRWFileHandleMethodsRead TestRWFileHandleSeek TestRWFileHandleReadAt TestRWFileHandleFlushRead TestRWFileHandleReleaseRead TestRWFileHandleSizeTruncateExisting TestRWFileHandleSizeCreateExisting TestVFSStat TestVFSStatParent TestVFSOpenFile TestVFSRename]