"go test -v -timeout 1h0m0s -remote TestFileFabric: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsPutFiles$/^ObjectMimeType$'" - Starting (try 2/5)
=== RUN   TestIntegration
    fstests.go:396: Using remote "TestFileFabric:"
2020/12/27 06:15:36 DEBUG : Creating backend with remote "TestFileFabric:rclone-test-puzunag1rehetub4dayerin0"
2020/12/27 06:15:36 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': rpc: checkPathExists(map[path:rclone-test-puzunag1rehetub4dayerin0 pid:120673762]) options=[]
2020/12/27 06:15:36 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': >rpc: result=Success (ok), err=<nil>
2020/12/27 06:15:36 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': 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=[]
2020/12/27 06:15:37 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': >rpc: result=Success (ok), err=<nil>
2020/12/27 06:15:37 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': rpc: doCreateNewFolder(map[fi_name:rclone-test-puzunag1rehetub4dayerin0 fi_pid:120673762]) options=[]
2020/12/27 06:15:39 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': >rpc: result=Success (ok), err=<nil>
2020/12/27 06:15:39 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': rpc: getFolderContents(map[count:1000 fi_pid:120771576 options:filelist|fi_id|fi_pid|fi_name|fi_type|fi_size|fi_contenttype|fi_modified|fi_localtime|trash|subfolders subfolders:y]) options=[]
2020/12/27 06:15:40 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': >rpc: result=Success (ok), err=<nil>
=== RUN   TestIntegration/FsMkdir
2020/12/27 06:15:40 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': rpc: getFolderContents(map[count:1000 fi_pid:120771576 options:filelist|fi_id|fi_pid|fi_name|fi_type|fi_size|fi_contenttype|fi_modified|fi_localtime|trash|subfolders subfolders:y]) options=[]
2020/12/27 06:15:40 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': >rpc: result=Success (ok), err=<nil>
=== RUN   TestIntegration/FsMkdir/FsPutFiles
2020/12/27 06:15:40 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': 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:120771576 fi_size:100 responsetype:json]) options=[]
2020/12/27 06:15:41 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': >rpc: result=Success (ok), err=<nil>
2020/12/27 06:15:43 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': rpc: doCompleteUpload(map[fi_size:100 remotetime:2001-02-03 04:05:06 uploadcode:faa1e94bc0ae55c0f2b385291c83790c]) options=[]
2020/12/27 06:15:43 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': >rpc: result=Success (ok), err=<nil>
2020/12/27 06:15:43 DEBUG : file name.txt: Correcting mime type from "text/plain" to "text/plain; charset=utf-8"
2020/12/27 06:15:43 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': rpc: doModifyFile(map[data:fi_contenttype=text/plain; charset=utf-8
 fi_id:120771577]) options=[]
