Unable to Test Connectivity to Google Drive or Properly Configure Log File

jmg999 · March 19, 2022, 6:33am

What is the problem you are having with rclone?

I have Rclone configured (improperly) on a Windows 10 system v21H1 (OS Build 19043.1586) in order to sync data w/ Google Drive. I followed the instructions found in the install documents and the Google Drive configuration document. After installation/configuration, I wanted to test connectivity but was neither able to do that nor configure the log file properly to see what the underlying issues might be.

Run the command 'rclone version' and share the full output of the command.

C:\Users\xxxxx\OneDrive\Desktop\my_docs\Computing\My Devices\Lenovo ThinkPad X1 Extreme Gen 3\Software\Data Transfer Software\rclone-v1.57.0-windows-amd64>rclone -v lsf Google_Drive:"00 - Rclone Backups"
2022/03/18 18:16:49 Failed to create file system for "Google_Drive:00 - Rclone Backups": didn't find section in config file

C:\Users\xxxxx\OneDrive\Desktop\my_docs\Computing\My Devices\Lenovo ThinkPad X1 Extreme Gen 3\Software\Data Transfer Software\rclone-v1.57.0-windows-amd64>rclone config show
[GoogleDrive]
type = drive
client_id = xxxxxxxxxx.apps.googleusercontent.com
client_secret = xxxxxxxxxx
scope = drive
root_folder_id = 1Awb4MZ_o3cPDr2HGszxm3udns8LsV5JX
token = {"access_token":"ya29.A0ARrdaM9GBFJRPFGWSaHkP5xs2O0mWFVo0ZFj13ibrNye8zjG632Fg_h_HkTqRUkxrFu3CBrZyuyIh4kS1YveOeVIHnfNk-gZmVErxnANF429UJb30eS7xvi7iHz5WgaDGISRfHY94NTqubhHTmpe6ccurbZh","token_type":"Bearer","refresh_token":"1//06VCc5oheBisnCgYIARAAGAYSNwF-L9IrmjmIkpjwWyWYS0JG14FGwW8dwOw4hc7qBb-q7M8nm72GG5z023Z8XyH5RCe6vDOj3TU","expiry":"2022-03-17T01:28:11.303404-07:00"}
team_drive =

***At this point, I created a file called Rclone_Log.txt in the same path that I was working from, and I ran the following commands:

C:\Users\xxxxx\OneDrive\Desktop\my_docs\Computing\My Devices\Lenovo ThinkPad X1 Extreme Gen 3\Software\Data Transfer Software\rclone-v1.57.0-windows-amd64>rclone --log-file="C:\Users\xxxxx\OneDrive\Desktop\my_docs\Computing\My Devices\Lenovo ThinkPad X1 Extreme Gen 3\Software\Data Transfer Software\Rclone_Log.txt" --log-level DEBUG
Usage:
  rclone [flags]
  rclone [command]

Available Commands:
  about           Get quota information from the remote.
  .
  .
  .
  version         Show the version number.

Use "rclone [command] --help" for more information about a command.
Use "rclone help flags" for to see the global flags.
Use "rclone help backends" for a list of supported services.

C:\Users\xxxxx\OneDrive\Desktop\my_docs\Computing\My Devices\Lenovo ThinkPad X1 Extreme Gen 3\Software\Data Transfer Software\rclone-v1.57.0-windows-amd64>rclone --log-level DEBUG
2022/03/17 23:14:57 DEBUG : rclone: Version "v1.57.0" starting with parameters ["rclone" "--log-level" "DEBUG"]

C:\Users\xxxxx\OneDrive\Desktop\my_docs\Computing\My Devices\Lenovo ThinkPad X1 Extreme Gen 3\Software\Data Transfer Software\rclone-v1.57.0-windows-amd64>rclone -v lsf Google_Drive:"00 - Rclone Backups"
2022/03/18 22:54:58 Failed to create file system for "Google_Drive:00 - Rclone Backups": didn't find section in config file

***I then checked the contents of the Rclone_Log.txt file, and it didn't show any information pertaining to this command or any of the others I'd run, save for a notification that Rclone had started w/ parameters being defined for a log file.

2022/03/17 23:16:24 DEBUG : rclone: Version "v1.57.0" starting with parameters ["rclone" "--log-level" "DEBUG" "--log-file=C:\\Users\\xxxxx\\OneDrive\\Desktop\\my_docs\\Computing\\My Devices\\Lenovo ThinkPad X1 Extreme Gen 3\\Software\\Data Transfer Software\\Rclone_Log.txt"]

The rclone config contents with secrets removed.

C:\Users\xxxxx\OneDrive\Desktop\my_docs\Computing\My Devices\Lenovo ThinkPad X1 Extreme Gen 3\Software\Data Transfer Software\rclone-v1.57.0-windows-amd64>rclone config show
[GoogleDrive]
type = drive
client_id = xxxxxxxxxx-cuvd9ul4g6d368iuhvc5oa1i39itvcqo.apps.googleusercontent.com
client_secret = xxxxxxxxxx-ZUziqgsUUTUR8OWzxFxllN6ezqbp
scope = drive
root_folder_id = 1Awb4MZ_o3cPDr2HGszxm3udns8LsV5JX
token = {"access_token":"ya29.A0ARrdaM9GBFJRPFGWSaHkP5xs2O0mWFVo0ZFj13ibrNye8zjG632Fg_h_HkTqRUkxrFu3CBrZyuyIh4kS1YveOeVIHnfNk-gZmVErxnANF429UJb30eS7xvi7iHz5WgaDGISRfHY94NTqubhHTmpe6ccurbZh","token_type":"Bearer","refresh_token":"1//06VCc5oheBisnCgYIARAAGAYSNwF-L9IrmjmIkpjwWyWYS0JG14FGwW8dwOw4hc7qBb-q7M8nm72GG5z023Z8XyH5RCe6vDOj3TU","expiry":"2022-03-17T01:28:11.303404-07:00"}
team_drive =

A log from the command with the `-vv` flag

C:\Users\xxxxx\OneDrive\Desktop\my_docs\Computing\My Devices\Lenovo ThinkPad X1 Extreme Gen 3\Software\Data Transfer Software\rclone-v1.57.0-windows-amd64>rclone lsd Rclone_Log.txt: -vv
2022/03/18 23:14:18 DEBUG : rclone: Version "v1.58.0" starting with parameters ["rclone" "lsd" "Rclone_Log.txt:" "-vv"]
2022/03/18 23:14:18 DEBUG : Creating backend with remote "Rclone_Log.txt:"
2022/03/18 23:14:18 DEBUG : Using config file from "C:\\Users\\xxxxx\\AppData\\Roaming\\rclone\\rclone.conf"
2022/03/18 23:14:18 Failed to create file system for "Rclone_Log.txt:": didn't find section in config file

