"go test -v -timeout 2h0m0s -remote TestFileFabric: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsPutFiles$/^ObjectMimeType$'" - Starting (try 2/5)
=== RUN   TestIntegration
    fstests.go:417: Using remote "TestFileFabric:"
2022/06/17 05:23:30 DEBUG : Creating backend with remote "TestFileFabric:rclone-test-haxuvoq8giyokoq7gupajey2"
2022/06/17 05:23:30 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2022/06/17 05:23:30 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': rpc: checkPathExists(map[path:rclone-test-haxuvoq8giyokoq7gupajey2 pid:120673762]) options=[]
2022/06/17 05:23:30 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': >rpc: result=Success (ok), err=<nil>
2022/06/17 05:23:30 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': rpc: getFolderContents(map[count:1000 fi_pid:120673762 options:filelist|fi_id|fi_pid|fi_name|fi_type|fi_size|fi_contenttype|fi_modified|fi_localtime|trash|subfolders subfolders:y]) options=[]
2022/06/17 05:23:32 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': >rpc: result=Success (ok), err=<nil>
2022/06/17 05:23:32 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': rpc: doCreateNewFolder(map[fi_name:rclone-test-haxuvoq8giyokoq7gupajey2 fi_pid:120673762]) options=[]
2022/06/17 05:23:34 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': >rpc: result=Success (ok), err=<nil>
2022/06/17 05:23:34 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': rpc: getFolderContents(map[count:1000 fi_pid:121478800 options:filelist|fi_id|fi_pid|fi_name|fi_type|fi_size|fi_contenttype|fi_modified|fi_localtime|trash|subfolders subfolders:y]) options=[]
2022/06/17 05:23:36 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': >rpc: result=Success (ok), err=<nil>
=== RUN   TestIntegration/FsMkdir
2022/06/17 05:23:36 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': rpc: getFolderContents(map[count:1000 fi_pid:121478800 options:filelist|fi_id|fi_pid|fi_name|fi_type|fi_size|fi_contenttype|fi_modified|fi_localtime|trash|subfolders subfolders:y]) options=[]
2022/06/17 05:23:36 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': >rpc: result=Success (ok), err=<nil>
=== RUN   TestIntegration/FsMkdir/FsPutFiles
2022/06/17 05:23:36 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': rpc: doInitUpload(map[directuploadsupport:n fi_contenttype:text/plain; charset=utf-8 fi_filename:file name.txt fi_localtime:2001-02-03 04:05:06 fi_modified:2001-02-03 04:05:06 fi_name:file name.txt fi_pid:121478800 fi_size:100 responsetype:json]) options=[]
2022/06/17 05:23:38 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': >rpc: result=Success (ok), err=<nil>
2022/06/17 05:23:40 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': rpc: doCompleteUpload(map[fi_size:100 remotetime:2001-02-03 04:05:06 uploadcode:0021d7a6636fcf2dd83493b01786fe51]) options=[]
2022/06/17 05:23:41 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': >rpc: result=Success (ok), err=<nil>
2022/06/17 05:23:41 DEBUG : file name.txt: Correcting mime type from "text/plain" to "text/plain; charset=utf-8"
2022/06/17 05:23:41 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': rpc: doModifyFile(map[data:fi_contenttype=text/plain; charset=utf-8
 fi_id:121478803]) options=[]
2022/06/17 05:23:42 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': >rpc: result=Success (ok), err=<nil>
2022/06/17 05:23:42 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': rpc: checkPathExists(map[path:file name.txt pid:121478800]) options=[]
2022/06/17 05:23:42 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': >rpc: result=Success (ok), err=<nil>
2022/06/17 05:23:42 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': rpc: getFolderContents(map[count:1000 fi_pid:121478800 options:filelist|fi_id|fi_pid|fi_name|fi_type|fi_size|fi_contenttype|fi_modified|fi_localtime|trash|subfolders subfolders:y]) options=[]
2022/06/17 05:23:44 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': >rpc: result=Success (ok), err=<nil>
2022/06/17 05:23:44 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': rpc: doCreateNewFolder(map[fi_name:hello? sausage fi_pid:121478800]) options=[]
2022/06/17 05:23:46 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': >rpc: result=Success (ok), err=<nil>
2022/06/17 05:23:46 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': rpc: getFolderContents(map[count:1000 fi_pid:121478805 options:filelist|fi_id|fi_pid|fi_name|fi_type|fi_size|fi_contenttype|fi_modified|fi_localtime|trash|subfolders subfolders:y]) options=[]
2022/06/17 05:23:48 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': >rpc: result=Success (ok), err=<nil>
2022/06/17 05:23:48 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': rpc: doCreateNewFolder(map[fi_name:êé fi_pid:121478805]) options=[]
2022/06/17 05:23:50 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': >rpc: result=Success (ok), err=<nil>
2022/06/17 05:23:50 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': rpc: getFolderContents(map[count:1000 fi_pid:121478807 options:filelist|fi_id|fi_pid|fi_name|fi_type|fi_size|fi_contenttype|fi_modified|fi_localtime|trash|subfolders subfolders:y]) options=[]
2022/06/17 05:23:51 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': >rpc: result=Success (ok), err=<nil>
2022/06/17 05:23:51 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': rpc: doCreateNewFolder(map[fi_name:Hello, 世界 fi_pid:121478807]) options=[]
2022/06/17 05:23:54 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': >rpc: result=Success (ok), err=<nil>
2022/06/17 05:23:54 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': rpc: getFolderContents(map[count:1000 fi_pid:121478808 options:filelist|fi_id|fi_pid|fi_name|fi_type|fi_size|fi_contenttype|fi_modified|fi_localtime|trash|subfolders subfolders:y]) options=[]
2022/06/17 05:23:55 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': >rpc: result=Success (ok), err=<nil>
2022/06/17 05:23:55 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': rpc: doCreateNewFolder(map[fi_name: " ' @ < > & ? + ≠ fi_pid:121478808]) options=[]
2022/06/17 05:23:58 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': >rpc: result=Success (ok), err=<nil>
2022/06/17 05:23:58 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': rpc: doInitUpload(map[directuploadsupport:n fi_contenttype:text/plain; charset=utf-8 fi_filename:z.txt fi_localtime:2001-02-03 04:05:10 fi_modified:2001-02-03 04:05:10 fi_name:z.txt fi_pid:121478809 fi_size:100 responsetype:json]) options=[]
2022/06/17 05:23:59 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': >rpc: result=Success (ok), err=<nil>
2022/06/17 05:24:01 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': rpc: doCompleteUpload(map[fi_size:100 remotetime:2001-02-03 04:05:10 uploadcode:f7d66da3d78e34d44efc5d582f9084d4]) options=[]
2022/06/17 05:24:02 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': >rpc: result=Success (ok), err=<nil>
2022/06/17 05:24:02 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Correcting mime type from "text/plain" to "text/plain; charset=utf-8"
2022/06/17 05:24:02 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': rpc: doModifyFile(map[data:fi_contenttype=text/plain; charset=utf-8
 fi_id:121478810]) options=[]
