Mount failed on Windows - drive just doesn't appear


#1

Hello,

I started using rclone on Windows and so far I was very happy with it.
Easily I could integrate my google drive and also mount worked pretty well.

Since some days I cannot mount my drives anymore, the drive just doesn’t appear.
So I tried to debug and I don’t really see any error:

C:\Users\usr\rclone>rclone -vv mount gdrive:/ X: --vfs-cache-mode writes --debug-fuse
2018/12/03 10:09:24 DEBUG : rclone: Version "v1.44" starting with parameters ["rclone" "-vv" "mount" "gdrive:/" "X:" "--vfs-cache-mode" "writes" "--debug-fuse"]
2018/12/03 10:09:24 DEBUG : Using config file from "C:\\Users\\usr\\.config\\rclone\\rclone.conf"
2018/12/03 10:09:24 DEBUG : Google drive root '': Mounting on "X:"
2018/12/03 10:09:24 DEBUG : vfs cache root is "C:\\Users\\usr\\AppData\\Local\\rclone\\vfs\\gdrive"
2018/12/03 10:09:24 DEBUG : Adding path "vfs/forget" to remote control registry
2018/12/03 10:09:24 DEBUG : Adding path "vfs/refresh" to remote control registry
2018/12/03 10:09:24 DEBUG : Adding path "vfs/poll-interval" to remote control registry
2018/12/03 10:09:24 DEBUG : Google drive root '': Mounting with options: ["-o" "fsname=gdrive:" "-o" "subtype=rclone" "-o" "max_readahead=131072" "-o" "attr_timeout=1" "-o" "atomic_o_trunc" "-o" "debug" "-o" "uid=-1" "-o" "gid=-1" "--FileSystemName=rclone"]
2018/12/03 10:09:24 DEBUG : Google drive root '': Init:
2018/12/03 10:09:24 DEBUG : Google drive root '': >Init:
2018/12/03 10:09:24 DEBUG : /: Statfs:
2018/12/03 10:09:24 DEBUG : /: >Statfs: stat={Bsize:4096 Frsize:4096 Blocks:274877906944 Bfree:274796150367 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Favail:0 Fsid:0 Flag:0 Namemax:255}, errc=0
2018/12/03 10:09:24 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2018/12/03 10:09:24 DEBUG : /: >Getattr: errc=0
2018/12/03 10:09:24 DEBUG : /: Readlink:
2018/12/03 10:09:24 DEBUG : /: >Readlink: linkPath="", errc=-40
The service rclone has been started.
rclone[TID=5530]: FFFF9789C6585580: >>Create [UT---C] "\", FILE_OPEN, CreateOptions=21, FileAttributes=10, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000590[PID=29a8], DesiredAccess=100000, GrantedAccess=0, ShareAccess=3
2018/12/03 10:09:24 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2018/12/03 10:09:24 DEBUG : /: >Getattr: errc=0
2018/12/03 10:09:24 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2018/12/03 10:09:24 DEBUG : /: >Getattr: errc=0
2018/12/03 10:09:24 DEBUG : /: Opendir:
2018/12/03 10:09:24 DEBUG : /: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2018/12/03 10:09:24 DEBUG : /: >OpenFile: fd=/ (r), err=<nil>
2018/12/03 10:09:24 DEBUG : /: >Opendir: errc=0, fh=0x0
rclone[TID=5530]: FFFF9789C6585580: <<Create IoStatus=0[1] UserContext=0000000000000000:00000000000D6F20, GrantedAccess=100000, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2018-12-03T09:09:24.251Z, LastAccessTime=2018-12-03T09:09:24.251Z, LastWriteTime=2018-12-03T09:09:24.251Z, ChangeTime=2018-12-03T09:09:24.251Z, IndexNumber=0:1}
rclone[TID=5530]: FFFF9789D62487B0: >>QueryVolumeInformation
rclone[TID=0754]: FFFF9789C7D16780: >>Create [UT---C] "\", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000005AC[PID=29a8], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2018/12/03 10:09:24 DEBUG : /: Statfs:
2018/12/03 10:09:24 DEBUG : /: >Statfs: stat={Bsize:4096 Frsize:4096 Blocks:274877906944 Bfree:274796150367 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Favail:0 Fsid:0 Flag:0 Namemax:255}, errc=0
rclone[TID=5530]: FFFF9789D62487B0: <<QueryVolumeInformation IoStatus=0[0] VolumeInfo={TotalSize=40000:0, FreeSize=3ffb2:7e5f000, VolumeLabel=""}
2018/12/03 10:09:24 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
rclone[TID=5530]: FFFF9789C8E31CC0: >>Close 0000000000000000:00000000000D6F20
2018/12/03 10:09:24 DEBUG : /: >Getattr: errc=0
2018/12/03 10:09:24 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2018/12/03 10:09:24 DEBUG : /: >Getattr: errc=0
2018/12/03 10:09:24 DEBUG : /: Opendir:
2018/12/03 10:09:24 DEBUG : /: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2018/12/03 10:09:24 DEBUG : /: >OpenFile: fd=/ (r), err=<nil>
2018/12/03 10:09:24 DEBUG : /: >Opendir: errc=0, fh=0x1
rclone[TID=0754]: FFFF9789C7D16780: <<Create IoStatus=0[1] UserContext=0000000000000000:00000000000D7250, GrantedAccess=80, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2018-12-03T09:09:24.251Z, LastAccessTime=2018-12-03T09:09:24.251Z, LastWriteTime=2018-12-03T09:09:24.251Z, ChangeTime=2018-12-03T09:09:24.251Z, IndexNumber=0:1}
2018/12/03 10:09:24 DEBUG : /: Releasedir: fh=0x0
rclone[TID=0754]: FFFF9789D6961010: >>Close 0000000000000000:00000000000D7250
rclone[TID=4c94]: FFFF9789C6585580: >>Create [UT---C] "\", FILE_OPEN, CreateOptions=21, FileAttributes=10, Security=NULL, AllocationSize=0:0, AccessToken=00000000000005B0[PID=29a8], DesiredAccess=100000, GrantedAccess=0, ShareAccess=3
2018/12/03 10:09:24 DEBUG : /: >Releasedir: errc=0
rclone[TID=5530]: FFFF9789C8E31CC0: <<Close IoStatus=0[0]
2018/12/03 10:09:24 DEBUG : /: Releasedir: fh=0x1
2018/12/03 10:09:24 DEBUG : /: >Releasedir: errc=0
rclone[TID=0754]: FFFF9789D6961010: <<Close IoStatus=0[0]
2018/12/03 10:09:24 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2018/12/03 10:09:24 DEBUG : /: >Getattr: errc=0
2018/12/03 10:09:24 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2018/12/03 10:09:24 DEBUG : /: >Getattr: errc=0
2018/12/03 10:09:24 DEBUG : /: Opendir:
2018/12/03 10:09:24 DEBUG : /: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2018/12/03 10:09:24 DEBUG : /: >OpenFile: fd=/ (r), err=<nil>
2018/12/03 10:09:24 DEBUG : /: >Opendir: errc=0, fh=0x0
rclone[TID=4c94]: FFFF9789C6585580: <<Create IoStatus=0[1] UserContext=0000000000000000:00000000000D7250, GrantedAccess=100000, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2018-12-03T09:09:24.251Z, LastAccessTime=2018-12-03T09:09:24.251Z, LastWriteTime=2018-12-03T09:09:24.251Z, ChangeTime=2018-12-03T09:09:24.251Z, IndexNumber=0:1}
rclone[TID=4c94]: FFFF9789D68DF230: >>Close 0000000000000000:00000000000D7250
2018/12/03 10:09:24 DEBUG : /: Releasedir: fh=0x0
2018/12/03 10:09:24 DEBUG : /: >Releasedir: errc=0
rclone[TID=4c94]: FFFF9789D68DF230: <<Close IoStatus=0[0]
2018/12/03 10:10:24 DEBUG : Google drive root '': Checking for changes on remote
2018/12/03 10:11:24 DEBUG : Google drive root '': Checking for changes on remote
2018/12/03 10:12:24 DEBUG : Google drive root '': Checking for changes on remote
2018/12/03 10:13:24 DEBUG : Google drive root '': Checking for changes on remote

Has someone any idea what this could be? I have absolutely no idea where to search.
I also tried different drive letters that are all not taken, but no idea why it doesn’t work.

Thank you and best regards


#2

From your log it appears that the drive is mounted.

I don’t know why it doesn’t appear though…

Did you try a reboot? Maybe the kernel has got confused somehow?


#3

Reboot of windows? Yes, I did a reboot, but still it doesn’t show up.


#4

Have you got the latest version of WinFSP? Maybe you could try re-installing that?


#5

Also tried that one, but still doesn’t change.
But I realize it’s something with my computer, maybe another program has an impact. I will try to close everything and then check again.

I copied rclone with the same config to a VM, works like a charm


#6

That is a good experiment.

I’d be interested to hear how you get on.