This is part of my problem in that I'm having difficulties w/ logging events. I'm not certain if I'm using the wrong commands, wrong path, a combination of the two, or if it's something else entirely unrelated. Either way, this remains the contents of the log file:

2022/03/17 23:13:32 DEBUG : rclone: Version "v1.57.0" starting with parameters ["rclone" "--log-file=C:\\Users\\xxxxx\\OneDrive\\Desktop\\my_docs\\Computing\\My Devices\\Lenovo ThinkPad X1 Extreme Gen 3\\Software\\Data Transfer Software\\Rclone_Log.txt" "--log-level" "DEBUG"]
2022/03/17 23:16:24 DEBUG : rclone: Version "v1.57.0" starting with parameters ["rclone" "--log-level" "DEBUG" "--log-file=C:\\Users\\xxxxx\\OneDrive\\Desktop\\my_docs\\Computing\\My Devices\\Lenovo ThinkPad X1 Extreme Gen 3\\Software\\Data Transfer Software\\Rclone_Log.txt"]

albertony · March 19, 2022, 11:57am

Hi.

This:

Failed to create file system for "Google_Drive:00 - Rclone Backups": didn't find section in config file

... is because you wrote Google_Drive instead of GoogleDrive, which is what you called your remote:

[GoogleDrive]
type = drive

And you got this output from your second command:

Usage:
  rclone [flags]
  rclone [command]

.. because you did not write an actual command (ls, touch, copy, etc.):

...>rclone --log-file="...Rclone_Log.txt" --log-level DEBUG

...so rclone was not told what to do and just gives you basic syntax help text instead.

It may be worth reading up on usage in Documentation.

jmg999 · March 20, 2022, 6:51pm

Thank you for your response. The Google_Drive vs. GoogleDrive syntax issue was a stupid mistake on my part. I had originally created a config, where I named the remote Google_Drive. However, I made some mistakes in the config, so I deleted it and began again. In my second go-round, I named the remote GoogleDrive, but I inadvertently used the former remote name in calling the directory in command for testing connectivity.

Pertaining to the log file command, I had previously read the documentation found here. I was under the impression that the command was "log-file=location of log file" in order to assign the location of the log file I'd already created. So, what I did was, I created the file (Rclone_Log.txt), and I used the --log-file= command to point to it. I see what you mean about it being a flag, but in reading through the list of all commands, I didn't see anything indicative of actually configuring the log file, so I performed a Google search. I didn't find much except for posts similar to this pointing back to the documentation.

Since I wasn't certain what command to run to accomplish this particular task, I began thinking about other commands I could run, where I might be able to tack on the --log-file= flag. I wanted to mount Google Drive w/in Windows, so I tried setting that up by first installing WinFsp w/ FUSE, then running the following command:

rclone mount GoogleDrive:"00 - Rclone Backups" D: --network-mode --log-file=C:\Users\xxxxx\AppData\Roaming\rclone\rclone_log.txt --log-level DEBUG

After entering this command, the Command Prompt appeared to sort of hang, so I checked Explorer to see if Google Drive showed up as the D: drive, but it didn't. I tried mapping it, but it didn't show up in my network, either, so I checked Rclone_Log.txt.

2022/03/20 09:54:16 DEBUG : rclone: Version "v1.58.0" starting with parameters ["rclone" "mount" "GoogleDrive:00 - Rclone Backups" "D:" "--network-mode" "--log-file=C:\\Users\\xxxxx\\AppData\\Roaming\\rclone\\rclone_log.txt" "--log-level" "DEBUG"]
2022/03/20 09:54:16 DEBUG : Creating backend with remote "GoogleDrive:00 - Rclone Backups"
2022/03/20 09:54:16 DEBUG : Using config file from "C:\\Users\\xxxxx\\AppData\\Roaming\\rclone\\rclone.conf"
2022/03/20 09:54:16 DEBUG : Network mode mounting is enabled
2022/03/20 09:54:16 DEBUG : Mounting on "D:" ("\\server\\GoogleDrive 00 - Rclone Backups")
2022/03/20 09:54:16 DEBUG : Google drive root '00 - Rclone Backups': Mounting with options: ["-o" "attr_timeout=1" "-o" "uid=-1" "-o" "gid=-1" "--FileSystemName=rclone" "--VolumePrefix=\\server\\GoogleDrive 00 - Rclone Backups"]
2022/03/20 09:54:16 DEBUG : Google drive root '00 - Rclone Backups': Init: 
2022/03/20 09:54:16 DEBUG : Google drive root '00 - Rclone Backups': >Init: 
2022/03/20 09:54:16 DEBUG : /: Statfs: 
2022/03/20 09:54:16 DEBUG : /: >Statfs: stat={Bsize:4096 Frsize:4096 Blocks:536870912 Bfree:364278356 Bavail:364278356 Files:1000000000 Ffree:1000000000 Favail:0 Fsid:0 Flag:0 Namemax:255}, errc=0
2022/03/20 09:54:16 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/03/20 09:54:16 DEBUG : /: >Getattr: errc=0
2022/03/20 09:54:16 DEBUG : /: Readlink: 
2022/03/20 09:54:16 DEBUG : /: >Readlink: linkPath="", errc=-40
The service rclone has been started.
2022/03/20 09:54:16 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/03/20 09:54:16 DEBUG : /: >Getattr: errc=0
2022/03/20 09:54:16 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/03/20 09:54:16 DEBUG : /: >Getattr: errc=0
2022/03/20 09:54:16 DEBUG : /: Opendir: 
2022/03/20 09:54:16 DEBUG : /: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/03/20 09:54:16 DEBUG : /: >OpenFile: fd=/ (r), err=<nil>
2022/03/20 09:54:16 DEBUG : /: >Opendir: errc=0, fh=0x0
2022/03/20 09:54:16 DEBUG : /: Releasedir: fh=0x0
2022/03/20 09:54:16 DEBUG : /: >Releasedir: errc=0
2022/03/20 09:54:16 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/03/20 09:54:16 DEBUG : /: >Getattr: errc=0
2022/03/20 09:54:16 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/03/20 09:54:16 DEBUG : /: >Getattr: errc=0
2022/03/20 09:54:16 DEBUG : /: Opendir: 
2022/03/20 09:54:16 DEBUG : /: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/03/20 09:54:16 DEBUG : /: >OpenFile: fd=/ (r), err=<nil>
2022/03/20 09:54:16 DEBUG : /: >Opendir: errc=0, fh=0x0
2022/03/20 09:54:16 DEBUG : /: Releasedir: fh=0x0
2022/03/20 09:54:16 DEBUG : /: >Releasedir: errc=0
2022/03/20 09:54:16 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/03/20 09:54:16 DEBUG : /: >Getattr: errc=0
2022/03/20 09:54:16 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/03/20 09:54:16 DEBUG : /: >Getattr: errc=0
2022/03/20 09:54:16 DEBUG : /: Opendir: 
2022/03/20 09:54:16 DEBUG : /: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/03/20 09:54:16 DEBUG : /: >OpenFile: fd=/ (r), err=<nil>
2022/03/20 09:54:16 DEBUG : /: >Opendir: errc=0, fh=0x0
2022/03/20 09:54:16 DEBUG : /: Releasedir: fh=0x0
2022/03/20 09:54:16 DEBUG : /: >Releasedir: errc=0
2022/03/20 09:55:16 DEBUG : Google drive root '00 - Rclone Backups': Checking for changes on remote
2022/03/20 09:56:16 DEBUG : Google drive root '00 - Rclone Backups': Checking for changes on remote
2022/03/20 09:57:16 DEBUG : Google drive root '00 - Rclone Backups': Checking for changes on remote
2022/03/20 09:58:16 DEBUG : Google drive root '00 - Rclone Backups': Checking for changes on remote
2022/03/20 09:59:16 DEBUG : Google drive root '00 - Rclone Backups': Checking for changes on remote
2022/03/20 10:00:16 DEBUG : Google drive root '00 - Rclone Backups': Checking for changes on remote
2022/03/20 10:00:16 DEBUG : GoogleDrive: Loaded invalid token from config file - ignoring
2022/03/20 10:00:16 DEBUG : Saving config "token" in section "GoogleDrive" of the config file
2022/03/20 10:00:16 DEBUG : Keeping previous permissions for config file: -rw-rw-rw-
2022/03/20 10:00:16 DEBUG : GoogleDrive: Saved new token in config file
2022/03/20 10:01:16 DEBUG : Google drive root '00 - Rclone Backups': Checking for changes on remote