2022/06/17 05:24:03 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': >rpc: result=Success (ok), err=<nil>
2022/06/17 05:24:03 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': rpc: checkPathExists(map[path:hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt pid:121478800]) options=[]
2022/06/17 05:24:04 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': >rpc: result=Success (ok), err=<nil>
2022/06/17 05:24:04 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': rpc: doInitUpload(map[directuploadsupport:n fi_contenttype:text/csv fi_filename:file name.txt fi_localtime:2001-02-03 04:05:06 fi_modified:2001-02-03 04:05:06 fi_name:file name.txt fi_pid:121478800 fi_size:100 responsetype:json]) options=[]
2022/06/17 05:24:05 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': >rpc: result=Success (ok), err=<nil>
2022/06/17 05:24:07 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': rpc: doCompleteUpload(map[fi_size:100 remotetime:2001-02-03 04:05:06 uploadcode:2510cfb70ed22bc41ea13f4f56fb7e43]) options=[]
2022/06/17 05:24:24 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': >rpc: result=Success (ok), err=<nil>
2022/06/17 05:24:24 DEBUG : file name.txt: Correcting mime type from "text/plain" to "text/csv"
2022/06/17 05:24:24 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': rpc: doModifyFile(map[data:fi_contenttype=text/csv
 fi_id:121478803]) options=[]
2022/06/17 05:24:25 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': >rpc: result=Success (ok), err=<nil>
2022/06/17 05:24:25 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': rpc: checkPathExists(map[path:file name.txt pid:121478800]) options=[]
2022/06/17 05:24:25 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': >rpc: result=Success (ok), err=<nil>
=== RUN   TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType
2022/06/17 05:24:25 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': rpc: checkPathExists(map[path:file name.txt pid:121478800]) options=[]
2022/06/17 05:24:26 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': >rpc: result=Success (ok), err=<nil>
2022/06/17 05:24:26 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': rpc: doDeleteFolder(map[fi_id:121478800]) options=[]
2022/06/17 05:24:27 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': >rpc: result=Success (ok), err=<nil>
2022/06/17 05:24:27 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': rpc: getFolderContents(map[count:1000 fi_pid:120673762 options:filelist|fi_id|fi_pid|fi_name|fi_type|fi_size|fi_contenttype|fi_modified|fi_localtime|trash|subfolders subfolders:y]) options=[]
2022/06/17 05:24:28 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': >rpc: result=Success (ok), err=<nil>
2022/06/17 05:24:28 ERROR : : error listing: directory not found
2022/06/17 05:24:28 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': rpc: getFolderContents(map[count:1000 fi_pid:120673762 options:filelist|fi_id|fi_pid|fi_name|fi_type|fi_size|fi_contenttype|fi_modified|fi_localtime|trash|subfolders subfolders:y]) options=[]
2022/06/17 05:24:29 DEBUG : filefabric root 'rclone-test-haxuvoq8giyokoq7gupajey2': >rpc: result=Success (ok), err=<nil>
--- PASS: TestIntegration (58.90s)
    --- PASS: TestIntegration/FsMkdir (53.13s)
        --- PASS: TestIntegration/FsMkdir/FsPutFiles (49.59s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.57s)
PASS
ok  	github.com/rclone/rclone/backend/filefabric	58.910s
"go test -v -timeout 2h0m0s -remote TestFileFabric: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsPutFiles$/^ObjectMimeType$'" - Finished OK in 1m0.34172476s (try 2/5)