2020/12/27 06:15:44 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': >rpc: result=Success (ok), err=<nil>
2020/12/27 06:15:44 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': rpc: checkPathExists(map[path:file name.txt pid:120771576]) options=[]
2020/12/27 06:15:44 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': >rpc: result=Success (ok), err=<nil>
2020/12/27 06:15:44 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': rpc: getFolderContents(map[count:1000 fi_pid:120771576 options:filelist|fi_id|fi_pid|fi_name|fi_type|fi_size|fi_contenttype|fi_modified|fi_localtime|trash|subfolders subfolders:y]) options=[]
2020/12/27 06:15:44 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': >rpc: result=Success (ok), err=<nil>
2020/12/27 06:15:44 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': rpc: doCreateNewFolder(map[fi_name:hello? sausage fi_pid:120771576]) options=[]
2020/12/27 06:15:47 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': >rpc: result=Success (ok), err=<nil>
2020/12/27 06:15:47 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': rpc: getFolderContents(map[count:1000 fi_pid:120771578 options:filelist|fi_id|fi_pid|fi_name|fi_type|fi_size|fi_contenttype|fi_modified|fi_localtime|trash|subfolders subfolders:y]) options=[]
2020/12/27 06:15:47 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': >rpc: result=Success (ok), err=<nil>
2020/12/27 06:15:47 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': rpc: doCreateNewFolder(map[fi_name:êé fi_pid:120771578]) options=[]
2020/12/27 06:15:50 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': >rpc: result=Success (ok), err=<nil>
2020/12/27 06:15:50 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': rpc: getFolderContents(map[count:1000 fi_pid:120771579 options:filelist|fi_id|fi_pid|fi_name|fi_type|fi_size|fi_contenttype|fi_modified|fi_localtime|trash|subfolders subfolders:y]) options=[]
2020/12/27 06:15:50 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': >rpc: result=Success (ok), err=<nil>
2020/12/27 06:15:50 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': rpc: doCreateNewFolder(map[fi_name:Hello, 世界 fi_pid:120771579]) options=[]
2020/12/27 06:15:53 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': >rpc: result=Success (ok), err=<nil>
2020/12/27 06:15:53 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': rpc: getFolderContents(map[count:1000 fi_pid:120771580 options:filelist|fi_id|fi_pid|fi_name|fi_type|fi_size|fi_contenttype|fi_modified|fi_localtime|trash|subfolders subfolders:y]) options=[]
2020/12/27 06:15:53 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': >rpc: result=Success (ok), err=<nil>
2020/12/27 06:15:53 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': rpc: doCreateNewFolder(map[fi_name: " ' @ < > & ? + ≠ fi_pid:120771580]) options=[]
2020/12/27 06:15:56 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': >rpc: result=Success (ok), err=<nil>
2020/12/27 06:15:56 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': 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:120771581 fi_size:100 responsetype:json]) options=[]
2020/12/27 06:15:57 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': >rpc: result=Success (ok), err=<nil>
2020/12/27 06:15:58 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': rpc: doCompleteUpload(map[fi_size:100 remotetime:2001-02-03 04:05:10 uploadcode:d508feabd8d10b52dc152a5cfebd537a]) options=[]
2020/12/27 06:15:59 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': >rpc: result=Success (ok), err=<nil>
2020/12/27 06:15:59 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Correcting mime type from "text/plain" to "text/plain; charset=utf-8"
2020/12/27 06:15:59 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': rpc: doModifyFile(map[data:fi_contenttype=text/plain; charset=utf-8
 fi_id:120771582]) options=[]
2020/12/27 06:15:59 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': >rpc: result=Success (ok), err=<nil>
2020/12/27 06:15:59 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': rpc: checkPathExists(map[path:hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt pid:120771576]) options=[]
2020/12/27 06:15:59 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': >rpc: result=Success (ok), err=<nil>
2020/12/27 06:15:59 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': 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:120771576 fi_size:100 responsetype:json]) options=[]
2020/12/27 06:16:01 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': >rpc: result=Success (ok), err=<nil>
2020/12/27 06:16:02 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': rpc: doCompleteUpload(map[fi_size:100 remotetime:2001-02-03 04:05:06 uploadcode:21e9c180fd4bd8bc4d6c84c4e1f27445]) options=[]
2020/12/27 06:16:19 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': >rpc: result=Success (ok), err=<nil>
2020/12/27 06:16:19 DEBUG : file name.txt: Correcting mime type from "text/plain" to "text/csv"
2020/12/27 06:16:19 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': rpc: doModifyFile(map[data:fi_contenttype=text/csv
 fi_id:120771577]) options=[]
2020/12/27 06:16:19 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': >rpc: result=Success (ok), err=<nil>
2020/12/27 06:16:19 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': rpc: checkPathExists(map[path:file name.txt pid:120771576]) options=[]
2020/12/27 06:16:20 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': >rpc: result=Success (ok), err=<nil>
=== RUN   TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType
2020/12/27 06:16:20 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': rpc: checkPathExists(map[path:file name.txt pid:120771576]) options=[]
2020/12/27 06:16:20 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': >rpc: result=Success (ok), err=<nil>
2020/12/27 06:16:20 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': rpc: doDeleteFolder(map[fi_id:120771576]) options=[]
2020/12/27 06:16:21 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': >rpc: result=Success (ok), err=<nil>
2020/12/27 06:16:21 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': 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=[]
2020/12/27 06:16:22 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': >rpc: result=Success (ok), err=<nil>
2020/12/27 06:16:22 ERROR : : error listing: directory not found
2020/12/27 06:16:22 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': 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=[]
2020/12/27 06:16:23 DEBUG : filefabric root 'rclone-test-puzunag1rehetub4dayerin0': >rpc: result=Success (ok), err=<nil>
--- PASS: TestIntegration (46.50s)
    --- PASS: TestIntegration/FsMkdir (42.55s)
        --- PASS: TestIntegration/FsMkdir/FsPutFiles (39.97s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.32s)
PASS
ok  	github.com/rclone/rclone/backend/filefabric	46.512s
"go test -v -timeout 1h0m0s -remote TestFileFabric: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsPutFiles$/^ObjectMimeType$'" - Finished OK in 48.00573707s (try 2/5)