Other than the invalid token, the log appears to be working, the remote path seems to have been mounted, and the monitoring of the remote path seems to be taking place. Therefore, I created two test directories in my remote directory (Test Directory 01 and Test Directory 02) and checked the log again.

2022/03/20 10:05:16 DEBUG : Google drive root '00 - Rclone Backups': Checking for changes on remote
2022/03/20 10:05:17 DEBUG : : changeNotify: relativePath="Test Directory 01", type=0
2022/03/20 10:05:17 DEBUG : : >changeNotify: 
2022/03/20 10:05:17 DEBUG : : changeNotify: relativePath="Test Directory 02", type=0

This also seemed promising, so I opened a new Command Prompt in order to check connectivity to my remote.

rclone -vv lsd GoogleDrive:"00 - Rclone Backups"
2022/03/20 11:49:21 DEBUG : rclone: Version "v1.58.0" starting with parameters ["rclone" "-vv" "lsd" "GoogleDrive:00 - Rclone Backups"]
2022/03/20 11:49:21 DEBUG : Creating backend with remote "GoogleDrive:00 - Rclone Backups"
2022/03/20 11:49:21 DEBUG : Using config file from "C:\\Users\\xxxxx\\AppData\\Roaming\\rclone\\rclone.conf"
2022/03/20 11:49:22 ERROR : : error listing: directory not found
2022/03/20 11:49:22 DEBUG : 4 go routines active
2022/03/20 11:49:22 Failed to lsd with 2 errors: last error was: directory not found

Yet, when I check the log, there's no entry related to this command. Rclone is still checking for changes on the remote, and that's it.

2022/03/20 10:18:16 DEBUG : Google drive root '00 - Rclone Backups': Checking for changes on remote
2022/03/20 10:19:16 DEBUG : Google drive root '00 - Rclone Backups': Checking for changes on remote

I checked rclone.conf, and the root_folder_id matches the ID of the remote directory I want to map to, so I ran another Google search on this error. Everything I found related to typos or different types of accounts than I'm attempting to setup, so they were caused by other complications. I'm not certain what I'm doing incorrectly, but this is where everything stands right now.

asdffdsa · March 20, 2022, 7:03pm

the command prompt you run the rclone mount command from.
are you running it as user with or without admin privileges?

i would try to open two command prompts
one prompt as user with admin privileges
one prompt without admin privileges
for each prompt, try dir d:

asdffdsa · March 20, 2022, 7:05pm

here are some of the flags
https://rclone.org/docs/#log-format-list
https://rclone.org/docs/#log-level-level
https://rclone.org/docs/#use-json-log

jmg999 · March 21, 2022, 4:52am

Hi, asdffdsa,

Thank you for your response. I'd originally run it from an elevated command prompt. Per your request, I was required to open three Command Prompt windows. The first was an elevated window, b/c when I start the service, it doesn't return me to a prompt, just sort of hanging there, but the service does run. I'm not certain if this is normal behavior or not, but it is working like this.

The second window was also an elevated Command Prompt, and this was the result of the command:

C:\Windows\system32>dir d:
 Volume in drive D has no label.
 Volume Serial Number is 85F8-AF59

 Directory of D:\

File Not Found

The third Command Prompt window had regular user privileges, and it couldn't find the path either from the user directory or after changing directories to the Rclone directory itself, not that it should have made a difference.

C:\Users\xxxxx>dir d:
The system cannot find the path specified.

C:\Users\xxxxx>cd C:\Users\xxxxx\OneDrive\Desktop\my_docs\Computing\My Devices\Lenovo ThinkPad X1 Extreme Gen 3\Software\Data Transfer Software\rclone-v1.57.0-windows-amd64

C:\Users\xxxxx\OneDrive\Desktop\my_docs\Computing\My Devices\Lenovo ThinkPad X1 Extreme Gen 3\Software\Data Transfer Software\rclone-v1.57.0-windows-amd64>dir d:
The system cannot find the path specified.

In regard to the links to the log flags, I had read all those, and I obviously changed the log-level to "DEBUG," but I didn't mess w/ formatting, since I wasn't able to get this up and running smoothly, nor did I change the format to "JSON." I have now attempted the latter, and these were the results:

First, I stopped the service.

The service rclone has been stopped.
2022/03/20 21:38:54 DEBUG : Google drive root '00 - Rclone Backups': Destroy: 
2022/03/20 21:38:54 DEBUG : Google drive root '00 - Rclone Backups': >Destroy: 
2022/03/20 21:38:54 DEBUG : Not calling host.Unmount as mount already Destroyed
2022/03/20 21:38:54 DEBUG : Unmounted successfully
2022/03/20 21:38:54 ERROR : D:: Unmounted rclone mount
2022/03/20 21:38:54 DEBUG : rclone: Version "v1.58.0" finishing with parameters ["rclone" "mount" "GoogleDrive:00 - Rclone Backups" "D:" "--network-mode" "--log-file=C:\\Users\\socal\\AppData\\Roaming\\rclone\\rclone_log.txt" "--log-level" "DEBUG"]

Second, I renamed the log file from "rclone_log.txt" to "rclone_log.old," and I created a new log w/ the name "rclone_log.json." I then restarted the service and added the "--use-json-log" flag.

Service restart w/ json-log flag:

c:\Users\xxxxx\OneDrive\Desktop\my_docs\Computing\My Devices\Lenovo ThinkPad X1 Extreme Gen 3\Software\Data Transfer Software\rclone-v1.57.0-windows-amd64>rclone mount GoogleDrive:"00 - Rclone Backups" D: --network-mode --log-file="C:\Users\xxxxx\AppData\Roaming\rclone\rclone_log.json" --use-json-log --log-level DEBUG

I then opened two more Command Prompts, one elevated and one user-level, in order to check the validity of the D: directory, and I received the same results as earlier in this post.

Output of rclone_log.json:

{"level":"debug","msg":"Version \"v1.58.0\" starting with parameters [\"rclone\" \"mount\" \"GoogleDrive:00 - Rclone Backups\" \"D:\" \"--network-mode\" \"--log-file=C:\\\\Users\\\\xxxxx\\\\AppData\\\\Roaming\\\\rclone\\\\rclone_log.json\" \"--use-json-log\" \"--log-level\" \"DEBUG\"]","object":"rclone","objectType":"string","source":"cmd/cmd.go:408","time":"2022-03-20T21:45:24.580959-07:00"}
{"level":"debug","msg":"Creating backend with remote \"GoogleDrive:00 - Rclone Backups\"","source":"fs/newfs.go:28","time":"2022-03-20T21:45:24.581984-07:00"}
{"level":"debug","msg":"Using config file from \"C:\\\\Users\\\\xxxxx\\\\AppData\\\\Roaming\\\\rclone\\\\rclone.conf\"","source":"config/config.go:353","time":"2022-03-20T21:45:24.582496-07:00"}
{"level":"debug","msg":"Network mode mounting is enabled","source":"cmount/mountpoint_windows.go:183","time":"2022-03-20T21:45:25.229565-07:00"}
{"level":"debug","msg":"Mounting on \"D:\" (\"\\\\server\\\\GoogleDrive 00 - Rclone Backups\")","source":"cmount/mount.go:161","time":"2022-03-20T21:45:25.23047-07:00"}
{"level":"debug","msg":"Mounting with options: [\"-o\" \"attr_timeout=1\" \"-o\" \"uid=-1\" \"-o\" \"gid=-1\" \"--FileSystemName=rclone\" \"--VolumePrefix=\\\\server\\\\GoogleDrive 00 - Rclone Backups\"]","object":"Google drive root '00 - Rclone Backups'","objectType":"*drive.Fs","source":"cmount/mount.go:172","time":"2022-03-20T21:45:25.230665-07:00"}
{"level":"debug","msg":"Init: ","object":"Google drive root '00 - Rclone Backups'","objectType":"*drive.Fs","source":"cmount/fs.go:184","time":"2022-03-20T21:45:25.242222-07:00"}
{"level":"debug","msg":"\u003eInit: ","object":"Google drive root '00 - Rclone Backups'","objectType":"*drive.Fs","source":"cmount/fs.go:186","time":"2022-03-20T21:45:25.24313-07:00"}
{"level":"debug","msg":"Statfs: ","object":"/","objectType":"string","source":"cmount/fs.go:279","time":"2022-03-20T21:45:25.24313-07:00"}
{"level":"debug","msg":"\u003eStatfs: stat={Bsize:4096 Frsize:4096 Blocks:536870912 Bfree:364278310 Bavail:364278310 Files:1000000000 Ffree:1000000000 Favail:0 Fsid:0 Flag:0 Namemax:255}, errc=0","object":"/","objectType":"string","source":"cmount/fs.go:293","time":"2022-03-20T21:45:25.380189-07:00"}
{"level":"debug","msg":"Getattr: fh=0xFFFFFFFFFFFFFFFF","object":"/","objectType":"string","source":"cmount/fs.go:198","time":"2022-03-20T21:45:25.380363-07:00"}
{"level":"debug","msg":"\u003eGetattr: errc=0","object":"/","objectType":"string","source":"cmount/fs.go:203","time":"2022-03-20T21:45:25.380533-07:00"}
{"level":"debug","msg":"Readlink: ","object":"/","objectType":"string","source":"cmount/fs.go:515","time":"2022-03-20T21:45:25.380533-07:00"}
{"level":"debug","msg":"\u003eReadlink: linkPath=\"\", errc=-40","object":"/","objectType":"string","source":"cmount/fs.go:516","time":"2022-03-20T21:45:25.380711-07:00"}
The service rclone has been started.
{"level":"debug","msg":"Getattr: fh=0xFFFFFFFFFFFFFFFF","object":"/","objectType":"string","source":"cmount/fs.go:198","time":"2022-03-20T21:45:25.389309-07:00"}
{"level":"debug","msg":"\u003eGetattr: errc=0","object":"/","objectType":"string","source":"cmount/fs.go:203","time":"2022-03-20T21:45:25.389309-07:00"}
{"level":"debug","msg":"Getattr: fh=0xFFFFFFFFFFFFFFFF","object":"/","objectType":"string","source":"cmount/fs.go:198","time":"2022-03-20T21:45:25.389309-07:00"}
{"level":"debug","msg":"\u003eGetattr: errc=0","object":"/","objectType":"string","source":"cmount/fs.go:203","time":"2022-03-20T21:45:25.389309-07:00"}
{"level":"debug","msg":"Opendir: ","object":"/","objectType":"string","source":"cmount/fs.go:208","time":"2022-03-20T21:45:25.389309-07:00"}
{"level":"debug","msg":"OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx","object":"/","objectType":"string","source":"vfs/vfs.go:485","time":"2022-03-20T21:45:25.389309-07:00"}
{"level":"debug","msg":"\u003eOpenFile: fd=/ (r), err=\u003cnil\u003e","object":"/","objectType":"string","source":"vfs/vfs.go:509","time":"2022-03-20T21:45:25.389309-07:00"}
{"level":"debug","msg":"\u003eOpendir: errc=0, fh=0x0","object":"/","objectType":"string","source":"cmount/fs.go:213","time":"2022-03-20T21:45:25.389309-07:00"}
{"level":"debug","msg":"Releasedir: fh=0x0","object":"/","objectType":"string","source":"cmount/fs.go:273","time":"2022-03-20T21:45:25.389832-07:00"}
{"level":"debug","msg":"\u003eReleasedir: errc=0","object":"/","objectType":"string","source":"cmount/fs.go:274","time":"2022-03-20T21:45:25.389832-07:00"}
{"level":"debug","msg":"Getattr: fh=0xFFFFFFFFFFFFFFFF","object":"/","objectType":"string","source":"cmount/fs.go:198","time":"2022-03-20T21:45:25.389832-07:00"}
{"level":"debug","msg":"\u003eGetattr: errc=0","object":"/","objectType":"string","source":"cmount/fs.go:203","time":"2022-03-20T21:45:25.389832-07:00"}
{"level":"debug","msg":"Getattr: fh=0xFFFFFFFFFFFFFFFF","object":"/","objectType":"string","source":"cmount/fs.go:198","time":"2022-03-20T21:45:25.389832-07:00"}
{"level":"debug","msg":"\u003eGetattr: errc=0","object":"/","objectType":"string","source":"cmount/fs.go:203","time":"2022-03-20T21:45:25.389832-07:00"}
{"level":"debug","msg":"Opendir: ","object":"/","objectType":"string","source":"cmount/fs.go:208","time":"2022-03-20T21:45:25.389832-07:00"}
{"level":"debug","msg":"OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx","object":"/","objectType":"string","source":"vfs/vfs.go:485","time":"2022-03-20T21:45:25.389832-07:00"}
{"level":"debug","msg":"\u003eOpenFile: fd=/ (r), err=\u003cnil\u003e","object":"/","objectType":"string","source":"vfs/vfs.go:509","time":"2022-03-20T21:45:25.389832-07:00"}
{"level":"debug","msg":"\u003eOpendir: errc=0, fh=0x0","object":"/","objectType":"string","source":"cmount/fs.go:213","time":"2022-03-20T21:45:25.389832-07:00"}
{"level":"debug","msg":"Releasedir: fh=0x0","object":"/","objectType":"string","source":"cmount/fs.go:273","time":"2022-03-20T21:45:25.390359-07:00"}
{"level":"debug","msg":"\u003eReleasedir: errc=0","object":"/","objectType":"string","source":"cmount/fs.go:274","time":"2022-03-20T21:45:25.390359-07:00"}
{"level":"debug","msg":"Getattr: fh=0xFFFFFFFFFFFFFFFF","object":"/","objectType":"string","source":"cmount/fs.go:198","time":"2022-03-20T21:45:25.390359-07:00"}
{"level":"debug","msg":"\u003eGetattr: errc=0","object":"/","objectType":"string","source":"cmount/fs.go:203","time":"2022-03-20T21:45:25.390359-07:00"}
{"level":"debug","msg":"Getattr: fh=0xFFFFFFFFFFFFFFFF","object":"/","objectType":"string","source":"cmount/fs.go:198","time":"2022-03-20T21:45:25.390359-07:00"}
{"level":"debug","msg":"\u003eGetattr: errc=0","object":"/","objectType":"string","source":"cmount/fs.go:203","time":"2022-03-20T21:45:25.390359-07:00"}
{"level":"debug","msg":"Opendir: ","object":"/","objectType":"string","source":"cmount/fs.go:208","time":"2022-03-20T21:45:25.390359-07:00"}
{"level":"debug","msg":"OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx","object":"/","objectType":"string","source":"vfs/vfs.go:485","time":"2022-03-20T21:45:25.390359-07:00"}
{"level":"debug","msg":"\u003eOpenFile: fd=/ (r), err=\u003cnil\u003e","object":"/","objectType":"string","source":"vfs/vfs.go:509","time":"2022-03-20T21:45:25.390359-07:00"}
{"level":"debug","msg":"\u003eOpendir: errc=0, fh=0x0","object":"/","objectType":"string","source":"cmount/fs.go:213","time":"2022-03-20T21:45:25.390359-07:00"}
{"level":"debug","msg":"Releasedir: fh=0x0","object":"/","objectType":"string","source":"cmount/fs.go:273","time":"2022-03-20T21:45:25.390359-07:00"}
{"level":"debug","msg":"\u003eReleasedir: errc=0","object":"/","objectType":"string","source":"cmount/fs.go:274","time":"2022-03-20T21:45:25.390359-07:00"}
{"level":"debug","msg":"Getattr: fh=0xFFFFFFFFFFFFFFFF","object":"/","objectType":"string","source":"cmount/fs.go:198","time":"2022-03-20T21:46:12.763344-07:00"}
{"level":"debug","msg":"\u003eGetattr: errc=0","object":"/","objectType":"string","source":"cmount/fs.go:203","time":"2022-03-20T21:46:12.763344-07:00"}
{"level":"debug","msg":"Getattr: fh=0xFFFFFFFFFFFFFFFF","object":"/","objectType":"string","source":"cmount/fs.go:198","time":"2022-03-20T21:46:12.763344-07:00"}
{"level":"debug","msg":"\u003eGetattr: errc=0","object":"/","objectType":"string","source":"cmount/fs.go:203","time":"2022-03-20T21:46:12.763344-07:00"}
{"level":"debug","msg":"Opendir: ","object":"/","objectType":"string","source":"cmount/fs.go:208","time":"2022-03-20T21:46:12.763344-07:00"}
{"level":"debug","msg":"OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx","object":"/","objectType":"string","source":"vfs/vfs.go:485","time":"2022-03-20T21:46:12.763344-07:00"}
{"level":"debug","msg":"\u003eOpenFile: fd=/ (r), err=\u003cnil\u003e","object":"/","objectType":"string","source":"vfs/vfs.go:509","time":"2022-03-20T21:46:12.763344-07:00"}
{"level":"debug","msg":"\u003eOpendir: errc=0, fh=0x0","object":"/","objectType":"string","source":"cmount/fs.go:213","time":"2022-03-20T21:46:12.763344-07:00"}
{"level":"debug","msg":"Releasedir: fh=0x0","object":"/","objectType":"string","source":"cmount/fs.go:273","time":"2022-03-20T21:46:12.76385-07:00"}
{"level":"debug","msg":"\u003eReleasedir: errc=0","object":"/","objectType":"string","source":"cmount/fs.go:274","time":"2022-03-20T21:46:12.76385-07:00"}
{"level":"debug","msg":"Getattr: fh=0xFFFFFFFFFFFFFFFF","object":"/","objectType":"string","source":"cmount/fs.go:198","time":"2022-03-20T21:46:12.763949-07:00"}
{"level":"debug","msg":"\u003eGetattr: errc=0","object":"/","objectType":"string","source":"cmount/fs.go:203","time":"2022-03-20T21:46:12.763949-07:00"}
{"level":"debug","msg":"Getattr: fh=0xFFFFFFFFFFFFFFFF","object":"/","objectType":"string","source":"cmount/fs.go:198","time":"2022-03-20T21:46:12.763949-07:00"}
{"level":"debug","msg":"\u003eGetattr: errc=0","object":"/","objectType":"string","source":"cmount/fs.go:203","time":"2022-03-20T21:46:12.763949-07:00"}
{"level":"debug","msg":"Opendir: ","object":"/","objectType":"string","source":"cmount/fs.go:208","time":"2022-03-20T21:46:12.763949-07:00"}
{"level":"debug","msg":"OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx","object":"/","objectType":"string","source":"vfs/vfs.go:485","time":"2022-03-20T21:46:12.763949-07:00"}
{"level":"debug","msg":"\u003eOpenFile: fd=/ (r), err=\u003cnil\u003e","object":"/","objectType":"string","source":"vfs/vfs.go:509","time":"2022-03-20T21:46:12.763949-07:00"}
{"level":"debug","msg":"\u003eOpendir: errc=0, fh=0x0","object":"/","objectType":"string","source":"cmount/fs.go:213","time":"2022-03-20T21:46:12.763949-07:00"}
{"level":"debug","msg":"Releasedir: fh=0x0","object":"/","objectType":"string","source":"cmount/fs.go:273","time":"2022-03-20T21:46:12.763949-07:00"}
{"level":"debug","msg":"\u003eReleasedir: errc=0","object":"/","objectType":"string","source":"cmount/fs.go:274","time":"2022-03-20T21:46:12.763949-07:00"}
{"level":"debug","msg":"Getattr: fh=0xFFFFFFFFFFFFFFFF","object":"/","objectType":"string","source":"cmount/fs.go:198","time":"2022-03-20T21:46:12.763949-07:00"}
{"level":"debug","msg":"\u003eGetattr: errc=0","object":"/","objectType":"string","source":"cmount/fs.go:203","time":"2022-03-20T21:46:12.763949-07:00"}
{"level":"debug","msg":"Getattr: fh=0xFFFFFFFFFFFFFFFF","object":"/","objectType":"string","source":"cmount/fs.go:198","time":"2022-03-20T21:46:12.764468-07:00"}
{"level":"debug","msg":"\u003eGetattr: errc=0","object":"/","objectType":"string","source":"cmount/fs.go:203","time":"2022-03-20T21:46:12.764468-07:00"}
{"level":"debug","msg":"Opendir: ","object":"/","objectType":"string","source":"cmount/fs.go:208","time":"2022-03-20T21:46:12.764468-07:00"}
{"level":"debug","msg":"OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx","object":"/","objectType":"string","source":"vfs/vfs.go:485","time":"2022-03-20T21:46:12.764468-07:00"}
{"level":"debug","msg":"\u003eOpenFile: fd=/ (r), err=\u003cnil\u003e","object":"/","objectType":"string","source":"vfs/vfs.go:509","time":"2022-03-20T21:46:12.764468-07:00"}
{"level":"debug","msg":"\u003eOpendir: errc=0, fh=0x0","object":"/","objectType":"string","source":"cmount/fs.go:213","time":"2022-03-20T21:46:12.764468-07:00"}
{"level":"debug","msg":"Releasedir: fh=0x0","object":"/","objectType":"string","source":"cmount/fs.go:273","time":"2022-03-20T21:46:12.764468-07:00"}
{"level":"debug","msg":"\u003eReleasedir: errc=0","object":"/","objectType":"string","source":"cmount/fs.go:274","time":"2022-03-20T21:46:12.764468-07:00"}
{"level":"debug","msg":"Getattr: fh=0xFFFFFFFFFFFFFFFF","object":"/","objectType":"string","source":"cmount/fs.go:198","time":"2022-03-20T21:46:12.764468-07:00"}
{"level":"debug","msg":"\u003eGetattr: errc=0","object":"/","objectType":"string","source":"cmount/fs.go:203","time":"2022-03-20T21:46:12.764468-07:00"}
{"level":"debug","msg":"Getattr: fh=0xFFFFFFFFFFFFFFFF","object":"/","objectType":"string","source":"cmount/fs.go:198","time":"2022-03-20T21:46:12.764468-07:00"}
{"level":"debug","msg":"\u003eGetattr: errc=0","object":"/","objectType":"string","source":"cmount/fs.go:203","time":"2022-03-20T21:46:12.764468-07:00"}
{"level":"debug","msg":"Opendir: ","object":"/","objectType":"string","source":"cmount/fs.go:208","time":"2022-03-20T21:46:12.764468-07:00"}
{"level":"debug","msg":"OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx","object":"/","objectType":"string","source":"vfs/vfs.go:485","time":"2022-03-20T21:46:12.764468-07:00"}
{"level":"debug","msg":"\u003eOpenFile: fd=/ (r), err=\u003cnil\u003e","object":"/","objectType":"string","source":"vfs/vfs.go:509","time":"2022-03-20T21:46:12.764468-07:00"}
{"level":"debug","msg":"\u003eOpendir: errc=0, fh=0x0","object":"/","objectType":"string","source":"cmount/fs.go:213","time":"2022-03-20T21:46:12.764468-07:00"}
{"level":"debug","msg":"Releasedir: fh=0x0","object":"/","objectType":"string","source":"cmount/fs.go:273","time":"2022-03-20T21:46:12.764468-07:00"}
{"level":"debug","msg":"\u003eReleasedir: errc=0","object":"/","objectType":"string","source":"cmount/fs.go:274","time":"2022-03-20T21:46:12.764468-07:00"}
{"level":"debug","msg":"Getattr: fh=0xFFFFFFFFFFFFFFFF","object":"/","objectType":"string","source":"cmount/fs.go:198","time":"2022-03-20T21:46:12.76499-07:00"}
{"level":"debug","msg":"\u003eGetattr: errc=0","object":"/","objectType":"string","source":"cmount/fs.go:203","time":"2022-03-20T21:46:12.76499-07:00"}
{"level":"debug","msg":"Getattr: fh=0xFFFFFFFFFFFFFFFF","object":"/","objectType":"string","source":"cmount/fs.go:198","time":"2022-03-20T21:46:12.76499-07:00"}
{"level":"debug","msg":"\u003eGetattr: errc=0","object":"/","objectType":"string","source":"cmount/fs.go:203","time":"2022-03-20T21:46:12.76499-07:00"}
{"level":"debug","msg":"Opendir: ","object":"/","objectType":"string","source":"cmount/fs.go:208","time":"2022-03-20T21:46:12.76499-07:00"}
{"level":"debug","msg":"OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx","object":"/","objectType":"string","source":"vfs/vfs.go:485","time":"2022-03-20T21:46:12.76499-07:00"}
{"level":"debug","msg":"\u003eOpenFile: fd=/ (r), err=\u003cnil\u003e","object":"/","objectType":"string","source":"vfs/vfs.go:509","time":"2022-03-20T21:46:12.76499-07:00"}
{"level":"debug","msg":"\u003eOpendir: errc=0, fh=0x0","object":"/","objectType":"string","source":"cmount/fs.go:213","time":"2022-03-20T21:46:12.76499-07:00"}
{"level":"debug","msg":"Statfs: ","object":"/","objectType":"string","source":"cmount/fs.go:279","time":"2022-03-20T21:46:12.76499-07:00"}
{"level":"debug","msg":"\u003eStatfs: stat={Bsize:4096 Frsize:4096 Blocks:536870912 Bfree:364278310 Bavail:364278310 Files:1000000000 Ffree:1000000000 Favail:0 Fsid:0 Flag:0 Namemax:255}, errc=0","object":"/","objectType":"string","source":"cmount/fs.go:293","time":"2022-03-20T21:46:12.76499-07:00"}
{"level":"debug","msg":"Releasedir: fh=0x0","object":"/","objectType":"string","source":"cmount/fs.go:273","time":"2022-03-20T21:46:12.76499-07:00"}
{"level":"debug","msg":"\u003eReleasedir: errc=0","object":"/","objectType":"string","source":"cmount/fs.go:274","time":"2022-03-20T21:46:12.76499-07:00"}
{"level":"debug","msg":"Getattr: fh=0xFFFFFFFFFFFFFFFF","object":"/","objectType":"string","source":"cmount/fs.go:198","time":"2022-03-20T21:46:12.765508-07:00"}
{"level":"debug","msg":"\u003eGetattr: errc=0","object":"/","objectType":"string","source":"cmount/fs.go:203","time":"2022-03-20T21:46:12.765508-07:00"}
{"level":"debug","msg":"Getattr: fh=0xFFFFFFFFFFFFFFFF","object":"/","objectType":"string","source":"cmount/fs.go:198","time":"2022-03-20T21:46:12.765508-07:00"}
{"level":"debug","msg":"\u003eGetattr: errc=0","object":"/","objectType":"string","source":"cmount/fs.go:203","time":"2022-03-20T21:46:12.765508-07:00"}
{"level":"debug","msg":"Opendir: ","object":"/","objectType":"string","source":"cmount/fs.go:208","time":"2022-03-20T21:46:12.765508-07:00"}
{"level":"debug","msg":"OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx","object":"/","objectType":"string","source":"vfs/vfs.go:485","time":"2022-03-20T21:46:12.765508-07:00"}
{"level":"debug","msg":"\u003eOpenFile: fd=/ (r), err=\u003cnil\u003e","object":"/","objectType":"string","source":"vfs/vfs.go:509","time":"2022-03-20T21:46:12.765508-07:00"}
{"level":"debug","msg":"\u003eOpendir: errc=0, fh=0x0","object":"/","objectType":"string","source":"cmount/fs.go:213","time":"2022-03-20T21:46:12.765508-07:00"}
{"level":"debug","msg":"Readdir: ofst=0, fh=0x0","object":"/","objectType":"string","source":"cmount/fs.go:222","time":"2022-03-20T21:46:12.765508-07:00"}
{"level":"debug","msg":"\u003eReaddir: items=0, errc=0","object":"/","objectType":"string","source":"cmount/fs.go:268","time":"2022-03-20T21:46:12.977518-07:00"}
{"level":"debug","msg":"Releasedir: fh=0x0","object":"/","objectType":"string","source":"cmount/fs.go:273","time":"2022-03-20T21:46:12.978295-07:00"}
{"level":"debug","msg":"\u003eReleasedir: errc=0","object":"/","objectType":"string","source":"cmount/fs.go:274","time":"2022-03-20T21:46:12.978295-07:00"}
{"level":"debug","msg":"Checking for changes on remote","object":"Google drive root '00 - Rclone Backups'","objectType":"*drive.Fs","source":"drive/drive.go:2779","time":"2022-03-20T21:46:25.240146-07:00"}
{"level":"debug","msg":"Checking for changes on remote","object":"Google drive root '00 - Rclone Backups'","objectType":"*drive.Fs","source":"drive/drive.go:2779","time":"2022-03-20T21:47:25.242869-07:00"}

asdffdsa · March 21, 2022, 12:45pm

you are dealing with two issues and getting a little confusing for me to follow.
can we solve one issue as a time?

the rclone mount not working
the log issues.

that is normal behavior.
so the rclone mount is working now, correct?

jmg999 · March 21, 2022, 3:33pm

Sure, sorry about that. I think that the log file issue seems to be resolved now, however, since I ran the command w/ the "--use-json-log" flag.

In regard to the mounting issue, it accepted the command I issued, and the log noted that mounting was enabled, and the remote was mounted as drive D:. However, the drive does not appear in File Explorer. B/c everything appeared to be working correctly, I decided to run a few Google searches for this behavior, and I ended up watching a couple of YouTube videos.

I noticed that the command I was using to mount the remote wasn't the command most others were using. Therefore, I changed my command to the following:

rclone mount --vfs-cache-mode full GoogleDrive:"00 - Rclone Backups" D: --network-mode --log-file="C:\Users\xxxxx\AppData\Roaming\rclone\rclone_log.json" --use-json-log --log-level DEBUG

The results were the same as before. However, there was one difference between what happened when I ran the command and when those in the videos ran the command. As I explained earlier, the Command Prompt would hang when entering this command, and you stated that this was normal behavior. In the videos, after running this command, a return message of "The service rclone has been started" was printed to the screen. I only see that the service was started in the log file. Other than this discrepancy, I'm not seeing anything that would indicate why the D: drive isn't showing up in Explorer.

asdffdsa · March 21, 2022, 3:44pm

as i understand it, windows explorer runs non-elevated.
will not see the rclone mount run from an elevated prompt.

fwiw, i always run mount to a folder, never a drive letter.

jmg999 · March 21, 2022, 6:08pm

Aha! Running the command from a non-elevated prompt solved the problem. I still don't get the 'service started' return message, but Google Drive does mount to the D: drive, and it is visible in Explorer. However, I had placed two test directories in the remote path that I mounted, and neither are visible in Explorer. It shows as an empty directory.

asdffdsa · March 21, 2022, 6:18pm

pick one rclone mount command and post the debug log.

jmg999 · March 21, 2022, 6:37pm

Here's a link to the log file. It was too large to post to pastebin. It doesn't say anything about either test directory I'd created (Test Directory 01 or Test Directory 02), whereas when I was using a .txt log file, I found this in the log:

2022/03/20 10:05:16 DEBUG : Google drive root '00 - Rclone Backups': Checking for changes on remote
2022/03/20 10:05:17 DEBUG : : changeNotify: relativePath="Test Directory 01", type=0

asdffdsa · March 21, 2022, 6:39pm

oy, json output is very confusing to read.

jmg999 · March 21, 2022, 6:40pm

lol...agreed. I'm hoping that after we get this working properly, I can switch it back to text-based.

asdffdsa · March 21, 2022, 6:47pm

before now,
the rclone mount was working but there was confusion about running rclone mountwith non and privileged command prompts. i thought we solved that issue?

sorry, what issue are we working on now?

and use a text debug log.
no reason to use confusing, hard for humans to read, json.

jmg999 · March 22, 2022, 8:34am

I'm sorry, I changed the log from .txt to .json, b/c when you linked me to the use-json-log page earlier, I thought that you wanted me to use a .json log. I've now switched it back.

You were correct, we did solve both the mount w/ elevated vs. non-elevated Command Prompts. The problem I'm seeing now is that my remote is GoogleDrive:"00 - Rclone Backups" However, when rclone fires up w/ the following command:

rclone mount --vfs-cache-mode full GoogleDrive:"00 - Rclone Backups" D: --network-mode --log-file="C:\Users\xxxxx\AppData\Roaming\rclone\rclone_log.txt" --log-level DEBUG

The D: drive mounts and can be seen in Explorer. So far, so good. When I browse to the D: drive is where I run into the problem I'm currently troubleshooting. I had placed two test directories in my root directory: Test Directory 1 and Test Directory 2. When I browse to the D: drive in Explorer, it should list both of these directories, but instead, it shows an empty drive.

I go to Google Drive on the web, and I navigate to the 00 - Rclone Backups directory expecting to see my two test directories. Instead, I see both test directories plus another 00 - Rclone Backups directory. If I copy a file to the mounted Google Drive in Explorer, it uploads it to the directory of Google Drive/00 - Rclone Backups/00 - Rclone Backups, so this nested 00 - Rclone Backups directory is actually what's mounted, not the 00 - Rclone Backups directory on the root of Google Drive.

I figured that I might be able to delete this second-level 00 - Rclone Backups directory w/out causing a problem. I move this directory to the trash, and I try uploading another document via Explorer. The document shows up in Explorer, but it doesn't appear in Google Drive on the web. I checked the log, and the file appeared to upload. I tried this w/ another two documents, and the same behavior occurred, so I ran a search for one of the documents in Google Drive on the web. The document was found in the 00 - Rclone Backups directory that I had put in the trash.

I hope that I've explained this so that it's understandable. I don't know what to make of this behavior or why a file transfer via a mounted drive creates a nested root directory w/in the root directory specified in the configuration file.

asdffdsa · March 22, 2022, 12:48pm

start over.

--- delete that root dir and its subdirs,
--- delete the corresposing dirs/files from trash.
--- kill the mount, restart the mount
--- test

jmg999 · March 22, 2022, 8:17pm

I followed your instructions, and I was still running into the same problem, until it dawned upon me what I was doing incorrectly. If rclone was automatically creating a directory called 00 - Rclone Backups nested w/in the root directory on my remote, then I didn't need to create a root directory called 00 - Rclone Backups on the root of my remote. I removed the "root_folder_id" value from rclone.conf and deleted the root directory and all the subdirectories and documents, then emptied the trash. I re-ran mount, and rclone mounted 00 - Rclone Backups on D:, so I copied a file to that drive, and I checked Google Drive on the web. Rclone created the 00 - Rclone Backups directory on the root of Google Drive, and the file I copied was the only data contained w/in it.

I checked rclone.conf to see if it automatically populated the value for "root_folder_id," but it didn't. I checked the log, and there was the following message:

2022/03/22 12:48:23 DEBUG : Google drive root '00 - Rclone Backups': 'root_folder_id = 0AHRKL1DfxciiUk9PVA' - save this in the config to speed up startup

However, checking the "root_folder_id" of 00 - Rclone Backups on Google Drive on the web, it shows as: 1aKoyglmArCYu9-wxc2y4WgvUYq6sSFKX. So, I'm a bit confused as to where Rclone came up w/ the value it did in the log. Other than this, everything else seems to be working, so thank you so very much for sticking w/ me throughout this in order to help me understand how this setup worked!

Although, I do have one other question. My original intent for this setup was to be able to circumvent an issue I was experiencing w/ the Windows MAX_PATH maximum length for a path. For some reason, it wasn't playing nice, and trying to upload files to Google Drive took on the properties of how Windows was interpreting those files. Anyhow, Rclone seemed to be the perfect solution.

In the log, I've noticed:

2022/03/22 12:48:29 DEBUG : /: >Statfs: stat={Bsize:4096 Frsize:4096 Blocks:536870912 Bfree:365365951 Bavail:365365951 Files:1000000000 Ffree:1000000000 Favail:0 Fsid:0 Flag:0 Namemax:255}, errc=0

I'm assuming that this means that if I were to transfer files via the mounted drive, they would have to comply w/ the Windows 255 MAX_PATH structure. However, if I used the Rclone command line, I could bypass this limitation, and take advantage of the Google Drive max path. Is there a way to increase the "Namemax" value, so I can transfer data via the mounted drive?

asdffdsa · March 22, 2022, 8:25pm

yes, my instructions were designed to create a subliminal mental process to reset your brain's rclone thought process threads.
seems that it worked as i hoped

are you using a rclone crypt remote?

jmg999 · March 23, 2022, 4:57am

I really appreciate that about these forums. When people ask for help, you and others don't just come right out w/ the answers. You make us work for it, and by doing so, we'll end up learning how rclone really works in various environments.

I'm not using crypt remote. During initial config, I considered setting it up, but I wanted to make certain everything was working smoothly before adding extra layers into the fold. The odd thing about this difference between the values of the root directory IDs is that the running config currently has no value set for the root directory ID, yet it was still able to mount the directory I wanted to mount, and it's allowing the transfer of files.

The way I set this up, based on your recommendation to delete everything, and start over, was that the way Rclone was designed to work? In other words, during the initial config, I created the 00 - Rclone Backups directory via the Google Drive web interface, and I grabbed the ID and placed it in the config. That seemed like the only way to accomplish this. That's why I was so surprised by the behavior it's exhibiting now.

Unable to Test Connectivity to Google Drive or Properly Configure Log File

What is the problem you are having with rclone?

Run the command 'rclone version' and share the full output of the command.

The rclone config contents with secrets removed.

A log from the command with the -vv flag

A log from the command with the `-vv` flag