C:\Users\ghamos>rclone mount xyzdatablob: W: --config C:\Secrets\rclone.conf --vfs-cache-mode full -o GroupName="Authenticated Users" --dir-perms 0777 --file-perms 0777 -vv --debug-fuse
2022/04/12 15:46:07 DEBUG : rclone: Version "v1.58.0" starting with parameters ["C:\\ProgramData\\chocolatey\\lib\\rclone.portable\\tools\\rclone-v1.58.0-windows-amd64\\rclone.exe" "mount" "xyzdatablob:" "W:" "--config" "C:\\Secrets\\rclone.conf" "--vfs-cache-mode" "full" "-o" "GroupName=Authenticated Users" "--dir-perms" "0777" "--file-perms" "0777" "-vv" "--debug-fuse"]
2022/04/12 15:46:07 DEBUG : Creating backend with remote "xyzdatablob:"
2022/04/12 15:46:07 DEBUG : Using config file from "C:\\Secrets\\rclone.conf"
2022/04/12 15:46:07 INFO  : Azure root: poll-interval is not supported by this remote
2022/04/12 15:46:07 DEBUG : vfs cache: root is "C:\\Users\\ghamos\\AppData\\Local\\rclone"
2022/04/12 15:46:07 DEBUG : vfs cache: data root is "\\\\?\\C:\\Users\\ghamos\\AppData\\Local\\rclone\\vfs\\xyzdatablob"
2022/04/12 15:46:07 DEBUG : vfs cache: metadata root is "\\\\?\\C:\\Users\\ghamos\\AppData\\Local\\rclone\\vfsMeta\\xyzdatablob"
2022/04/12 15:46:07 DEBUG : Creating backend with remote "C:/Users/ghamos/AppData/Local/rclone/vfs/xyzdatablob/"
2022/04/12 15:46:07 DEBUG : fs cache: renaming cache item "C:/Users/ghamos/AppData/Local/rclone/vfs/xyzdatablob/" to be canonical "//?/C:/Users/ghamos/AppData/Local/rclone/vfs/xyzdatablob/"
2022/04/12 15:46:07 DEBUG : Creating backend with remote "C:/Users/ghamos/AppData/Local/rclone/vfsMeta/xyzdatablob/"
2022/04/12 15:46:07 DEBUG : fs cache: renaming cache item "C:/Users/ghamos/AppData/Local/rclone/vfsMeta/xyzdatablob/" to be canonical "//?/C:/Users/ghamos/AppData/Local/rclone/vfsMeta/xyzdatablob/"
2022/04/12 15:46:07 DEBUG : Network mode mounting is disabled
2022/04/12 15:46:07 DEBUG : Mounting on "W:" ("xyzdatablob")
2022/04/12 15:46:07 INFO  : vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0)
2022/04/12 15:46:07 DEBUG : Azure root: Mounting with options: ["-o" "attr_timeout=1" "-o" "debug" "-o" "uid=-1" "-o" "gid=-1" "--FileSystemName=rclone" "-o" "volname=xyzdatablob" "-o" "GroupName=Authenticated Users"]
2022/04/12 15:46:07 DEBUG : Azure root: Init:
2022/04/12 15:46:07 DEBUG : Azure root: >Init:
2022/04/12 15:46:07 DEBUG : /: Statfs:
2022/04/12 15:46:07 DEBUG : /: >Statfs: stat={Bsize:4096 Frsize:4096 Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Favail:0 Fsid:0 Flag:0 Namemax:255}, errc=0
2022/04/12 15:46:07 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:07 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:07 DEBUG : /: Readlink:
2022/04/12 15:46:07 DEBUG : /: >Readlink: linkPath="", errc=-40
The service rclone has been started.
rclone[TID=3a38]: FFFF9E86C2140DD0: >>QueryVolumeInformation
2022/04/12 15:46:07 DEBUG : /: Statfs:
2022/04/12 15:46:07 DEBUG : /: >Statfs: stat={Bsize:4096 Frsize:4096 Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Favail:0 Fsid:0 Flag:0 Namemax:255}, errc=0
rclone[TID=3a38]: FFFF9E86C2140DD0: <<QueryVolumeInformation IoStatus=0[0] VolumeInfo={TotalSize=40000:0, FreeSize=40000:0, VolumeLabel="xyzdatablob"}
rclone[TID=3a38]: FFFF9E86C8EF3DD0: >>Create [UT---C] "\", FILE_OPEN, CreateOptions=21, FileAttributes=10, Security=NULL, AllocationSize=0:0, AccessToken=00000000000003D4[PID=2ce4], DesiredAccess=100000, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:07 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:07 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:07 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:07 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:07 DEBUG : /: Opendir:
2022/04/12 15:46:07 DEBUG : /: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:07 DEBUG : /: >OpenFile: fd=/ (r), err=<nil>
2022/04/12 15:46:07 DEBUG : /: >Opendir: errc=0, fh=0x0
rclone[TID=3a38]: FFFF9E86C8EF3DD0: <<Create IoStatus=0[1] UserContext=0000000000000000:00000000031A54C0, GrantedAccess=100000, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-12T15:46:07.276Z, LastAccessTime=2022-04-12T15:46:07.276Z, LastWriteTime=2022-04-12T15:46:07.276Z, ChangeTime=2022-04-12T15:46:07.276Z, IndexNumber=0:1}
rclone[TID=3a38]: FFFF9E86C9937DD0: >>QuerySecurity 0000000000000000:00000000031A54C0
2022/04/12 15:46:07 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:07 DEBUG : /: >Getattr: errc=0
rclone[TID=3a38]: FFFF9E86C9937DD0: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=3a38]: FFFF9E86CEA6ADD0: >>Close 0000000000000000:00000000031A54C0
rclone[TID=24b4]: FFFF9E86C9937DD0: >>Create [UT---C] "\", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000003FC[PID=2ce4], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:07 DEBUG : /: Releasedir: fh=0x0
2022/04/12 15:46:07 DEBUG : /: >Releasedir: errc=0
rclone[TID=3a38]: FFFF9E86CEA6ADD0: <<Close IoStatus=0[0]
2022/04/12 15:46:07 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:07 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:07 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:07 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:07 DEBUG : /: Opendir:
2022/04/12 15:46:07 DEBUG : /: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:07 DEBUG : /: >OpenFile: fd=/ (r), err=<nil>
2022/04/12 15:46:07 DEBUG : /: >Opendir: errc=0, fh=0x0
rclone[TID=24b4]: FFFF9E86C9937DD0: <<Create IoStatus=0[1] UserContext=0000000000000000:00000000031A5310, GrantedAccess=80, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-12T15:46:07.276Z, LastAccessTime=2022-04-12T15:46:07.276Z, LastWriteTime=2022-04-12T15:46:07.276Z, ChangeTime=2022-04-12T15:46:07.276Z, IndexNumber=0:1}
rclone[TID=24b4]: FFFF9E86CC95E800: >>Close 0000000000000000:00000000031A5310
rclone[TID=3a38]: FFFF9E86C9937DD0: >>Create [UT---C] "\", FILE_OPEN, CreateOptions=21, FileAttributes=10, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000298[PID=2ce4], DesiredAccess=100000, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:07 DEBUG : /: Releasedir: fh=0x0
2022/04/12 15:46:07 DEBUG : /: >Releasedir: errc=0
rclone[TID=24b4]: FFFF9E86CC95E800: <<Close IoStatus=0[0]
2022/04/12 15:46:07 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:07 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:07 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:07 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:07 DEBUG : /: Opendir:
2022/04/12 15:46:07 DEBUG : /: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:07 DEBUG : /: >OpenFile: fd=/ (r), err=<nil>
2022/04/12 15:46:07 DEBUG : /: >Opendir: errc=0, fh=0x0
rclone[TID=3a38]: FFFF9E86C9937DD0: <<Create IoStatus=0[1] UserContext=0000000000000000:00000000031A5100, GrantedAccess=100000, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-12T15:46:07.276Z, LastAccessTime=2022-04-12T15:46:07.276Z, LastWriteTime=2022-04-12T15:46:07.276Z, ChangeTime=2022-04-12T15:46:07.276Z, IndexNumber=0:1}
rclone[TID=3a38]: FFFF9E86C9937DD0: >>QuerySecurity 0000000000000000:00000000031A5100
2022/04/12 15:46:07 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:07 DEBUG : /: >Getattr: errc=0
rclone[TID=3a38]: FFFF9E86C9937DD0: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=3a38]: FFFF9E86CB265DC0: >>Close 0000000000000000:00000000031A5100
2022/04/12 15:46:07 DEBUG : /: Releasedir: fh=0x0
2022/04/12 15:46:07 DEBUG : /: >Releasedir: errc=0
rclone[TID=3a38]: FFFF9E86CB265DC0: <<Close IoStatus=0[0]
rclone[TID=3a38]: FFFF9E86BD725E00: >>Create [UT---C] "\", FILE_OPEN, CreateOptions=21, FileAttributes=10, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000298[PID=2350], DesiredAccess=100000, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:17 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:17 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:17 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:17 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:17 DEBUG : /: Opendir:
2022/04/12 15:46:17 DEBUG : /: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:17 DEBUG : /: >OpenFile: fd=/ (r), err=<nil>
2022/04/12 15:46:17 DEBUG : /: >Opendir: errc=0, fh=0x0
rclone[TID=3a38]: FFFF9E86BD725E00: <<Create IoStatus=0[1] UserContext=0000000000000000:00000000031A4E90, GrantedAccess=100000, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-12T15:46:07.276Z, LastAccessTime=2022-04-12T15:46:07.276Z, LastWriteTime=2022-04-12T15:46:07.276Z, ChangeTime=2022-04-12T15:46:07.276Z, IndexNumber=0:1}
rclone[TID=3a38]: FFFF9E86BD725E00: >>QuerySecurity 0000000000000000:00000000031A4E90
2022/04/12 15:46:17 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:17 DEBUG : /: >Getattr: errc=0
rclone[TID=3a38]: FFFF9E86BD725E00: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=3a38]: FFFF9E86BD725E00: >>QueryVolumeInformation
2022/04/12 15:46:17 DEBUG : /: Statfs:
2022/04/12 15:46:17 DEBUG : /: >Statfs: stat={Bsize:4096 Frsize:4096 Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Favail:0 Fsid:0 Flag:0 Namemax:255}, errc=0
rclone[TID=3a38]: FFFF9E86BD725E00: <<QueryVolumeInformation IoStatus=0[0] VolumeInfo={TotalSize=40000:0, FreeSize=40000:0, VolumeLabel="xyzdatablob"}
rclone[TID=3a38]: FFFF9E86C17427F0: >>Close 0000000000000000:00000000031A4E90
2022/04/12 15:46:17 DEBUG : /: Releasedir: fh=0x0
2022/04/12 15:46:17 DEBUG : /: >Releasedir: errc=0
rclone[TID=3a38]: FFFF9E86C17427F0: <<Close IoStatus=0[0]
rclone[TID=3a38]: FFFF9E86CFED9DD0: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=20, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000298[PID=2350], DesiredAccess=100080, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:19 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:19 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:19 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:19 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:19 DEBUG : /test: Opendir:
2022/04/12 15:46:19 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:19 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:19 DEBUG : /test: >Opendir: errc=0, fh=0x0
rclone[TID=3a38]: FFFF9E86CFED9DD0: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FD10, GrantedAccess=100080, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
rclone[TID=3a38]: FFFF9E86C8EF3DD0: >>QuerySecurity 0000000000000000:000000000321FD10
2022/04/12 15:46:19 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:19 DEBUG : /test: >Getattr: errc=0
rclone[TID=3a38]: FFFF9E86C8EF3DD0: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=3a38]: FFFF9E86D0483DE0: >>Close 0000000000000000:000000000321FD10
rclone[TID=24b4]: FFFF9E86C8EF3DD0: >>Create [UT---C] "\test\desktop.ini", FILE_OPEN, CreateOptions=64, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000298[PID=2350], DesiredAccess=120089, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:19 DEBUG : /test: Releasedir: fh=0x0
2022/04/12 15:46:19 DEBUG : /test: >Releasedir: errc=0
rclone[TID=3a38]: FFFF9E86D0483DE0: <<Close IoStatus=0[0]
2022/04/12 15:46:19 DEBUG : /test/desktop.ini: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:19 DEBUG : /test/desktop.ini: >Getattr: errc=-2
rclone[TID=24b4]: FFFF9E86C8EF3DD0: <<Create IoStatus=c0000034[0]
rclone[TID=24b4]: FFFF9E86C69D7970: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000298[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:19 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:19 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:19 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:19 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:19 DEBUG : /test: Opendir:
2022/04/12 15:46:19 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:19 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:19 DEBUG : /test: >Opendir: errc=0, fh=0x0
rclone[TID=24b4]: FFFF9E86C69D7970: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321F8C0, GrantedAccess=80, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
rclone[TID=24b4]: FFFF9E86C8EF3DD0: >>Close 0000000000000000:000000000321F8C0
rclone[TID=3a38]: FFFF9E86D0483DE0: >>Create [UT---C] "\test\.git", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000694[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:19 DEBUG : /test: Releasedir: fh=0x0
2022/04/12 15:46:19 DEBUG : /test: >Releasedir: errc=0
rclone[TID=24b4]: FFFF9E86C8EF3DD0: <<Close IoStatus=0[0]
2022/04/12 15:46:19 DEBUG : /test/.git: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:19 DEBUG : /test/.git: >Getattr: errc=-2
rclone[TID=3a38]: FFFF9E86D0483DE0: <<Create IoStatus=c0000034[0]
rclone[TID=3a38]: FFFF9E86D0483DE0: >>Create [UT---C] "\test\HEAD", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000694[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:19 DEBUG : /test/HEAD: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:19 DEBUG : /test/HEAD: >Getattr: errc=-2
rclone[TID=3a38]: FFFF9E86D0483DE0: <<Create IoStatus=c0000034[0]
rclone[TID=3a38]: FFFF9E86D0483DE0: >>Create [UT---C] "\.git", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000694[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:19 DEBUG : /.git: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:19 DEBUG : /.git: >Getattr: errc=-2
rclone[TID=3a38]: FFFF9E86D0483DE0: <<Create IoStatus=c0000034[0]
rclone[TID=3a38]: FFFF9E86D0483DE0: >>Create [UT---C] "\HEAD", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000694[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:20 DEBUG : /HEAD: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:20 DEBUG : /HEAD: >Getattr: errc=-2
rclone[TID=3a38]: FFFF9E86D0483DE0: <<Create IoStatus=c0000034[0]
rclone[TID=3a38]: FFFF9E86D0483DE0: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000694[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:20 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:20 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:20 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:20 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:20 DEBUG : /test: Opendir:
2022/04/12 15:46:20 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:20 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:20 DEBUG : /test: >Opendir: errc=0, fh=0x0
rclone[TID=3a38]: FFFF9E86D0483DE0: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321F9B0, GrantedAccess=80, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
rclone[TID=3a38]: FFFF9E86C8EF3DD0: >>Close 0000000000000000:000000000321F9B0
rclone[TID=24b4]: FFFF9E86D0483DE0: >>Create [UT---C] "\test\.git", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000298[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:20 DEBUG : /test: Releasedir: fh=0x0
2022/04/12 15:46:20 DEBUG : /test: >Releasedir: errc=0
2022/04/12 15:46:20 DEBUG : /test/.git: Getattr: fh=0xFFFFFFFFFFFFFFFF
rclone[TID=3a38]: FFFF9E86C8EF3DD0: <<Close IoStatus=0[0]
2022/04/12 15:46:20 DEBUG : /test/.git: >Getattr: errc=-2
rclone[TID=24b4]: FFFF9E86D0483DE0: <<Create IoStatus=c0000034[0]
rclone[TID=24b4]: FFFF9E86D0483DE0: >>Create [UT---C] "\test\HEAD", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000298[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:20 DEBUG : /test/HEAD: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:20 DEBUG : /test/HEAD: >Getattr: errc=-2
rclone[TID=24b4]: FFFF9E86D0483DE0: <<Create IoStatus=c0000034[0]
rclone[TID=24b4]: FFFF9E86D0483DE0: >>Create [UT---C] "\.git", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000298[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:20 DEBUG : /.git: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:20 DEBUG : /.git: >Getattr: errc=-2
rclone[TID=24b4]: FFFF9E86D0483DE0: <<Create IoStatus=c0000034[0]
rclone[TID=24b4]: FFFF9E86D0483DE0: >>Create [UT---C] "\HEAD", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000298[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:20 DEBUG : /HEAD: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:20 DEBUG : /HEAD: >Getattr: errc=-2
rclone[TID=24b4]: FFFF9E86D0483DE0: <<Create IoStatus=c0000034[0]
rclone[TID=24b4]: FFFF9E86D0483DE0: >>Create [UT---C] "\test\HEAD", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000298[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:20 DEBUG : /test/HEAD: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:20 DEBUG : /test/HEAD: >Getattr: errc=-2
rclone[TID=24b4]: FFFF9E86D0483DE0: <<Create IoStatus=c0000034[0]
rclone[TID=24b4]: FFFF9E86C69D7970: >>Create [UT---C] "\", FILE_OPEN, CreateOptions=21, FileAttributes=10, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000298[PID=2350], DesiredAccess=100000, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:20 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:20 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:20 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:20 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:20 DEBUG : /: Opendir:
2022/04/12 15:46:20 DEBUG : /: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:20 DEBUG : /: >OpenFile: fd=/ (r), err=<nil>
2022/04/12 15:46:20 DEBUG : /: >Opendir: errc=0, fh=0x0
rclone[TID=24b4]: FFFF9E86C69D7970: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FE30, GrantedAccess=100000, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-12T15:46:07.276Z, LastAccessTime=2022-04-12T15:46:07.276Z, LastWriteTime=2022-04-12T15:46:07.276Z, ChangeTime=2022-04-12T15:46:07.276Z, IndexNumber=0:1}
rclone[TID=24b4]: FFFF9E86D0483DE0: >>QuerySecurity 0000000000000000:000000000321FE30
2022/04/12 15:46:20 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:20 DEBUG : /: >Getattr: errc=0
rclone[TID=24b4]: FFFF9E86D0483DE0: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=24b4]: FFFF9E86CBF52E00: >>Close 0000000000000000:000000000321FE30
rclone[TID=3a38]: FFFF9E86C6ACF950: >>Create [UT---C] "\", FILE_OPEN, CreateOptions=21, FileAttributes=10, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006A0[PID=2350], DesiredAccess=100000, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:20 DEBUG : /: Releasedir: fh=0x0
2022/04/12 15:46:20 DEBUG : /: >Releasedir: errc=0
2022/04/12 15:46:20 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:20 DEBUG : /: >Getattr: errc=0
rclone[TID=24b4]: FFFF9E86CBF52E00: <<Close IoStatus=0[0]
2022/04/12 15:46:20 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:20 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:20 DEBUG : /: Opendir:
2022/04/12 15:46:20 DEBUG : /: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:20 DEBUG : /: >OpenFile: fd=/ (r), err=<nil>
2022/04/12 15:46:20 DEBUG : /: >Opendir: errc=0, fh=0x0
rclone[TID=3a38]: FFFF9E86C6ACF950: <<Create IoStatus=0[1] UserContext=0000000000000000:00000000032203A0, GrantedAccess=100000, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-12T15:46:07.276Z, LastAccessTime=2022-04-12T15:46:07.276Z, LastWriteTime=2022-04-12T15:46:07.276Z, ChangeTime=2022-04-12T15:46:07.276Z, IndexNumber=0:1}
rclone[TID=3a38]: FFFF9E86C6ACF950: >>QuerySecurity 0000000000000000:00000000032203A0
2022/04/12 15:46:20 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:20 DEBUG : /: >Getattr: errc=0
rclone[TID=3a38]: FFFF9E86C6ACF950: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=3a38]: FFFF9E86C6ACF950: >>QueryVolumeInformation
2022/04/12 15:46:20 DEBUG : /: Statfs:
2022/04/12 15:46:20 DEBUG : /: >Statfs: stat={Bsize:4096 Frsize:4096 Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Favail:0 Fsid:0 Flag:0 Namemax:255}, errc=0
rclone[TID=3a38]: FFFF9E86C6ACF950: <<QueryVolumeInformation IoStatus=0[0] VolumeInfo={TotalSize=40000:0, FreeSize=40000:0, VolumeLabel="xyzdatablob"}
rclone[TID=3a38]: FFFF9E86C6FD6DE0: >>Close 0000000000000000:00000000032203A0
2022/04/12 15:46:20 DEBUG : /: Releasedir: fh=0x0
2022/04/12 15:46:20 DEBUG : /: >Releasedir: errc=0
rclone[TID=3a38]: FFFF9E86C6FD6DE0: <<Close IoStatus=0[0]
rclone[TID=3a38]: FFFF9E86C8EF3DD0: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=20, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006A0[PID=2350], DesiredAccess=100080, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:22 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:22 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:22 DEBUG : /test: Opendir:
2022/04/12 15:46:22 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:22 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:22 DEBUG : /test: >Opendir: errc=0, fh=0x0
rclone[TID=3a38]: FFFF9E86C8EF3DD0: <<Create IoStatus=0[1] UserContext=0000000000000000:00000000032201F0, GrantedAccess=100080, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
rclone[TID=3a38]: FFFF9E86CFED9DD0: >>QuerySecurity 0000000000000000:00000000032201F0
2022/04/12 15:46:22 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test: >Getattr: errc=0
rclone[TID=3a38]: FFFF9E86CFED9DD0: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=3a38]: FFFF9E86D0483DE0: >>Close 0000000000000000:00000000032201F0
2022/04/12 15:46:22 DEBUG : /test: Releasedir: fh=0x0
2022/04/12 15:46:22 DEBUG : /test: >Releasedir: errc=0
rclone[TID=3a38]: FFFF9E86D0483DE0: <<Close IoStatus=0[0]
rclone[TID=24b4]: FFFF9E86C2B49AF0: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=20, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000298[PID=2350], DesiredAccess=100080, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:22 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:22 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:22 DEBUG : /test: Opendir:
2022/04/12 15:46:22 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:22 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:22 DEBUG : /test: >Opendir: errc=0, fh=0x0
rclone[TID=24b4]: FFFF9E86C2B49AF0: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FC50, GrantedAccess=100080, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
rclone[TID=24b4]: FFFF9E86CFED9DD0: >>QuerySecurity 0000000000000000:000000000321FC50
2022/04/12 15:46:22 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test: >Getattr: errc=0
rclone[TID=24b4]: FFFF9E86CFED9DD0: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=24b4]: FFFF9E86C8EF3DD0: >>Close 0000000000000000:000000000321FC50
2022/04/12 15:46:22 DEBUG : /test: Releasedir: fh=0x0
rclone[TID=3a38]: FFFF9E86D0483DE0: >>Create [UT---C] "\test\desktop.ini", FILE_OPEN, CreateOptions=64, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006A0[PID=2350], DesiredAccess=120089, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:22 DEBUG : /test: >Releasedir: errc=0
rclone[TID=24b4]: FFFF9E86C8EF3DD0: <<Close IoStatus=0[0]
2022/04/12 15:46:22 DEBUG : /test/desktop.ini: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test/desktop.ini: >Getattr: errc=-2
rclone[TID=3a38]: FFFF9E86D0483DE0: <<Create IoStatus=c0000034[0]
rclone[TID=3a38]: FFFF9E86C69D7970: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006A0[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:22 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:22 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:22 DEBUG : /test: Opendir:
2022/04/12 15:46:22 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:22 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:22 DEBUG : /test: >Opendir: errc=0, fh=0x0
rclone[TID=3a38]: FFFF9E86C69D7970: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FC50, GrantedAccess=80, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
rclone[TID=3a38]: FFFF9E86C8EF3DD0: >>Close 0000000000000000:000000000321FC50
rclone[TID=24b4]: FFFF9E86D0483DE0: >>Create [UT---C] "\test\.git", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000298[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:22 DEBUG : /test: Releasedir: fh=0x0
2022/04/12 15:46:22 DEBUG : /test: >Releasedir: errc=0
rclone[TID=3a38]: FFFF9E86C8EF3DD0: <<Close IoStatus=0[0]
2022/04/12 15:46:22 DEBUG : /test/.git: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test/.git: >Getattr: errc=-2
rclone[TID=24b4]: FFFF9E86D0483DE0: <<Create IoStatus=c0000034[0]
rclone[TID=24b4]: FFFF9E86D0483DE0: >>Create [UT---C] "\test\HEAD", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000298[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:22 DEBUG : /test/HEAD: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test/HEAD: >Getattr: errc=-2
rclone[TID=24b4]: FFFF9E86D0483DE0: <<Create IoStatus=c0000034[0]
rclone[TID=24b4]: FFFF9E86D0483DE0: >>Create [UT---C] "\.git", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000298[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:22 DEBUG : /.git: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /.git: >Getattr: errc=-2
rclone[TID=24b4]: FFFF9E86D0483DE0: <<Create IoStatus=c0000034[0]
rclone[TID=24b4]: FFFF9E86D0483DE0: >>Create [UT---C] "\HEAD", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000298[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:22 DEBUG : /HEAD: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /HEAD: >Getattr: errc=-2
rclone[TID=24b4]: FFFF9E86D0483DE0: <<Create IoStatus=c0000034[0]
rclone[TID=24b4]: FFFF9E86D0483DE0: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000298[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:22 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:22 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:22 DEBUG : /test: Opendir:
2022/04/12 15:46:22 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:22 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:22 DEBUG : /test: >Opendir: errc=0, fh=0x0
rclone[TID=24b4]: FFFF9E86D0483DE0: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FD70, GrantedAccess=80, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
rclone[TID=24b4]: FFFF9E86C8EF3DD0: >>Close 0000000000000000:000000000321FD70
rclone[TID=3a38]: FFFF9E86D0483DE0: >>Create [UT---C] "\test\.git", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006A0[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:22 DEBUG : /test: Releasedir: fh=0x0
2022/04/12 15:46:22 DEBUG : /test: >Releasedir: errc=0
rclone[TID=24b4]: FFFF9E86C8EF3DD0: <<Close IoStatus=0[0]
2022/04/12 15:46:22 DEBUG : /test/.git: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test/.git: >Getattr: errc=-2
rclone[TID=3a38]: FFFF9E86D0483DE0: <<Create IoStatus=c0000034[0]
rclone[TID=3a38]: FFFF9E86D0483DE0: >>Create [UT---C] "\test\HEAD", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006A0[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:22 DEBUG : /test/HEAD: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test/HEAD: >Getattr: errc=-2
rclone[TID=3a38]: FFFF9E86D0483DE0: <<Create IoStatus=c0000034[0]
rclone[TID=3a38]: FFFF9E86D0483DE0: >>Create [UT---C] "\.git", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006A0[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:22 DEBUG : /.git: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /.git: >Getattr: errc=-2
rclone[TID=3a38]: FFFF9E86D0483DE0: <<Create IoStatus=c0000034[0]
rclone[TID=3a38]: FFFF9E86D0483DE0: >>Create [UT---C] "\HEAD", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006A0[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:22 DEBUG : /HEAD: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /HEAD: >Getattr: errc=-2
rclone[TID=3a38]: FFFF9E86D0483DE0: <<Create IoStatus=c0000034[0]
rclone[TID=3a38]: FFFF9E86D0483DE0: >>Create [UT---C] "\test\HEAD", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006A0[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:22 DEBUG : /test/HEAD: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test/HEAD: >Getattr: errc=-2
rclone[TID=3a38]: FFFF9E86D0483DE0: <<Create IoStatus=c0000034[0]
rclone[TID=3a38]: FFFF9E86C69D7970: >>Create [UT---C] "\test", FILE_CREATE, CreateOptions=200021, FileAttributes=10, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006A0[PID=2350], DesiredAccess=100001, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:22 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:22 DEBUG : /test: Mkdir: mode=0770
2022/04/12 15:46:22 DEBUG : /test: >Mkdir: errc=0
2022/04/12 15:46:22 DEBUG : /test: Opendir:
2022/04/12 15:46:22 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:22 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:22 DEBUG : /test: >Opendir: errc=0, fh=0x0
2022/04/12 15:46:22 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test: >Getattr: errc=0
rclone[TID=3a38]: FFFF9E86C69D7970: <<Create IoStatus=0[2] UserContext=0000000000000000:000000000321F9B0, GrantedAccess=100001, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
rclone[TID=3a38]: FFFF9E86D0483DE0: >>QuerySecurity 0000000000000000:000000000321F9B0
2022/04/12 15:46:22 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test: >Getattr: errc=0
rclone[TID=3a38]: FFFF9E86D0483DE0: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=3a38]: FFFF9E86C8EF3DD0: >>Close 0000000000000000:000000000321F9B0
2022/04/12 15:46:22 DEBUG : /test: Releasedir: fh=0x0
2022/04/12 15:46:22 DEBUG : /test: >Releasedir: errc=0
rclone[TID=3a38]: FFFF9E86C8EF3DD0: <<Close IoStatus=0[0]
rclone[TID=3a38]: FFFF9E86C6BC59B0: >>Create [UT---C] "\", FILE_OPEN, CreateOptions=20, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006A0[PID=2350], DesiredAccess=120089, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:22 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:22 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:22 DEBUG : /: Opendir:
2022/04/12 15:46:22 DEBUG : /: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:22 DEBUG : /: >OpenFile: fd=/ (r), err=<nil>
2022/04/12 15:46:22 DEBUG : /: >Opendir: errc=0, fh=0x0
rclone[TID=3a38]: FFFF9E86C6BC59B0: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FAA0, GrantedAccess=120089, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-12T15:46:07.276Z, LastAccessTime=2022-04-12T15:46:07.276Z, LastWriteTime=2022-04-12T15:46:07.276Z, ChangeTime=2022-04-12T15:46:07.276Z, IndexNumber=0:1}
rclone[TID=3a38]: FFFF9E86D0483DE0: >>QuerySecurity 0000000000000000:000000000321FAA0
2022/04/12 15:46:22 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /: >Getattr: errc=0
rclone[TID=3a38]: FFFF9E86D0483DE0: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=3a38]: FFFF9E86D0483DE0: >>QueryVolumeInformation
2022/04/12 15:46:22 DEBUG : /: Statfs:
2022/04/12 15:46:22 DEBUG : /: >Statfs: stat={Bsize:4096 Frsize:4096 Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Favail:0 Fsid:0 Flag:0 Namemax:255}, errc=0
rclone[TID=3a38]: FFFF9E86D0483DE0: <<QueryVolumeInformation IoStatus=0[0] VolumeInfo={TotalSize=40000:0, FreeSize=40000:0, VolumeLabel="xyzdatablob"}
rclone[TID=3a38]: FFFF9E86C2140DD0: >>Close 0000000000000000:000000000321FAA0
rclone[TID=24b4]: FFFF9E86C6BC59B0: >>Create [UT---C] "\", FILE_OPEN, CreateOptions=20, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000298[PID=2350], DesiredAccess=100081, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:22 DEBUG : /: Releasedir: fh=0x0
2022/04/12 15:46:22 DEBUG : /: >Releasedir: errc=0
rclone[TID=3a38]: FFFF9E86C2140DD0: <<Close IoStatus=0[0]
2022/04/12 15:46:22 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:22 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:22 DEBUG : /: Opendir:
2022/04/12 15:46:22 DEBUG : /: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:22 DEBUG : /: >OpenFile: fd=/ (r), err=<nil>
2022/04/12 15:46:22 DEBUG : /: >Opendir: errc=0, fh=0x0
rclone[TID=24b4]: FFFF9E86C6BC59B0: <<Create IoStatus=0[1] UserContext=0000000000000000:0000000003220220, GrantedAccess=100081, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-12T15:46:07.276Z, LastAccessTime=2022-04-12T15:46:07.276Z, LastWriteTime=2022-04-12T15:46:07.276Z, ChangeTime=2022-04-12T15:46:07.276Z, IndexNumber=0:1}
rclone[TID=24b4]: FFFF9E86CC94E060: >>QuerySecurity 0000000000000000:0000000003220220
2022/04/12 15:46:22 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /: >Getattr: errc=0
rclone[TID=24b4]: FFFF9E86CC94E060: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=24b4]: FFFF9E86CC94E060: >>QueryDirectory 0000000000000000:0000000003220220, Address=000000002BE30000, Length=16368, Pattern=NULL, Marker=NULL
2022/04/12 15:46:22 DEBUG : /: Readdir: ofst=0, fh=0x0
2022/04/12 15:46:22 DEBUG : /: >Readdir: items=15, errc=0
rclone[TID=24b4]: FFFF9E86CC94E060: <<QueryDirectory IoStatus=0[1866]
rclone[TID=24b4]: FFFF9E86C2140DD0: >>Close 0000000000000000:0000000003220220
rclone[TID=3a38]: FFFF9E86CC94E060: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=20, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006A8[PID=2350], DesiredAccess=100080, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:22 DEBUG : /: Releasedir: fh=0x0
2022/04/12 15:46:22 DEBUG : /: >Releasedir: errc=0
rclone[TID=24b4]: FFFF9E86C2140DD0: <<Close IoStatus=0[0]
2022/04/12 15:46:22 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:22 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:22 DEBUG : /test: Opendir:
2022/04/12 15:46:22 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:22 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:22 DEBUG : /test: >Opendir: errc=0, fh=0x0
rclone[TID=3a38]: FFFF9E86CC94E060: <<Create IoStatus=0[1] UserContext=0000000000000000:0000000003220430, GrantedAccess=100080, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
rclone[TID=3a38]: FFFF9E86CC94E060: >>QuerySecurity 0000000000000000:0000000003220430
2022/04/12 15:46:22 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test: >Getattr: errc=0
rclone[TID=3a38]: FFFF9E86CC94E060: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=3a38]: FFFF9E86D0483DE0: >>Close 0000000000000000:0000000003220430
2022/04/12 15:46:22 DEBUG : /test: Releasedir: fh=0x0
2022/04/12 15:46:22 DEBUG : /test: >Releasedir: errc=0
rclone[TID=3a38]: FFFF9E86D0483DE0: <<Close IoStatus=0[0]
rclone[TID=24b4]: FFFF9E86CC94E060: >>Create [UT---C] "\test\testfile", FILE_CREATE, CreateOptions=44, FileAttributes=20, Security=NULL, AllocationSize=0:1825000, AccessToken=0000000000000298[PID=2350], DesiredAccess=17019f, GrantedAccess=0, ShareAccess=0
2022/04/12 15:46:22 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:22 DEBUG : /test/testfile: CreateEx: flags=0x502, mode=0770
2022/04/12 15:46:22 DEBUG : test/testfile: Open: flags=O_RDWR|O_CREATE|O_EXCL
2022/04/12 15:46:22 DEBUG : test/testfile: newRWFileHandle:
2022/04/12 15:46:22 DEBUG : test/testfile(0xc000c1a080): openPending:
2022/04/12 15:46:22 DEBUG : test/testfile: vfs cache: truncate to size=0
2022/04/12 15:46:22 DEBUG : test: Added virtual directory entry vAddFile: "testfile"
2022/04/12 15:46:22 DEBUG : test/testfile(0xc000c1a080): >openPending: err=<nil>
2022/04/12 15:46:22 DEBUG : test/testfile: >newRWFileHandle: err=<nil>
2022/04/12 15:46:22 DEBUG : test: Added virtual directory entry vAddFile: "testfile"
2022/04/12 15:46:22 DEBUG : test/testfile: >Open: fd=test/testfile (rw), err=<nil>
2022/04/12 15:46:22 DEBUG : /test/testfile: >CreateEx: errc=0, fh=0x0
2022/04/12 15:46:22 DEBUG : /test/testfile: Release: fh=0x0
2022/04/12 15:46:22 DEBUG : test/testfile(0xc000c1a080): RWFileHandle.Release
2022/04/12 15:46:22 DEBUG : test/testfile(0xc000c1a080): close:
2022/04/12 15:46:22 DEBUG : test/testfile: vfs cache: setting modification time to 2022-04-12 15:46:22.8018157 +0000 GMT m=+18.086083401
2022/04/12 15:46:22 INFO  : test/testfile: vfs cache: queuing for upload in 5s
2022/04/12 15:46:22 DEBUG : test/testfile(0xc000c1a080): >close: err=<nil>
2022/04/12 15:46:22 DEBUG : /test/testfile: >Release: errc=0
rclone[TID=24b4]: FFFF9E86CC94E060: <<Create IoStatus=c0000010[0]
rclone[TID=24b4]: FFFF9E86CC94E060: >>Create [UT---C] "\test\testfile", FILE_CREATE, CreateOptions=44, FileAttributes=20, Security=NULL, AllocationSize=0:1825000, AccessToken=0000000000000298[PID=2350], DesiredAccess=170197, GrantedAccess=0, ShareAccess=0
2022/04/12 15:46:22 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:22 DEBUG : /test/testfile: CreateEx: flags=0x502, mode=0770
2022/04/12 15:46:22 DEBUG : test/testfile: Open: flags=O_RDWR|O_CREATE|O_EXCL
2022/04/12 15:46:22 DEBUG : test/testfile: newRWFileHandle:
2022/04/12 15:46:22 DEBUG : test/testfile: >newRWFileHandle: err=file already exists
2022/04/12 15:46:22 DEBUG : test/testfile: File.openRW failed: file already exists
2022/04/12 15:46:22 DEBUG : test/testfile: >Open: fd=<nil *RWFileHandle>, err=file already exists
2022/04/12 15:46:22 DEBUG : /test/testfile: >CreateEx: errc=-17, fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test/testfile: >Getattr: errc=0
rclone[TID=24b4]: FFFF9E86CC94E060: <<Create IoStatus=c0000035[0]
rclone[TID=24b4]: FFFF9E86CC94E060: >>Create [UT---C] "\test\testfile", FILE_CREATE, CreateOptions=44, FileAttributes=20, Security=NULL, AllocationSize=0:1825000, AccessToken=0000000000000298[PID=2350], DesiredAccess=170196, GrantedAccess=0, ShareAccess=0
2022/04/12 15:46:22 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:22 DEBUG : /test/testfile: CreateEx: flags=0x502, mode=0770
2022/04/12 15:46:22 DEBUG : test/testfile: Open: flags=O_RDWR|O_CREATE|O_EXCL
2022/04/12 15:46:22 DEBUG : test/testfile: newRWFileHandle:
2022/04/12 15:46:22 DEBUG : test/testfile: >newRWFileHandle: err=file already exists
2022/04/12 15:46:22 DEBUG : test/testfile: File.openRW failed: file already exists
2022/04/12 15:46:22 DEBUG : test/testfile: >Open: fd=<nil *RWFileHandle>, err=file already exists
2022/04/12 15:46:22 DEBUG : /test/testfile: >CreateEx: errc=-17, fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test/testfile: >Getattr: errc=0
rclone[TID=24b4]: FFFF9E86CC94E060: <<Create IoStatus=c0000035[0]
rclone[TID=24b4]: FFFF9E86CC94E060: >>Create [UT---C] "\test\testfile", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000298[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:22 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test/testfile: >Getattr: errc=0
2022/04/12 15:46:22 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test/testfile: >Getattr: errc=0
2022/04/12 15:46:22 DEBUG : /test/testfile: OpenEx: flags=0x0
2022/04/12 15:46:22 DEBUG : /test/testfile: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:22 DEBUG : test/testfile: Open: flags=O_RDONLY
2022/04/12 15:46:22 DEBUG : test/testfile: newRWFileHandle:
2022/04/12 15:46:22 DEBUG : test/testfile: >newRWFileHandle: err=<nil>
2022/04/12 15:46:22 DEBUG : test/testfile: >Open: fd=test/testfile (rw), err=<nil>
2022/04/12 15:46:22 DEBUG : /test/testfile: >OpenFile: fd=test/testfile (rw), err=<nil>
2022/04/12 15:46:22 DEBUG : /test/testfile: >OpenEx: errc=0, fh=0x0
rclone[TID=24b4]: FFFF9E86CC94E060: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FEF0, GrantedAccess=80, FileInfo={FileAttributes=0, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-12T15:46:22.801Z, LastAccessTime=2022-04-12T15:46:22.801Z, LastWriteTime=2022-04-12T15:46:22.801Z, ChangeTime=2022-04-12T15:46:22.801Z, IndexNumber=0:11}
rclone[TID=24b4]: FFFF9E86D0483DE0: >>Close 0000000000000000:000000000321FEF0
rclone[TID=3a38]: FFFF9E86CC94E060: >>Create [UT---C] "\test\testfile", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=000000000000069C[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:22 DEBUG : /test/testfile: Flush: fh=0x0
2022/04/12 15:46:22 DEBUG : test/testfile(0xc000c1a1c0): RWFileHandle.Flush
2022/04/12 15:46:22 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test/testfile: >Flush: errc=0
2022/04/12 15:46:22 DEBUG : /test/testfile: >Getattr: errc=0
2022/04/12 15:46:22 DEBUG : /test/testfile: Release: fh=0x0
2022/04/12 15:46:22 DEBUG : test/testfile(0xc000c1a1c0): RWFileHandle.Release
2022/04/12 15:46:22 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : test/testfile(0xc000c1a1c0): close:
2022/04/12 15:46:22 DEBUG : test/testfile(0xc000c1a1c0): >close: err=<nil>
2022/04/12 15:46:22 DEBUG : /test/testfile: >Release: errc=0
rclone[TID=24b4]: FFFF9E86D0483DE0: <<Close IoStatus=0[0]
2022/04/12 15:46:22 DEBUG : /test/testfile: >Getattr: errc=0
2022/04/12 15:46:22 DEBUG : /test/testfile: OpenEx: flags=0x0
2022/04/12 15:46:22 DEBUG : /test/testfile: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:22 DEBUG : test/testfile: Open: flags=O_RDONLY
2022/04/12 15:46:22 DEBUG : test/testfile: newRWFileHandle:
2022/04/12 15:46:22 DEBUG : test/testfile: >newRWFileHandle: err=<nil>
2022/04/12 15:46:22 DEBUG : test/testfile: >Open: fd=test/testfile (rw), err=<nil>
2022/04/12 15:46:22 DEBUG : /test/testfile: >OpenFile: fd=test/testfile (rw), err=<nil>
2022/04/12 15:46:22 DEBUG : /test/testfile: >OpenEx: errc=0, fh=0x0
rclone[TID=3a38]: FFFF9E86CC94E060: <<Create IoStatus=0[1] UserContext=0000000000000000:0000000003220280, GrantedAccess=80, FileInfo={FileAttributes=0, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-12T15:46:22.801Z, LastAccessTime=2022-04-12T15:46:22.801Z, LastWriteTime=2022-04-12T15:46:22.801Z, ChangeTime=2022-04-12T15:46:22.801Z, IndexNumber=0:11}
rclone[TID=3a38]: FFFF9E86D0483DE0: >>Close 0000000000000000:0000000003220280
rclone[TID=24b4]: FFFF9E86CC94E060: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=20, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000298[PID=2350], DesiredAccess=100081, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:22 DEBUG : /test/testfile: Flush: fh=0x0
2022/04/12 15:46:22 DEBUG : test/testfile(0xc00099f240): RWFileHandle.Flush
2022/04/12 15:46:22 DEBUG : /test/testfile: >Flush: errc=0
2022/04/12 15:46:22 DEBUG : /test/testfile: Release: fh=0x0
2022/04/12 15:46:22 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : test/testfile(0xc00099f240): RWFileHandle.Release
2022/04/12 15:46:22 DEBUG : test/testfile(0xc00099f240): close:
2022/04/12 15:46:22 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:22 DEBUG : test/testfile(0xc00099f240): >close: err=<nil>
2022/04/12 15:46:22 DEBUG : /test/testfile: >Release: errc=0
rclone[TID=3a38]: FFFF9E86D0483DE0: <<Close IoStatus=0[0]
2022/04/12 15:46:22 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:22 DEBUG : /test: Opendir:
2022/04/12 15:46:22 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:22 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:22 DEBUG : /test: >Opendir: errc=0, fh=0x0
rclone[TID=24b4]: FFFF9E86CC94E060: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FFB0, GrantedAccess=100081, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
rclone[TID=24b4]: FFFF9E86CC94E060: >>QuerySecurity 0000000000000000:000000000321FFB0
2022/04/12 15:46:22 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test: >Getattr: errc=0
rclone[TID=24b4]: FFFF9E86CC94E060: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=24b4]: FFFF9E86CC94E060: >>QueryDirectory 0000000000000000:000000000321FFB0, Address=000000002BE30000, Length=616, Pattern="testfile", Marker=NULL
2022/04/12 15:46:22 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test/testfile: >Getattr: errc=0
rclone[TID=24b4]: FFFF9E86CC94E060: <<QueryDirectory IoStatus=0[122]
rclone[TID=24b4]: FFFF9E86D0483DE0: >>Close 0000000000000000:000000000321FFB0
rclone[TID=3a38]: FFFF9E86CC94E060: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=20, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=000000000000069C[PID=2350], DesiredAccess=100081, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:22 DEBUG : /test: Releasedir: fh=0x0
2022/04/12 15:46:22 DEBUG : /test: >Releasedir: errc=0
2022/04/12 15:46:22 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test: >Getattr: errc=0
rclone[TID=24b4]: FFFF9E86D0483DE0: <<Close IoStatus=0[0]
2022/04/12 15:46:22 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:22 DEBUG : /test: Opendir:
2022/04/12 15:46:22 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:22 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:22 DEBUG : /test: >Opendir: errc=0, fh=0x0
rclone[TID=3a38]: FFFF9E86CC94E060: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FA40, GrantedAccess=100081, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
rclone[TID=3a38]: FFFF9E86CC94E060: >>QuerySecurity 0000000000000000:000000000321FA40
2022/04/12 15:46:22 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test: >Getattr: errc=0
rclone[TID=3a38]: FFFF9E86CC94E060: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=3a38]: FFFF9E86CC94E060: >>QueryDirectory 0000000000000000:000000000321FA40, Address=000000002BE30000, Length=616, Pattern="testfile", Marker=NULL
2022/04/12 15:46:22 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test/testfile: >Getattr: errc=0
rclone[TID=3a38]: FFFF9E86CC94E060: <<QueryDirectory IoStatus=0[122]
rclone[TID=3a38]: FFFF9E86D0483DE0: >>Close 0000000000000000:000000000321FA40
2022/04/12 15:46:22 DEBUG : /test: Releasedir: fh=0x0
rclone[TID=24b4]: FFFF9E86CC94E060: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=20, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=000000000000069C[PID=2350], DesiredAccess=100081, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:22 DEBUG : /test: >Releasedir: errc=0
rclone[TID=3a38]: FFFF9E86D0483DE0: <<Close IoStatus=0[0]
2022/04/12 15:46:22 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:22 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:22 DEBUG : /test: Opendir:
2022/04/12 15:46:22 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:22 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:22 DEBUG : /test: >Opendir: errc=0, fh=0x0
rclone[TID=24b4]: FFFF9E86CC94E060: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FAA0, GrantedAccess=100081, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
rclone[TID=24b4]: FFFF9E86CC94E060: >>QuerySecurity 0000000000000000:000000000321FAA0
2022/04/12 15:46:22 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test: >Getattr: errc=0
rclone[TID=24b4]: FFFF9E86CC94E060: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=24b4]: FFFF9E86CC94E060: >>QueryDirectory 0000000000000000:000000000321FAA0, Address=000000002BE30000, Length=616, Pattern="testfile", Marker=NULL
2022/04/12 15:46:22 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test/testfile: >Getattr: errc=0
rclone[TID=24b4]: FFFF9E86CC94E060: <<QueryDirectory IoStatus=0[122]
rclone[TID=24b4]: FFFF9E86D0483DE0: >>Close 0000000000000000:000000000321FAA0
2022/04/12 15:46:22 DEBUG : /test: Releasedir: fh=0x0
2022/04/12 15:46:22 DEBUG : /test: >Releasedir: errc=0
rclone[TID=24b4]: FFFF9E86D0483DE0: <<Close IoStatus=0[0]
rclone[TID=3a38]: FFFF9E86CC94E060: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=0, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000298[PID=2350], DesiredAccess=100081, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:22 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:22 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:22 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:22 DEBUG : /test: Opendir:
2022/04/12 15:46:22 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:22 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:22 DEBUG : /test: >Opendir: errc=0, fh=0x0
rclone[TID=3a38]: FFFF9E86CC94E060: <<Create IoStatus=0[1] UserContext=0000000000000000:00000000032201F0, GrantedAccess=100081, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
rclone[TID=3a38]: FFFF9E86CC94E060: >>QuerySecurity 0000000000000000:00000000032201F0
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
rclone[TID=3a38]: FFFF9E86CC94E060: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=3a38]: FFFF9E86D0483DE0: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=0, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000298[PID=2350], DesiredAccess=100081, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test: Opendir:
2022/04/12 15:46:23 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:23 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:23 DEBUG : /test: >Opendir: errc=0, fh=0x1
rclone[TID=3a38]: FFFF9E86D0483DE0: <<Create IoStatus=0[1] UserContext=0000000000000000:0000000003220370, GrantedAccess=100081, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
rclone[TID=3a38]: FFFF9E86D0428DD0: >>Close 0000000000000000:00000000032201F0
rclone[TID=24b4]: FFFF9E86CC94E060: >>Close 0000000000000000:0000000003220370
2022/04/12 15:46:23 DEBUG : /test: Releasedir: fh=0x0
rclone[TID=2dfc]: FFFF9E86C6BC59B0: >>Create [UT---C] "\test\testfile", FILE_CREATE, CreateOptions=44, FileAttributes=20, Security=NULL, AllocationSize=0:1825000, AccessToken=00000000000006A0[PID=2350], DesiredAccess=17019f, GrantedAccess=0, ShareAccess=0
2022/04/12 15:46:23 DEBUG : /test: >Releasedir: errc=0
rclone[TID=3a38]: FFFF9E86D0428DD0: <<Close IoStatus=0[0]
2022/04/12 15:46:23 DEBUG : /test: Releasedir: fh=0x1
2022/04/12 15:46:23 DEBUG : /test: >Releasedir: errc=0
rclone[TID=24b4]: FFFF9E86CC94E060: <<Close IoStatus=0[0]
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test/testfile: CreateEx: flags=0x502, mode=0770
2022/04/12 15:46:23 DEBUG : test/testfile: Open: flags=O_RDWR|O_CREATE|O_EXCL
2022/04/12 15:46:23 DEBUG : test/testfile: newRWFileHandle:
2022/04/12 15:46:23 DEBUG : test/testfile: >newRWFileHandle: err=file already exists
2022/04/12 15:46:23 DEBUG : test/testfile: File.openRW failed: file already exists
2022/04/12 15:46:23 DEBUG : test/testfile: >Open: fd=<nil *RWFileHandle>, err=file already exists
2022/04/12 15:46:23 DEBUG : /test/testfile: >CreateEx: errc=-17, fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test/testfile: >Getattr: errc=0
rclone[TID=2dfc]: FFFF9E86C6BC59B0: <<Create IoStatus=c0000035[0]
rclone[TID=2dfc]: FFFF9E86C2140DD0: >>Create [UT---C] "\test\testfile", FILE_CREATE, CreateOptions=44, FileAttributes=20, Security=NULL, AllocationSize=0:1825000, AccessToken=00000000000006A0[PID=2350], DesiredAccess=170197, GrantedAccess=0, ShareAccess=0
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test/testfile: CreateEx: flags=0x502, mode=0770
2022/04/12 15:46:23 DEBUG : test/testfile: Open: flags=O_RDWR|O_CREATE|O_EXCL
2022/04/12 15:46:23 DEBUG : test/testfile: newRWFileHandle:
2022/04/12 15:46:23 DEBUG : test/testfile: >newRWFileHandle: err=file already exists
2022/04/12 15:46:23 DEBUG : test/testfile: File.openRW failed: file already exists
2022/04/12 15:46:23 DEBUG : test/testfile: >Open: fd=<nil *RWFileHandle>, err=file already exists
2022/04/12 15:46:23 DEBUG : /test/testfile: >CreateEx: errc=-17, fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test/testfile: >Getattr: errc=0
rclone[TID=2dfc]: FFFF9E86C2140DD0: <<Create IoStatus=c0000035[0]
rclone[TID=2dfc]: FFFF9E86C6BC59B0: >>Create [UT---C] "\test\testfile", FILE_CREATE, CreateOptions=44, FileAttributes=20, Security=NULL, AllocationSize=0:1825000, AccessToken=00000000000006A0[PID=2350], DesiredAccess=170196, GrantedAccess=0, ShareAccess=0
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test/testfile: CreateEx: flags=0x502, mode=0770
2022/04/12 15:46:23 DEBUG : test/testfile: Open: flags=O_RDWR|O_CREATE|O_EXCL
2022/04/12 15:46:23 DEBUG : test/testfile: newRWFileHandle:
2022/04/12 15:46:23 DEBUG : test/testfile: >newRWFileHandle: err=file already exists
2022/04/12 15:46:23 DEBUG : test/testfile: File.openRW failed: file already exists
2022/04/12 15:46:23 DEBUG : test/testfile: >Open: fd=<nil *RWFileHandle>, err=file already exists
2022/04/12 15:46:23 DEBUG : /test/testfile: >CreateEx: errc=-17, fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test/testfile: >Getattr: errc=0
rclone[TID=2dfc]: FFFF9E86C6BC59B0: <<Create IoStatus=c0000035[0]
rclone[TID=2dfc]: FFFF9E86D0428DD0: >>Create [UT---C] "\test\testfile", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006A0[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:23 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test/testfile: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test/testfile: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test/testfile: OpenEx: flags=0x0
2022/04/12 15:46:23 DEBUG : /test/testfile: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:23 DEBUG : test/testfile: Open: flags=O_RDONLY
2022/04/12 15:46:23 DEBUG : test/testfile: newRWFileHandle:
2022/04/12 15:46:23 DEBUG : test/testfile: >newRWFileHandle: err=<nil>
2022/04/12 15:46:23 DEBUG : test/testfile: >Open: fd=test/testfile (rw), err=<nil>
2022/04/12 15:46:23 DEBUG : /test/testfile: >OpenFile: fd=test/testfile (rw), err=<nil>
2022/04/12 15:46:23 DEBUG : /test/testfile: >OpenEx: errc=0, fh=0x0
rclone[TID=2dfc]: FFFF9E86D0428DD0: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FBC0, GrantedAccess=80, FileInfo={FileAttributes=0, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-12T15:46:22.801Z, LastAccessTime=2022-04-12T15:46:22.801Z, LastWriteTime=2022-04-12T15:46:22.801Z, ChangeTime=2022-04-12T15:46:22.801Z, IndexNumber=0:11}
rclone[TID=2dfc]: FFFF9E86C2140DD0: >>Close 0000000000000000:000000000321FBC0
rclone[TID=24b4]: FFFF9E86D0428DD0: >>Create [UT---C] "\test\testfile", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000298[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:23 DEBUG : /test/testfile: Flush: fh=0x0
2022/04/12 15:46:23 DEBUG : test/testfile(0xc00059cb00): RWFileHandle.Flush
2022/04/12 15:46:23 DEBUG : /test/testfile: >Flush: errc=0
2022/04/12 15:46:23 DEBUG : /test/testfile: Release: fh=0x0
2022/04/12 15:46:23 DEBUG : test/testfile(0xc00059cb00): RWFileHandle.Release
2022/04/12 15:46:23 DEBUG : test/testfile(0xc00059cb00): close:
2022/04/12 15:46:23 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : test/testfile(0xc00059cb00): >close: err=<nil>
2022/04/12 15:46:23 DEBUG : /test/testfile: >Release: errc=0
rclone[TID=2dfc]: FFFF9E86C2140DD0: <<Close IoStatus=0[0]
2022/04/12 15:46:23 DEBUG : /test/testfile: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test/testfile: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test/testfile: OpenEx: flags=0x0
2022/04/12 15:46:23 DEBUG : /test/testfile: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:23 DEBUG : test/testfile: Open: flags=O_RDONLY
2022/04/12 15:46:23 DEBUG : test/testfile: newRWFileHandle:
2022/04/12 15:46:23 DEBUG : test/testfile: >newRWFileHandle: err=<nil>
2022/04/12 15:46:23 DEBUG : test/testfile: >Open: fd=test/testfile (rw), err=<nil>
2022/04/12 15:46:23 DEBUG : /test/testfile: >OpenFile: fd=test/testfile (rw), err=<nil>
2022/04/12 15:46:23 DEBUG : /test/testfile: >OpenEx: errc=0, fh=0x0
rclone[TID=24b4]: FFFF9E86D0428DD0: <<Create IoStatus=0[1] UserContext=0000000000000000:00000000032201F0, GrantedAccess=80, FileInfo={FileAttributes=0, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-12T15:46:22.801Z, LastAccessTime=2022-04-12T15:46:22.801Z, LastWriteTime=2022-04-12T15:46:22.801Z, ChangeTime=2022-04-12T15:46:22.801Z, IndexNumber=0:11}
rclone[TID=24b4]: FFFF9E86C2140DD0: >>Close 0000000000000000:00000000032201F0
rclone[TID=2dfc]: FFFF9E86D0428DD0: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=20, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006A0[PID=2350], DesiredAccess=100081, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:23 DEBUG : /test/testfile: Flush: fh=0x0
2022/04/12 15:46:23 DEBUG : test/testfile(0xc000c1a200): RWFileHandle.Flush
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test/testfile: >Flush: errc=0
2022/04/12 15:46:23 DEBUG : /test/testfile: Release: fh=0x0
2022/04/12 15:46:23 DEBUG : test/testfile(0xc000c1a200): RWFileHandle.Release
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : test/testfile(0xc000c1a200): close:
2022/04/12 15:46:23 DEBUG : test/testfile(0xc000c1a200): >close: err=<nil>
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test: Opendir:
2022/04/12 15:46:23 DEBUG : /test/testfile: >Release: errc=0
rclone[TID=24b4]: FFFF9E86C2140DD0: <<Close IoStatus=0[0]
2022/04/12 15:46:23 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:23 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
rclone[TID=24b4]: FFFF9E86C70244D0: >>Create [UT---C] "\", FILE_OPEN, CreateOptions=20, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006A8[PID=2350], DesiredAccess=100081, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:23 DEBUG : /test: >Opendir: errc=0, fh=0x0
rclone[TID=3a38]: FFFF9E86C8103DC0: >>Create [UTB--C] "\test", FILE_OPEN, CreateOptions=4000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=000000000000069C[PID=dc4], DesiredAccess=0, GrantedAccess=80, ShareAccess=1
rclone[TID=396c]: FFFF9E86D025ADE0: >>Create [UT---C] "\", FILE_OPEN, CreateOptions=0, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006AC[PID=2350], DesiredAccess=100081, GrantedAccess=0, ShareAccess=7
rclone[TID=2dfc]: FFFF9E86D0428DD0: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FFB0, GrantedAccess=100081, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
2022/04/12 15:46:23 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /: >Getattr: errc=0
rclone[TID=2dfc]: FFFF9E86C6BC59B0: >>QuerySecurity 0000000000000000:000000000321FFB0
rclone[TID=0e08]: FFFF9E86CE35CDD0: >>Create [UT---C] "\", FILE_OPEN, CreateOptions=21, FileAttributes=10, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006B4[PID=2350], DesiredAccess=100000, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
rclone[TID=2dfc]: FFFF9E86C6BC59B0: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
2022/04/12 15:46:23 DEBUG : /: >Getattr: errc=0
rclone[TID=2dfc]: FFFF9E86CA9E7DC0: >>QueryDirectory 0000000000000000:000000000321FFB0, Address=000000002BE30000, Length=616, Pattern="testfile", Marker=NULL
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /: Opendir:
2022/04/12 15:46:23 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: Opendir:
2022/04/12 15:46:23 DEBUG : /: Opendir:
2022/04/12 15:46:23 DEBUG : /: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:23 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test/testfile: >Getattr: errc=0
rclone[TID=2dfc]: FFFF9E86CA9E7DC0: <<QueryDirectory IoStatus=0[122]
2022/04/12 15:46:23 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
rclone[TID=2dfc]: FFFF9E86CC92B800: >>Close 0000000000000000:000000000321FFB0
rclone[TID=3c44]: FFFF9E86CA9E7DC0: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=20, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006D4[PID=2350], DesiredAccess=100081, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:23 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:23 DEBUG : /test: >Opendir: errc=0, fh=0x1
rclone[TID=3a38]: FFFF9E86C8103DC0: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FE90, GrantedAccess=80, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
2022/04/12 15:46:23 DEBUG : /: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:23 DEBUG : /: >OpenFile: fd=/ (r), err=<nil>
rclone[TID=3a38]: FFFF9E86CCA83DC0: >>QuerySecurity 0000000000000000:000000000321FE90
2022/04/12 15:46:23 DEBUG : /: >OpenFile: fd=/ (r), err=<nil>
2022/04/12 15:46:23 DEBUG : /: Opendir:
2022/04/12 15:46:23 DEBUG : /test: Releasedir: fh=0x0
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /: >Opendir: errc=0, fh=0x2
rclone[TID=396c]: FFFF9E86D025ADE0: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321F9B0, GrantedAccess=100081, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-12T15:46:07.276Z, LastAccessTime=2022-04-12T15:46:07.276Z, LastWriteTime=2022-04-12T15:46:07.276Z, ChangeTime=2022-04-12T15:46:07.276Z, IndexNumber=0:1}
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
rclone[TID=396c]: FFFF9E86CB254800: >>QuerySecurity 0000000000000000:000000000321F9B0
2022/04/12 15:46:23 DEBUG : /: >Opendir: errc=0, fh=0x3
rclone[TID=3a38]: FFFF9E86CCA83DC0: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
2022/04/12 15:46:23 DEBUG : /: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
rclone[TID=24b4]: FFFF9E86C70244D0: <<Create IoStatus=0[1] UserContext=0000000000000000:0000000003220070, GrantedAccess=100081, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-12T15:46:07.276Z, LastAccessTime=2022-04-12T15:46:07.276Z, LastWriteTime=2022-04-12T15:46:07.276Z, ChangeTime=2022-04-12T15:46:07.276Z, IndexNumber=0:1}
rclone[TID=3a38]: FFFF9E86C6FD6DE0: >>Close 0000000000000000:000000000321FE90
2022/04/12 15:46:23 DEBUG : /test: >Releasedir: errc=0
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
rclone[TID=2dfc]: FFFF9E86CC92B800: <<Close IoStatus=0[0]
2022/04/12 15:46:23 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /: >OpenFile: fd=/ (r), err=<nil>
2022/04/12 15:46:23 DEBUG : /test: Releasedir: fh=0x1
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /: >Opendir: errc=0, fh=0x0
rclone[TID=396c]: FFFF9E86CB254800: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
2022/04/12 15:46:23 DEBUG : /test: >Releasedir: errc=0
rclone[TID=0e08]: FFFF9E86CE35CDD0: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FB90, GrantedAccess=100000, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-12T15:46:07.276Z, LastAccessTime=2022-04-12T15:46:07.276Z, LastWriteTime=2022-04-12T15:46:07.276Z, ChangeTime=2022-04-12T15:46:07.276Z, IndexNumber=0:1}
rclone[TID=1840]: FFFF9E86C70244D0: >>QueryDirectory 0000000000000000:0000000003220070, Address=000000002BE30000, Length=616, Pattern="test", Marker=NULL
rclone[TID=396c]: FFFF9E86CB254800: >>Create [UT---C] "\", FILE_OPEN, CreateOptions=0, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006EC[PID=2350], DesiredAccess=100081, GrantedAccess=0, ShareAccess=7
rclone[TID=3a38]: FFFF9E86C6FD6DE0: <<Close IoStatus=0[0]
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
rclone[TID=1840]: FFFF9E86C70244D0: <<QueryDirectory IoStatus=0[114]
2022/04/12 15:46:23 DEBUG : /test: Opendir:
rclone[TID=1840]: FFFF9E86D0483DE0: >>Close 0000000000000000:0000000003220070
rclone[TID=2dfc]: FFFF9E86C6FD6DE0: >>Close 0000000000000000:000000000321FB90
rclone[TID=3a38]: FFFF9E86C2140DD0: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=000000000000069C[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:23 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:23 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /: Releasedir: fh=0x3
2022/04/12 15:46:23 DEBUG : /: >Releasedir: errc=0
rclone[TID=1840]: FFFF9E86D0483DE0: <<Close IoStatus=0[0]
2022/04/12 15:46:23 DEBUG : /: Releasedir: fh=0x0
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:23 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
rclone[TID=1840]: FFFF9E86C70244D0: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=20, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006F4[PID=2350], DesiredAccess=100081, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:23 DEBUG : /: >Releasedir: errc=0
rclone[TID=2dfc]: FFFF9E86C6FD6DE0: <<Close IoStatus=0[0]
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test: >Opendir: errc=0, fh=0x0
rclone[TID=3c44]: FFFF9E86CA9E7DC0: <<Create IoStatus=0[1] UserContext=0000000000000000:00000000032203A0, GrantedAccess=100081, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
2022/04/12 15:46:23 DEBUG : /: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86C6ACF950: >>QuerySecurity 0000000000000000:00000000032203A0
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /: Opendir:
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
rclone[TID=3c44]: FFFF9E86C6ACF950: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
2022/04/12 15:46:23 DEBUG : /test: Opendir:
rclone[TID=3c44]: FFFF9E86C6ACF950: >>QueryDirectory 0000000000000000:00000000032203A0, Address=000000002BE30000, Length=616, Pattern="testfile", Marker=NULL
2022/04/12 15:46:23 DEBUG : /: >OpenFile: fd=/ (r), err=<nil>
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:23 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /: >Opendir: errc=0, fh=0x1
2022/04/12 15:46:23 DEBUG : /test: Opendir:
rclone[TID=396c]: FFFF9E86CB254800: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FD10, GrantedAccess=100081, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-12T15:46:07.276Z, LastAccessTime=2022-04-12T15:46:07.276Z, LastWriteTime=2022-04-12T15:46:07.276Z, ChangeTime=2022-04-12T15:46:07.276Z, IndexNumber=0:1}
2022/04/12 15:46:23 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:23 DEBUG : /test/testfile: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
rclone[TID=3c44]: FFFF9E86C6ACF950: <<QueryDirectory IoStatus=0[122]
2022/04/12 15:46:23 DEBUG : /test: >Opendir: errc=0, fh=0x3
rclone[TID=3c44]: FFFF9E86D0483DE0: >>Close 0000000000000000:00000000032203A0
rclone[TID=3a38]: FFFF9E86C2140DD0: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FA10, GrantedAccess=80, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
2022/04/12 15:46:23 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
rclone[TID=3a38]: FFFF9E86D025ADE0: >>Close 0000000000000000:000000000321FA10
2022/04/12 15:46:23 DEBUG : /test: >Opendir: errc=0, fh=0x4
rclone[TID=1840]: FFFF9E86C70244D0: <<Create IoStatus=0[1] UserContext=0000000000000000:0000000003220370, GrantedAccess=100081, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
2022/04/12 15:46:23 DEBUG : /test: Releasedir: fh=0x0
rclone[TID=1840]: FFFF9E86C70244D0: >>QuerySecurity 0000000000000000:0000000003220370
2022/04/12 15:46:23 DEBUG : /test: Releasedir: fh=0x3
2022/04/12 15:46:23 DEBUG : /test: >Releasedir: errc=0
2022/04/12 15:46:23 DEBUG : /test: >Releasedir: errc=0
rclone[TID=3a38]: FFFF9E86D025ADE0: <<Close IoStatus=0[0]
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
rclone[TID=3c44]: FFFF9E86D0483DE0: <<Close IoStatus=0[0]
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
rclone[TID=1840]: FFFF9E86C70244D0: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=1840]: FFFF9E86C70244D0: >>QueryDirectory 0000000000000000:0000000003220370, Address=000000002BE30000, Length=16368, Pattern=NULL, Marker=NULL
2022/04/12 15:46:23 DEBUG : /test: Readdir: ofst=0, fh=0x4
2022/04/12 15:46:23 DEBUG : /test: >Readdir: items=1, errc=0
rclone[TID=3c44]: FFFF9E86CC906800: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=60, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000704[PID=2350], DesiredAccess=100080, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:23 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
rclone[TID=1840]: FFFF9E86C70244D0: <<QueryDirectory IoStatus=0[346]
rclone[TID=3c44]: FFFF9E86CC906800: <<Create IoStatus=c00000ba[0]
rclone[TID=1840]: FFFF9E86D025ADE0: >>Close 0000000000000000:0000000003220370
rclone[TID=3c44]: FFFF9E86D0483DE0: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=200020, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000704[PID=2350], DesiredAccess=100080, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:23 DEBUG : /test: Releasedir: fh=0x4
2022/04/12 15:46:23 DEBUG : /test: >Releasedir: errc=0
rclone[TID=1840]: FFFF9E86D025ADE0: <<Close IoStatus=0[0]
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test: Opendir:
2022/04/12 15:46:23 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:23 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:23 DEBUG : /test: >Opendir: errc=0, fh=0x0
rclone[TID=3c44]: FFFF9E86D0483DE0: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FAA0, GrantedAccess=100080, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
rclone[TID=3c44]: FFFF9E86C70244D0: >>QuerySecurity 0000000000000000:000000000321FAA0
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86C70244D0: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=3c44]: FFFF9E86C70244D0: >>FileSystemControl [FSCTL_GET_REPARSE_POINT] "\test", 0000000000000000:000000000321FAA0
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86C70244D0: <<FileSystemControl IoStatus=c0000275[0]
rclone[TID=3c44]: FFFF9E86C2B49AF0: >>Close 0000000000000000:000000000321FAA0
rclone[TID=1840]: FFFF9E86C70244D0: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=20, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000704[PID=2350], DesiredAccess=100080, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:23 DEBUG : /test: Releasedir: fh=0x0
2022/04/12 15:46:23 DEBUG : /test: >Releasedir: errc=0
rclone[TID=3c44]: FFFF9E86C2B49AF0: <<Close IoStatus=0[0]
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test: Opendir:
2022/04/12 15:46:23 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:23 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:23 DEBUG : /test: >Opendir: errc=0, fh=0x0
rclone[TID=1840]: FFFF9E86C70244D0: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FBC0, GrantedAccess=100080, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
rclone[TID=1840]: FFFF9E86D0483DE0: >>QuerySecurity 0000000000000000:000000000321FBC0
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
rclone[TID=1840]: FFFF9E86D0483DE0: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=1840]: FFFF9E86CEA6ADD0: >>Close 0000000000000000:000000000321FBC0
rclone[TID=3c44]: FFFF9E86C91EF800: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=10, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=000000000000069C[PID=2350], DesiredAccess=100080, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:23 DEBUG : /test: Releasedir: fh=0x0
2022/04/12 15:46:23 DEBUG : /test: >Releasedir: errc=0
rclone[TID=1840]: FFFF9E86CEA6ADD0: <<Close IoStatus=0[0]
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test: Opendir:
2022/04/12 15:46:23 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:23 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:23 DEBUG : /test: >Opendir: errc=0, fh=0x0
rclone[TID=3c44]: FFFF9E86C91EF800: <<Create IoStatus=0[1] UserContext=0000000000000000:0000000003220430, GrantedAccess=100080, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
rclone[TID=3c44]: FFFF9E86D0483DE0: >>QuerySecurity 0000000000000000:0000000003220430
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86D0483DE0: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=3c44]: FFFF9E86C2140DD0: >>Close 0000000000000000:0000000003220430
rclone[TID=1840]: FFFF9E86D0483DE0: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=200020, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000704[PID=2350], DesiredAccess=100080, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:23 DEBUG : /test: Releasedir: fh=0x0
2022/04/12 15:46:23 DEBUG : /test: >Releasedir: errc=0
rclone[TID=3c44]: FFFF9E86C2140DD0: <<Close IoStatus=0[0]
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test: Opendir:
2022/04/12 15:46:23 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:23 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:23 DEBUG : /test: >Opendir: errc=0, fh=0x0
rclone[TID=1840]: FFFF9E86D0483DE0: <<Create IoStatus=0[1] UserContext=0000000000000000:0000000003220430, GrantedAccess=100080, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
rclone[TID=1840]: FFFF9E86D0483DE0: >>QuerySecurity 0000000000000000:0000000003220430
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
rclone[TID=1840]: FFFF9E86D0483DE0: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=1840]: FFFF9E86D0483DE0: >>FileSystemControl [FSCTL_GET_REPARSE_POINT] "\test", 0000000000000000:0000000003220430
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
rclone[TID=1840]: FFFF9E86D0483DE0: <<FileSystemControl IoStatus=c0000275[0]
rclone[TID=1840]: FFFF9E86C2140DD0: >>Close 0000000000000000:0000000003220430
rclone[TID=3c44]: FFFF9E86C91EF800: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=60, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=000000000000069C[PID=2350], DesiredAccess=100080, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:23 DEBUG : /test: Releasedir: fh=0x0
2022/04/12 15:46:23 DEBUG : /test: >Releasedir: errc=0
rclone[TID=1840]: FFFF9E86C2140DD0: <<Close IoStatus=0[0]
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86C91EF800: <<Create IoStatus=c00000ba[0]
rclone[TID=3c44]: FFFF9E86C70244D0: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=200020, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=000000000000069C[PID=2350], DesiredAccess=100080, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test: Opendir:
2022/04/12 15:46:23 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:23 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:23 DEBUG : /test: >Opendir: errc=0, fh=0x0
rclone[TID=3c44]: FFFF9E86C70244D0: <<Create IoStatus=0[1] UserContext=0000000000000000:00000000032203D0, GrantedAccess=100080, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
rclone[TID=3c44]: FFFF9E86C70244D0: >>QuerySecurity 0000000000000000:00000000032203D0
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86C70244D0: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=3c44]: FFFF9E86C70244D0: >>FileSystemControl [FSCTL_GET_REPARSE_POINT] "\test", 0000000000000000:00000000032203D0
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86C70244D0: <<FileSystemControl IoStatus=c0000275[0]
rclone[TID=1840]: FFFF9E86C2B49AF0: >>Close 0000000000000000:00000000032203D0
2022/04/12 15:46:23 DEBUG : /test: Releasedir: fh=0x0
rclone[TID=3a38]: FFFF9E86C70244D0: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=20, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006EC[PID=2350], DesiredAccess=100080, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:23 DEBUG : /test: >Releasedir: errc=0
rclone[TID=1840]: FFFF9E86C2B49AF0: <<Close IoStatus=0[0]
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test: Opendir:
2022/04/12 15:46:23 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:23 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:23 DEBUG : /test: >Opendir: errc=0, fh=0x0
rclone[TID=3a38]: FFFF9E86C70244D0: <<Create IoStatus=0[1] UserContext=0000000000000000:0000000003220370, GrantedAccess=100080, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
rclone[TID=3a38]: FFFF9E86C70244D0: >>QuerySecurity 0000000000000000:0000000003220370
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
rclone[TID=3a38]: FFFF9E86C70244D0: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=3a38]: FFFF9E86C2B49AF0: >>Close 0000000000000000:0000000003220370
rclone[TID=1840]: FFFF9E86C70244D0: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=10, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000704[PID=2350], DesiredAccess=100080, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:23 DEBUG : /test: Releasedir: fh=0x0
2022/04/12 15:46:23 DEBUG : /test: >Releasedir: errc=0
rclone[TID=3a38]: FFFF9E86C2B49AF0: <<Close IoStatus=0[0]
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test: Opendir:
2022/04/12 15:46:23 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:23 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:23 DEBUG : /test: >Opendir: errc=0, fh=0x0
rclone[TID=1840]: FFFF9E86C70244D0: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FB90, GrantedAccess=100080, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
rclone[TID=1840]: FFFF9E86C70244D0: >>QuerySecurity 0000000000000000:000000000321FB90
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
rclone[TID=1840]: FFFF9E86C70244D0: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=1840]: FFFF9E86CEA6ADD0: >>Close 0000000000000000:000000000321FB90
rclone[TID=3a38]: FFFF9E86D0432DC0: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=200020, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000708[PID=2350], DesiredAccess=100080, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:23 DEBUG : /test: Releasedir: fh=0x0
2022/04/12 15:46:23 DEBUG : /test: >Releasedir: errc=0
rclone[TID=1840]: FFFF9E86CEA6ADD0: <<Close IoStatus=0[0]
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test: Opendir:
2022/04/12 15:46:23 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:23 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:23 DEBUG : /test: >Opendir: errc=0, fh=0x0
rclone[TID=3a38]: FFFF9E86D0432DC0: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FB90, GrantedAccess=100080, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
rclone[TID=3a38]: FFFF9E86C6BC59B0: >>QuerySecurity 0000000000000000:000000000321FB90
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
rclone[TID=3a38]: FFFF9E86C6BC59B0: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=3a38]: FFFF9E86CA9E7DC0: >>FileSystemControl [FSCTL_GET_REPARSE_POINT] "\test", 0000000000000000:000000000321FB90
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
rclone[TID=3a38]: FFFF9E86CA9E7DC0: <<FileSystemControl IoStatus=c0000275[0]
rclone[TID=3a38]: FFFF9E86C69D7970: >>Close 0000000000000000:000000000321FB90
2022/04/12 15:46:23 DEBUG : /test: Releasedir: fh=0x0
2022/04/12 15:46:23 DEBUG : /test: >Releasedir: errc=0
rclone[TID=3a38]: FFFF9E86C69D7970: <<Close IoStatus=0[0]
rclone[TID=3a38]: FFFF9E86D0425DD0: >>Create [UT---C] "\test\desktop.ini", FILE_OPEN, CreateOptions=64, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000708[PID=2350], DesiredAccess=120089, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:23 DEBUG : /test/desktop.ini: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test/desktop.ini: >Getattr: errc=-2
rclone[TID=3a38]: FFFF9E86D0425DD0: <<Create IoStatus=c0000034[0]
rclone[TID=3a38]: FFFF9E86D0425DD0: >>Create [UT---C] "\", FILE_OPEN, CreateOptions=21, FileAttributes=10, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000708[PID=2350], DesiredAccess=100000, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:23 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /: Opendir:
rclone[TID=1840]: FFFF9E86C8103DC0: >>Create [UT---C] "\", FILE_OPEN, CreateOptions=21, FileAttributes=10, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000700[PID=2350], DesiredAccess=100000, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:23 DEBUG : /: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:23 DEBUG : /: >OpenFile: fd=/ (r), err=<nil>
2022/04/12 15:46:23 DEBUG : /: >Opendir: errc=0, fh=0x0
2022/04/12 15:46:23 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
rclone[TID=3a38]: FFFF9E86D0425DD0: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FC50, GrantedAccess=100000, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-12T15:46:07.276Z, LastAccessTime=2022-04-12T15:46:07.276Z, LastWriteTime=2022-04-12T15:46:07.276Z, ChangeTime=2022-04-12T15:46:07.276Z, IndexNumber=0:1}
2022/04/12 15:46:23 DEBUG : /: >Getattr: errc=0
rclone[TID=3a38]: FFFF9E86CC41EDD0: >>Close 0000000000000000:000000000321FC50
rclone[TID=3c44]: FFFF9E86D0425DD0: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=000000000000069C[PID=2350], DesiredAccess=20080, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:23 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /: Releasedir: fh=0x0
2022/04/12 15:46:23 DEBUG : /: >Releasedir: errc=0
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
rclone[TID=3a38]: FFFF9E86CC41EDD0: <<Close IoStatus=0[0]
2022/04/12 15:46:23 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /: Opendir:
2022/04/12 15:46:23 DEBUG : /: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:23 DEBUG : /: >OpenFile: fd=/ (r), err=<nil>
2022/04/12 15:46:23 DEBUG : /test: Opendir:
2022/04/12 15:46:23 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:23 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:23 DEBUG : /: >Opendir: errc=0, fh=0x0
rclone[TID=1840]: FFFF9E86C8103DC0: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321F920, GrantedAccess=100000, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-12T15:46:07.276Z, LastAccessTime=2022-04-12T15:46:07.276Z, LastWriteTime=2022-04-12T15:46:07.276Z, ChangeTime=2022-04-12T15:46:07.276Z, IndexNumber=0:1}
2022/04/12 15:46:23 DEBUG : /test: >Opendir: errc=0, fh=0x3
rclone[TID=3c44]: FFFF9E86D0425DD0: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FC80, GrantedAccess=20080, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
rclone[TID=1840]: FFFF9E86C6FD4DF0: >>Close 0000000000000000:000000000321F920
rclone[TID=3c44]: FFFF9E86CC92B800: >>QuerySecurity 0000000000000000:000000000321FC80
2022/04/12 15:46:23 DEBUG : /: Releasedir: fh=0x0
2022/04/12 15:46:23 DEBUG : /: >Releasedir: errc=0
rclone[TID=1840]: FFFF9E86C6FD4DF0: <<Close IoStatus=0[0]
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86CC92B800: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=3c44]: FFFF9E86C2CEB840: >>Close 0000000000000000:000000000321FC80
rclone[TID=1840]: FFFF9E86CC41EDD0: >>Create [UT---C] "\", FILE_OPEN, CreateOptions=21, FileAttributes=10, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006FC[PID=2350], DesiredAccess=100000, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:23 DEBUG : /test: Releasedir: fh=0x3
2022/04/12 15:46:23 DEBUG : /test: >Releasedir: errc=0
2022/04/12 15:46:23 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /: Opendir:
2022/04/12 15:46:23 DEBUG : /: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:23 DEBUG : /: >OpenFile: fd=/ (r), err=<nil>
2022/04/12 15:46:23 DEBUG : /: >Opendir: errc=0, fh=0x0
rclone[TID=3c44]: FFFF9E86C2CEB840: <<Close IoStatus=0[0]
rclone[TID=1840]: FFFF9E86CC41EDD0: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FB90, GrantedAccess=100000, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-12T15:46:07.276Z, LastAccessTime=2022-04-12T15:46:07.276Z, LastWriteTime=2022-04-12T15:46:07.276Z, ChangeTime=2022-04-12T15:46:07.276Z, IndexNumber=0:1}
rclone[TID=1840]: FFFF9E86C2B49AF0: >>Close 0000000000000000:000000000321FB90
rclone[TID=3c44]: FFFF9E86CC92B800: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006F0[PID=2350], DesiredAccess=20080, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:23 DEBUG : /: Releasedir: fh=0x0
2022/04/12 15:46:23 DEBUG : /: >Releasedir: errc=0
rclone[TID=1840]: FFFF9E86C2B49AF0: <<Close IoStatus=0[0]
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test: Opendir:
2022/04/12 15:46:23 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:23 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:23 DEBUG : /test: >Opendir: errc=0, fh=0x0
rclone[TID=3c44]: FFFF9E86CC92B800: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FAA0, GrantedAccess=20080, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
rclone[TID=3c44]: FFFF9E86CC41EDD0: >>QuerySecurity 0000000000000000:000000000321FAA0
2022/04/12 15:46:23 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86CC41EDD0: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=3c44]: FFFF9E86C2CEB840: >>Close 0000000000000000:000000000321FAA0
2022/04/12 15:46:23 DEBUG : /test: Releasedir: fh=0x0
2022/04/12 15:46:23 DEBUG : /test: >Releasedir: errc=0
rclone[TID=3c44]: FFFF9E86C2CEB840: <<Close IoStatus=0[0]
rclone[TID=3c44]: FFFF9E86CC906800: >>Create [UT---C] "\test\testfile", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000704[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:23 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test/testfile: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test/testfile: >Getattr: errc=0
2022/04/12 15:46:23 DEBUG : /test/testfile: OpenEx: flags=0x0
2022/04/12 15:46:23 DEBUG : /test/testfile: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:23 DEBUG : test/testfile: Open: flags=O_RDONLY
2022/04/12 15:46:23 DEBUG : test/testfile: newRWFileHandle:
2022/04/12 15:46:23 DEBUG : test/testfile: >newRWFileHandle: err=<nil>
2022/04/12 15:46:23 DEBUG : test/testfile: >Open: fd=test/testfile (rw), err=<nil>
2022/04/12 15:46:23 DEBUG : /test/testfile: >OpenFile: fd=test/testfile (rw), err=<nil>
2022/04/12 15:46:23 DEBUG : /test/testfile: >OpenEx: errc=0, fh=0x0
rclone[TID=3c44]: FFFF9E86CC906800: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FFE0, GrantedAccess=80, FileInfo={FileAttributes=0, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-12T15:46:22.801Z, LastAccessTime=2022-04-12T15:46:22.801Z, LastWriteTime=2022-04-12T15:46:22.801Z, ChangeTime=2022-04-12T15:46:22.801Z, IndexNumber=0:11}
rclone[TID=3c44]: FFFF9E86CB513840: >>Close 0000000000000000:000000000321FFE0
rclone[TID=1840]: FFFF9E86CC906800: >>Create [UT---C] "\test\.git", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006FC[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:23 DEBUG : /test/testfile: Flush: fh=0x0
2022/04/12 15:46:23 DEBUG : test/testfile(0xc0008e6000): RWFileHandle.Flush
2022/04/12 15:46:23 DEBUG : /test/testfile: >Flush: errc=0
2022/04/12 15:46:23 DEBUG : /test/.git: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test/.git: >Getattr: errc=-2
rclone[TID=1840]: FFFF9E86CC906800: <<Create IoStatus=c0000034[0]
2022/04/12 15:46:23 DEBUG : /test/testfile: Release: fh=0x0
rclone[TID=1840]: FFFF9E86CC906800: >>Create [UT---C] "\test\HEAD", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006FC[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:23 DEBUG : test/testfile(0xc0008e6000): RWFileHandle.Release
2022/04/12 15:46:23 DEBUG : test/testfile(0xc0008e6000): close:
2022/04/12 15:46:23 DEBUG : /test/HEAD: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /test/HEAD: >Getattr: errc=-2
rclone[TID=1840]: FFFF9E86CC906800: <<Create IoStatus=c0000034[0]
2022/04/12 15:46:23 DEBUG : test/testfile(0xc0008e6000): >close: err=<nil>
2022/04/12 15:46:23 DEBUG : /test/testfile: >Release: errc=0
rclone[TID=1840]: FFFF9E86CC906800: >>Create [UT---C] "\.git", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006FC[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
rclone[TID=3c44]: FFFF9E86CB513840: <<Close IoStatus=0[0]
2022/04/12 15:46:23 DEBUG : /.git: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /.git: >Getattr: errc=-2
rclone[TID=1840]: FFFF9E86CC906800: <<Create IoStatus=c0000034[0]
rclone[TID=1840]: FFFF9E86CC906800: >>Create [UT---C] "\HEAD", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006FC[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:23 DEBUG : /HEAD: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:23 DEBUG : /HEAD: >Getattr: errc=-2
rclone[TID=1840]: FFFF9E86CC906800: <<Create IoStatus=c0000034[0]
rclone[TID=1840]: FFFF9E86C2140DD0: >>Create [UT---C] "\test\testfile", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006FC[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:26 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test/testfile: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test/testfile: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test/testfile: OpenEx: flags=0x0
2022/04/12 15:46:26 DEBUG : /test/testfile: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:26 DEBUG : test/testfile: Open: flags=O_RDONLY
2022/04/12 15:46:26 DEBUG : test/testfile: newRWFileHandle:
2022/04/12 15:46:26 DEBUG : test/testfile: >newRWFileHandle: err=<nil>
2022/04/12 15:46:26 DEBUG : test/testfile: >Open: fd=test/testfile (rw), err=<nil>
2022/04/12 15:46:26 DEBUG : /test/testfile: >OpenFile: fd=test/testfile (rw), err=<nil>
2022/04/12 15:46:26 DEBUG : /test/testfile: >OpenEx: errc=0, fh=0x0
rclone[TID=1840]: FFFF9E86C2140DD0: <<Create IoStatus=0[1] UserContext=0000000000000000:0000000003220370, GrantedAccess=80, FileInfo={FileAttributes=0, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-12T15:46:22.801Z, LastAccessTime=2022-04-12T15:46:22.801Z, LastWriteTime=2022-04-12T15:46:22.801Z, ChangeTime=2022-04-12T15:46:22.801Z, IndexNumber=0:11}
rclone[TID=1840]: FFFF9E86CC92B800: >>Close 0000000000000000:0000000003220370
rclone[TID=3c44]: FFFF9E86C70244D0: >>Create [UT---C] "\test\testfile (2)", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=000000000000069C[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:26 DEBUG : /test/testfile: Flush: fh=0x0
2022/04/12 15:46:26 DEBUG : /test/testfile (2): Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test/testfile (2): >Getattr: errc=-2
2022/04/12 15:46:26 DEBUG : test/testfile(0xc0008e6040): RWFileHandle.Flush
2022/04/12 15:46:26 DEBUG : /test/testfile: >Flush: errc=0
rclone[TID=3c44]: FFFF9E86C70244D0: <<Create IoStatus=c0000034[0]
2022/04/12 15:46:26 DEBUG : /test/testfile: Release: fh=0x0
2022/04/12 15:46:26 DEBUG : test/testfile(0xc0008e6040): RWFileHandle.Release
2022/04/12 15:46:26 DEBUG : test/testfile(0xc0008e6040): close:
2022/04/12 15:46:26 DEBUG : test/testfile(0xc0008e6040): >close: err=<nil>
rclone[TID=3c44]: FFFF9E86C6BC59B0: >>Create [UT---C] "\test\testfile", FILE_OVERWRITE_IF, CreateOptions=44, FileAttributes=20, Security=NULL, AllocationSize=0:1825000, AccessToken=000000000000069C[PID=2350], DesiredAccess=17019f, GrantedAccess=0, ShareAccess=0
2022/04/12 15:46:26 DEBUG : /test/testfile: >Release: errc=0
rclone[TID=1840]: FFFF9E86CC92B800: <<Close IoStatus=0[0]
2022/04/12 15:46:26 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test/testfile: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86C6BC59B0: <<Create IoStatus=c0000022[0]
rclone[TID=3c44]: FFFF9E86C2140DD0: >>Create [UT---C] "\test\testfile", FILE_OVERWRITE_IF, CreateOptions=44, FileAttributes=20, Security=NULL, AllocationSize=0:1825000, AccessToken=000000000000069C[PID=2350], DesiredAccess=170197, GrantedAccess=0, ShareAccess=0
2022/04/12 15:46:26 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test/testfile: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86C2140DD0: <<Create IoStatus=c0000022[0]
rclone[TID=3c44]: FFFF9E86C2140DD0: >>Create [UT---C] "\test\testfile", FILE_OVERWRITE_IF, CreateOptions=44, FileAttributes=20, Security=NULL, AllocationSize=0:1825000, AccessToken=000000000000069C[PID=2350], DesiredAccess=170196, GrantedAccess=0, ShareAccess=0
2022/04/12 15:46:26 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test/testfile: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86C2140DD0: <<Create IoStatus=c0000022[0]
rclone[TID=3c44]: FFFF9E86C2140DD0: >>Create [UT---C] "\test\testfile", FILE_OVERWRITE_IF, CreateOptions=44, FileAttributes=20, Security=NULL, AllocationSize=0:1825000, AccessToken=000000000000069C[PID=2350], DesiredAccess=170197, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:26 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test/testfile: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86C2140DD0: <<Create IoStatus=c0000022[0]
rclone[TID=3c44]: FFFF9E86C2140DD0: >>Create [UT---C] "\test\testfile", FILE_OVERWRITE_IF, CreateOptions=44, FileAttributes=20, Security=NULL, AllocationSize=0:1825000, AccessToken=000000000000069C[PID=2350], DesiredAccess=170197, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:26 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test/testfile: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86C2140DD0: <<Create IoStatus=c0000022[0]
rclone[TID=3c44]: FFFF9E86C2140DD0: >>Create [UT---C] "\test\testfile", FILE_OVERWRITE_IF, CreateOptions=44, FileAttributes=20, Security=NULL, AllocationSize=0:1825000, AccessToken=000000000000069C[PID=2350], DesiredAccess=170196, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:26 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test/testfile: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86C2140DD0: <<Create IoStatus=c0000022[0]
rclone[TID=3c44]: FFFF9E86C2140DD0: >>Create [UT---C] "\test\testfile", FILE_OVERWRITE_IF, CreateOptions=44, FileAttributes=20, Security=NULL, AllocationSize=0:1825000, AccessToken=000000000000069C[PID=2350], DesiredAccess=160197, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:26 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test/testfile: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86C2140DD0: <<Create IoStatus=c0000022[0]
rclone[TID=3c44]: FFFF9E86C2140DD0: >>Create [UT---C] "\test\testfile", FILE_OVERWRITE_IF, CreateOptions=44, FileAttributes=20, Security=NULL, AllocationSize=0:1825000, AccessToken=000000000000069C[PID=2350], DesiredAccess=160197, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:26 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test/testfile: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86C2140DD0: <<Create IoStatus=c0000022[0]
rclone[TID=3c44]: FFFF9E86C2140DD0: >>Create [UT---C] "\test\testfile", FILE_OVERWRITE_IF, CreateOptions=44, FileAttributes=20, Security=NULL, AllocationSize=0:1825000, AccessToken=000000000000069C[PID=2350], DesiredAccess=160196, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:26 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test/testfile: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86C2140DD0: <<Create IoStatus=c0000022[0]
rclone[TID=3c44]: FFFF9E86CC92B800: >>Create [UT---C] "\test\testfile", FILE_OVERWRITE_IF, CreateOptions=44, FileAttributes=20, Security=NULL, AllocationSize=0:1825000, AccessToken=000000000000069C[PID=2350], DesiredAccess=120197, GrantedAccess=0, ShareAccess=0
2022/04/12 15:46:26 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test/testfile: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86CC92B800: <<Create IoStatus=c0000022[0]
rclone[TID=3c44]: FFFF9E86CC92B800: >>Create [UT---C] "\test\testfile", FILE_OVERWRITE_IF, CreateOptions=44, FileAttributes=20, Security=NULL, AllocationSize=0:1825000, AccessToken=000000000000069C[PID=2350], DesiredAccess=120197, GrantedAccess=0, ShareAccess=0
2022/04/12 15:46:26 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test/testfile: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86CC92B800: <<Create IoStatus=c0000022[0]
rclone[TID=3c44]: FFFF9E86CC92B800: >>Create [UT---C] "\test\testfile", FILE_OVERWRITE_IF, CreateOptions=44, FileAttributes=20, Security=NULL, AllocationSize=0:1825000, AccessToken=000000000000069C[PID=2350], DesiredAccess=120196, GrantedAccess=0, ShareAccess=0
2022/04/12 15:46:26 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test/testfile: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86CC92B800: <<Create IoStatus=c0000022[0]
rclone[TID=3c44]: FFFF9E86CC92B800: >>Create [UT---C] "\test\testfile", FILE_OVERWRITE_IF, CreateOptions=44, FileAttributes=20, Security=NULL, AllocationSize=0:1825000, AccessToken=000000000000069C[PID=2350], DesiredAccess=120197, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:26 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test/testfile: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86CC92B800: <<Create IoStatus=c0000022[0]
rclone[TID=3c44]: FFFF9E86CC92B800: >>Create [UT---C] "\test\testfile", FILE_OVERWRITE_IF, CreateOptions=44, FileAttributes=20, Security=NULL, AllocationSize=0:1825000, AccessToken=000000000000069C[PID=2350], DesiredAccess=120197, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:26 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test/testfile: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86CC92B800: <<Create IoStatus=c0000022[0]
rclone[TID=3c44]: FFFF9E86CC92B800: >>Create [UT---C] "\test\testfile", FILE_OVERWRITE_IF, CreateOptions=44, FileAttributes=20, Security=NULL, AllocationSize=0:1825000, AccessToken=000000000000069C[PID=2350], DesiredAccess=120196, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:26 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test/testfile: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86CC92B800: <<Create IoStatus=c0000022[0]
rclone[TID=3c44]: FFFF9E86CC92B800: >>Create [UT---C] "\test\testfile", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=000000000000069C[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:26 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test/testfile: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test/testfile: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test/testfile: OpenEx: flags=0x0
2022/04/12 15:46:26 DEBUG : /test/testfile: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:26 DEBUG : test/testfile: Open: flags=O_RDONLY
2022/04/12 15:46:26 DEBUG : test/testfile: newRWFileHandle:
2022/04/12 15:46:26 DEBUG : test/testfile: >newRWFileHandle: err=<nil>
2022/04/12 15:46:26 DEBUG : test/testfile: >Open: fd=test/testfile (rw), err=<nil>
2022/04/12 15:46:26 DEBUG : /test/testfile: >OpenFile: fd=test/testfile (rw), err=<nil>
2022/04/12 15:46:26 DEBUG : /test/testfile: >OpenEx: errc=0, fh=0x0
rclone[TID=3c44]: FFFF9E86CC92B800: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FBC0, GrantedAccess=80, FileInfo={FileAttributes=0, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-12T15:46:22.801Z, LastAccessTime=2022-04-12T15:46:22.801Z, LastWriteTime=2022-04-12T15:46:22.801Z, ChangeTime=2022-04-12T15:46:22.801Z, IndexNumber=0:11}
rclone[TID=3c44]: FFFF9E86C70244D0: >>Close 0000000000000000:000000000321FBC0
rclone[TID=1840]: FFFF9E86CC92B800: >>Create [UT---C] "\test\testfile", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006B4[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:26 DEBUG : /test/testfile: Flush: fh=0x0
2022/04/12 15:46:26 DEBUG : test/testfile(0xc0008e6080): RWFileHandle.Flush
2022/04/12 15:46:26 DEBUG : /test/testfile: >Flush: errc=0
2022/04/12 15:46:26 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test/testfile: Release: fh=0x0
2022/04/12 15:46:26 DEBUG : test/testfile(0xc0008e6080): RWFileHandle.Release
2022/04/12 15:46:26 DEBUG : /test/testfile: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : test/testfile(0xc0008e6080): close:
2022/04/12 15:46:26 DEBUG : test/testfile(0xc0008e6080): >close: err=<nil>
2022/04/12 15:46:26 DEBUG : /test/testfile: >Release: errc=0
2022/04/12 15:46:26 DEBUG : /test/testfile: Getattr: fh=0xFFFFFFFFFFFFFFFF
rclone[TID=3c44]: FFFF9E86C70244D0: <<Close IoStatus=0[0]
2022/04/12 15:46:26 DEBUG : /test/testfile: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test/testfile: OpenEx: flags=0x0
2022/04/12 15:46:26 DEBUG : /test/testfile: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:26 DEBUG : test/testfile: Open: flags=O_RDONLY
2022/04/12 15:46:26 DEBUG : test/testfile: newRWFileHandle:
2022/04/12 15:46:26 DEBUG : test/testfile: >newRWFileHandle: err=<nil>
2022/04/12 15:46:26 DEBUG : test/testfile: >Open: fd=test/testfile (rw), err=<nil>
2022/04/12 15:46:26 DEBUG : /test/testfile: >OpenFile: fd=test/testfile (rw), err=<nil>
2022/04/12 15:46:26 DEBUG : /test/testfile: >OpenEx: errc=0, fh=0x0
rclone[TID=1840]: FFFF9E86CC92B800: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321F920, GrantedAccess=80, FileInfo={FileAttributes=0, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-12T15:46:22.801Z, LastAccessTime=2022-04-12T15:46:22.801Z, LastWriteTime=2022-04-12T15:46:22.801Z, ChangeTime=2022-04-12T15:46:22.801Z, IndexNumber=0:11}
rclone[TID=1840]: FFFF9E86C70244D0: >>Close 0000000000000000:000000000321F920
2022/04/12 15:46:26 DEBUG : /test/testfile: Flush: fh=0x0
rclone[TID=3c44]: FFFF9E86CF5F5DE0: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000704[PID=2350], DesiredAccess=20000, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:26 DEBUG : test/testfile(0xc00059cb40): RWFileHandle.Flush
2022/04/12 15:46:26 DEBUG : /test/testfile: >Flush: errc=0
2022/04/12 15:46:26 DEBUG : /test/testfile: Release: fh=0x0
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : test/testfile(0xc00059cb40): RWFileHandle.Release
2022/04/12 15:46:26 DEBUG : test/testfile(0xc00059cb40): close:
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test: Opendir:
2022/04/12 15:46:26 DEBUG : test/testfile(0xc00059cb40): >close: err=<nil>
2022/04/12 15:46:26 DEBUG : /test/testfile: >Release: errc=0
rclone[TID=1840]: FFFF9E86C70244D0: <<Close IoStatus=0[0]
2022/04/12 15:46:26 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:26 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:26 DEBUG : /test: >Opendir: errc=0, fh=0x0
rclone[TID=3c44]: FFFF9E86CF5F5DE0: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321F8C0, GrantedAccess=20000, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
rclone[TID=3c44]: FFFF9E86CF5F5DE0: >>QuerySecurity 0000000000000000:000000000321F8C0
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86CF5F5DE0: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=3c44]: FFFF9E86C70244D0: >>Close 0000000000000000:000000000321F8C0
rclone[TID=1840]: FFFF9E86CF5F5DE0: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006B4[PID=2350], DesiredAccess=20000, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:26 DEBUG : /test: Releasedir: fh=0x0
2022/04/12 15:46:26 DEBUG : /test: >Releasedir: errc=0
rclone[TID=3c44]: FFFF9E86C70244D0: <<Close IoStatus=0[0]
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test: Opendir:
2022/04/12 15:46:26 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:26 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:26 DEBUG : /test: >Opendir: errc=0, fh=0x0
rclone[TID=1840]: FFFF9E86CF5F5DE0: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FD70, GrantedAccess=20000, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
rclone[TID=1840]: FFFF9E86CF5F5DE0: >>QuerySecurity 0000000000000000:000000000321FD70
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
rclone[TID=1840]: FFFF9E86CF5F5DE0: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=1840]: FFFF9E86C70244D0: >>Close 0000000000000000:000000000321FD70
rclone[TID=3c44]: FFFF9E86CF5F5DE0: >>Create [UT---C] "\", FILE_OPEN, CreateOptions=20, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=000000000000070C[PID=2350], DesiredAccess=100081, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:26 DEBUG : /test: Releasedir: fh=0x0
2022/04/12 15:46:26 DEBUG : /test: >Releasedir: errc=0
rclone[TID=1840]: FFFF9E86C70244D0: <<Close IoStatus=0[0]
2022/04/12 15:46:26 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /: Opendir:
2022/04/12 15:46:26 DEBUG : /: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:26 DEBUG : /: >OpenFile: fd=/ (r), err=<nil>
2022/04/12 15:46:26 DEBUG : /: >Opendir: errc=0, fh=0x0
rclone[TID=3c44]: FFFF9E86CF5F5DE0: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FA70, GrantedAccess=100081, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-12T15:46:07.276Z, LastAccessTime=2022-04-12T15:46:07.276Z, LastWriteTime=2022-04-12T15:46:07.276Z, ChangeTime=2022-04-12T15:46:07.276Z, IndexNumber=0:1}
rclone[TID=3c44]: FFFF9E86C70244D0: >>QueryInformation 0000000000000000:000000000321FA70
2022/04/12 15:46:26 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86C70244D0: <<QueryInformation IoStatus=0[0] FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-12T15:46:07.276Z, LastAccessTime=2022-04-12T15:46:07.276Z, LastWriteTime=2022-04-12T15:46:07.276Z, ChangeTime=2022-04-12T15:46:07.276Z, IndexNumber=0:1}
rclone[TID=3c44]: FFFF9E86CF5F5DE0: >>QuerySecurity 0000000000000000:000000000321FA70
2022/04/12 15:46:26 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86CF5F5DE0: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=3c44]: FFFF9E86D0483DE0: >>QueryDirectory 0000000000000000:000000000321FA70, Address=000000002BE30000, Length=616, Pattern="test", Marker=NULL
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86D0483DE0: <<QueryDirectory IoStatus=0[114]
rclone[TID=3c44]: FFFF9E86C8C3F7A0: >>Close 0000000000000000:000000000321FA70
2022/04/12 15:46:26 DEBUG : /: Releasedir: fh=0x0
2022/04/12 15:46:26 DEBUG : /: >Releasedir: errc=0
rclone[TID=3c44]: FFFF9E86C8C3F7A0: <<Close IoStatus=0[0]
rclone[TID=3c44]: FFFF9E86C8C3F7A0: >>Create [UT---C] "\", FILE_OPEN, CreateOptions=21, FileAttributes=10, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000704[PID=2350], DesiredAccess=100000, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:26 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /: Opendir:
2022/04/12 15:46:26 DEBUG : /: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:26 DEBUG : /: >OpenFile: fd=/ (r), err=<nil>
2022/04/12 15:46:26 DEBUG : /: >Opendir: errc=0, fh=0x0
rclone[TID=3c44]: FFFF9E86C8C3F7A0: <<Create IoStatus=0[1] UserContext=0000000000000000:00000000032200D0, GrantedAccess=100000, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-12T15:46:07.276Z, LastAccessTime=2022-04-12T15:46:07.276Z, LastWriteTime=2022-04-12T15:46:07.276Z, ChangeTime=2022-04-12T15:46:07.276Z, IndexNumber=0:1}
rclone[TID=3c44]: FFFF9E86C6FD6DE0: >>QueryVolumeInformation
2022/04/12 15:46:26 DEBUG : /: Statfs:
2022/04/12 15:46:26 DEBUG : /: >Statfs: stat={Bsize:4096 Frsize:4096 Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Favail:0 Fsid:0 Flag:0 Namemax:255}, errc=0
rclone[TID=3c44]: FFFF9E86C6FD6DE0: <<QueryVolumeInformation IoStatus=0[0] VolumeInfo={TotalSize=40000:0, FreeSize=40000:0, VolumeLabel="xyzdatablob"}
rclone[TID=3c44]: FFFF9E86C8103DC0: >>Close 0000000000000000:00000000032200D0
rclone[TID=1840]: FFFF9E86C9937DD0: >>Create [UT---C] "\", FILE_OPEN, CreateOptions=21, FileAttributes=10, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006B4[PID=2350], DesiredAccess=100000, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:26 DEBUG : /: Releasedir: fh=0x0
2022/04/12 15:46:26 DEBUG : /: >Releasedir: errc=0
rclone[TID=3c44]: FFFF9E86C8103DC0: <<Close IoStatus=0[0]
2022/04/12 15:46:26 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /: Opendir:
2022/04/12 15:46:26 DEBUG : /: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:26 DEBUG : /: >OpenFile: fd=/ (r), err=<nil>
2022/04/12 15:46:26 DEBUG : /: >Opendir: errc=0, fh=0x0
rclone[TID=1840]: FFFF9E86C9937DD0: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FD70, GrantedAccess=100000, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-12T15:46:07.276Z, LastAccessTime=2022-04-12T15:46:07.276Z, LastWriteTime=2022-04-12T15:46:07.276Z, ChangeTime=2022-04-12T15:46:07.276Z, IndexNumber=0:1}
rclone[TID=1840]: FFFF9E86C6FD6DE0: >>Close 0000000000000000:000000000321FD70
2022/04/12 15:46:26 DEBUG : /: Releasedir: fh=0x0
2022/04/12 15:46:26 DEBUG : /: >Releasedir: errc=0
rclone[TID=1840]: FFFF9E86C6FD6DE0: <<Close IoStatus=0[0]
rclone[TID=3c44]: FFFF9E86CF5F5DE0: >>Create [UT---C] "\test\desktop.ini", FILE_OPEN, CreateOptions=64, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=000000000000069C[PID=2350], DesiredAccess=120089, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:26 DEBUG : /test/desktop.ini: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test/desktop.ini: >Getattr: errc=-2
rclone[TID=3c44]: FFFF9E86CF5F5DE0: <<Create IoStatus=c0000034[0]
rclone[TID=3c44]: FFFF9E86CF5F5DE0: >>Create [UT---C] "\test\desktop.ini", FILE_OPEN, CreateOptions=64, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=000000000000069C[PID=2350], DesiredAccess=120089, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:26 DEBUG : /test/desktop.ini: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test/desktop.ini: >Getattr: errc=-2
rclone[TID=3c44]: FFFF9E86CF5F5DE0: <<Create IoStatus=c0000034[0]
rclone[TID=3c44]: FFFF9E86CF5F5DE0: >>Create [UT---C] "\test\folder.jpg", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=000000000000069C[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:26 DEBUG : /test/folder.jpg: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test/folder.jpg: >Getattr: errc=-2
rclone[TID=3c44]: FFFF9E86CF5F5DE0: <<Create IoStatus=c0000034[0]
rclone[TID=3c44]: FFFF9E86CF5F5DE0: >>Create [UT---C] "\test\folder.gif", FILE_OPEN, CreateOptions=200000, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=000000000000069C[PID=2350], DesiredAccess=80, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:26 DEBUG : /test/folder.gif: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test/folder.gif: >Getattr: errc=-2
rclone[TID=3c44]: FFFF9E86CF5F5DE0: <<Create IoStatus=c0000034[0]
rclone[TID=3c44]: FFFF9E86CF5F5DE0: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=20, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=000000000000069C[PID=2350], DesiredAccess=100081, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test: Opendir:
2022/04/12 15:46:26 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:26 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:26 DEBUG : /test: >Opendir: errc=0, fh=0x0
rclone[TID=3c44]: FFFF9E86CF5F5DE0: <<Create IoStatus=0[1] UserContext=0000000000000000:00000000032201F0, GrantedAccess=100081, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
rclone[TID=3c44]: FFFF9E86CF5F5DE0: >>QuerySecurity 0000000000000000:00000000032201F0
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86CF5F5DE0: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=3c44]: FFFF9E86CF5F5DE0: >>QueryDirectory 0000000000000000:00000000032201F0, Address=000000002BE30000, Length=16368, Pattern=NULL, Marker=NULL
2022/04/12 15:46:26 DEBUG : /test: Readdir: ofst=0, fh=0x0
2022/04/12 15:46:26 DEBUG : /test: >Readdir: items=1, errc=0
2022/04/12 15:46:26 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86CF5F5DE0: <<QueryDirectory IoStatus=0[346]
rclone[TID=3c44]: FFFF9E86C70244D0: >>Close 0000000000000000:00000000032201F0
rclone[TID=1840]: FFFF9E86C8C3F7A0: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=60, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006B4[PID=2350], DesiredAccess=100080, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:26 DEBUG : /test: Releasedir: fh=0x0
2022/04/12 15:46:26 DEBUG : /test: >Releasedir: errc=0
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
rclone[TID=1840]: FFFF9E86C8C3F7A0: <<Create IoStatus=c00000ba[0]
rclone[TID=3c44]: FFFF9E86C70244D0: <<Close IoStatus=0[0]
rclone[TID=1840]: FFFF9E86CF5F5DE0: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=200020, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006B4[PID=2350], DesiredAccess=100080, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test: Opendir:
2022/04/12 15:46:26 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:26 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:26 DEBUG : /test: >Opendir: errc=0, fh=0x0
rclone[TID=1840]: FFFF9E86CF5F5DE0: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FBC0, GrantedAccess=100080, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
rclone[TID=1840]: FFFF9E86CF5F5DE0: >>QuerySecurity 0000000000000000:000000000321FBC0
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
rclone[TID=1840]: FFFF9E86CF5F5DE0: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=1840]: FFFF9E86CF5F5DE0: >>FileSystemControl [FSCTL_GET_REPARSE_POINT] "\test", 0000000000000000:000000000321FBC0
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
rclone[TID=1840]: FFFF9E86CF5F5DE0: <<FileSystemControl IoStatus=c0000275[0]
rclone[TID=1840]: FFFF9E86C70244D0: >>Close 0000000000000000:000000000321FBC0
rclone[TID=3c44]: FFFF9E86CF5F5DE0: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=20, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000704[PID=2350], DesiredAccess=100080, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:26 DEBUG : /test: Releasedir: fh=0x0
2022/04/12 15:46:26 DEBUG : /test: >Releasedir: errc=0
rclone[TID=1840]: FFFF9E86C70244D0: <<Close IoStatus=0[0]
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test: Opendir:
2022/04/12 15:46:26 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:26 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:26 DEBUG : /test: >Opendir: errc=0, fh=0x0
rclone[TID=3c44]: FFFF9E86CF5F5DE0: <<Create IoStatus=0[1] UserContext=0000000000000000:00000000032203A0, GrantedAccess=100080, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
rclone[TID=3c44]: FFFF9E86CF5F5DE0: >>QuerySecurity 0000000000000000:00000000032203A0
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86CF5F5DE0: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=3c44]: FFFF9E86C70244D0: >>Close 0000000000000000:00000000032203A0
rclone[TID=1840]: FFFF9E86CF5F5DE0: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=10, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006B4[PID=2350], DesiredAccess=100080, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:26 DEBUG : /test: Releasedir: fh=0x0
2022/04/12 15:46:26 DEBUG : /test: >Releasedir: errc=0
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86C70244D0: <<Close IoStatus=0[0]
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test: Opendir:
2022/04/12 15:46:26 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:26 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:26 DEBUG : /test: >Opendir: errc=0, fh=0x0
rclone[TID=1840]: FFFF9E86CF5F5DE0: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FEF0, GrantedAccess=100080, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
rclone[TID=1840]: FFFF9E86CF5F5DE0: >>QuerySecurity 0000000000000000:000000000321FEF0
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
rclone[TID=1840]: FFFF9E86CF5F5DE0: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=1840]: FFFF9E86C70244D0: >>Close 0000000000000000:000000000321FEF0
rclone[TID=3c44]: FFFF9E86CF5F5DE0: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=200020, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006FC[PID=2350], DesiredAccess=100080, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:26 DEBUG : /test: Releasedir: fh=0x0
2022/04/12 15:46:26 DEBUG : /test: >Releasedir: errc=0
rclone[TID=1840]: FFFF9E86C70244D0: <<Close IoStatus=0[0]
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:26 DEBUG : /test: Opendir:
2022/04/12 15:46:26 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:26 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:26 DEBUG : /test: >Opendir: errc=0, fh=0x0
rclone[TID=3c44]: FFFF9E86CF5F5DE0: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321F950, GrantedAccess=100080, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
rclone[TID=3c44]: FFFF9E86CF5F5DE0: >>QuerySecurity 0000000000000000:000000000321F950
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86CF5F5DE0: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=3c44]: FFFF9E86C6FD6DE0: >>FileSystemControl [FSCTL_GET_REPARSE_POINT] "\test", 0000000000000000:000000000321F950
2022/04/12 15:46:26 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86C6FD6DE0: <<FileSystemControl IoStatus=c0000275[0]
rclone[TID=3c44]: FFFF9E86C8103DC0: >>Close 0000000000000000:000000000321F950
2022/04/12 15:46:26 DEBUG : /test: Releasedir: fh=0x0
2022/04/12 15:46:26 DEBUG : /test: >Releasedir: errc=0
rclone[TID=3c44]: FFFF9E86C8103DC0: <<Close IoStatus=0[0]
rclone[TID=3c44]: FFFF9E86CC975DC0: >>Create [UT---C] "\test\desktop.ini", FILE_OPEN, CreateOptions=64, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006D8[PID=2350], DesiredAccess=120089, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:26 DEBUG : /test/desktop.ini: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:26 DEBUG : /test/desktop.ini: >Getattr: errc=-2
rclone[TID=3c44]: FFFF9E86CC975DC0: <<Create IoStatus=c0000034[0]
2022/04/12 15:46:27 DEBUG : test/testfile: vfs cache: starting upload
2022/04/12 15:46:27 DEBUG : test/testfile: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2022/04/12 15:46:27 INFO  : test/testfile: Copied (new)
2022/04/12 15:46:27 DEBUG : test/testfile: vfs cache: fingerprint now "0,2022-04-12 15:46:22.8018157 +0000 UTC,d41d8cd98f00b204e9800998ecf8427e"
2022/04/12 15:46:27 DEBUG : test/testfile: vfs cache: writeback object to VFS layer
2022/04/12 15:46:27 DEBUG : test: Added virtual directory entry vAddFile: "testfile"
2022/04/12 15:46:27 INFO  : test/testfile: vfs cache: upload succeeded try #1
rclone[TID=3c44]: FFFF9E86D0483DE0: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=0, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000718[PID=2350], DesiredAccess=100081, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:28 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:28 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:28 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:28 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:28 DEBUG : /test: Opendir:
rclone[TID=1840]: FFFF9E86C6BC59B0: >>Create [UT---C] "\", FILE_OPEN, CreateOptions=20, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006F4[PID=2350], DesiredAccess=100081, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:28 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:28 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:28 DEBUG : /test: >Opendir: errc=0, fh=0x0
rclone[TID=3c44]: FFFF9E86D0483DE0: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FF50, GrantedAccess=100081, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
2022/04/12 15:46:28 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:28 DEBUG : /: >Getattr: errc=0
rclone[TID=3c44]: FFFF9E86D0483DE0: >>QuerySecurity 0000000000000000:000000000321FF50
2022/04/12 15:46:28 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:28 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:28 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:28 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:28 DEBUG : /: Opendir:
rclone[TID=3c44]: FFFF9E86D0483DE0: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
2022/04/12 15:46:28 DEBUG : /: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
rclone[TID=3c44]: FFFF9E86D0483DE0: >>Create [UT---C] "\test", FILE_OPEN, CreateOptions=0, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=0000000000000718[PID=2350], DesiredAccess=100081, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:28 DEBUG : /: >OpenFile: fd=/ (r), err=<nil>
2022/04/12 15:46:28 DEBUG : /: >Opendir: errc=0, fh=0x3
rclone[TID=1840]: FFFF9E86C6BC59B0: <<Create IoStatus=0[1] UserContext=0000000000000000:0000000003220040, GrantedAccess=100081, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-12T15:46:07.276Z, LastAccessTime=2022-04-12T15:46:07.276Z, LastWriteTime=2022-04-12T15:46:07.276Z, ChangeTime=2022-04-12T15:46:07.276Z, IndexNumber=0:1}
2022/04/12 15:46:28 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
rclone[TID=1840]: FFFF9E86CBF52E00: >>QueryInformation 0000000000000000:0000000003220040
2022/04/12 15:46:28 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:28 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:28 DEBUG : /test: >Getattr: errc=0
2022/04/12 15:46:28 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:28 DEBUG : /test: Opendir:
2022/04/12 15:46:28 DEBUG : /: >Getattr: errc=0
rclone[TID=1840]: FFFF9E86CBF52E00: <<QueryInformation IoStatus=0[0] FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-12T15:46:07.276Z, LastAccessTime=2022-04-12T15:46:07.276Z, LastWriteTime=2022-04-12T15:46:07.276Z, ChangeTime=2022-04-12T15:46:07.276Z, IndexNumber=0:1}
2022/04/12 15:46:28 DEBUG : /test: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
rclone[TID=1840]: FFFF9E86CBF52E00: >>QuerySecurity 0000000000000000:0000000003220040
2022/04/12 15:46:28 DEBUG : /test: >OpenFile: fd=test/ (r), err=<nil>
2022/04/12 15:46:28 DEBUG : /test: >Opendir: errc=0, fh=0x4
rclone[TID=3c44]: FFFF9E86D0483DE0: <<Create IoStatus=0[1] UserContext=0000000000000000:00000000032202E0, GrantedAccess=100081, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-05T18:27:08.000Z, LastAccessTime=2022-04-05T18:27:08.000Z, LastWriteTime=2022-04-05T18:27:08.000Z, ChangeTime=2022-04-05T18:27:08.000Z, IndexNumber=0:10}
2022/04/12 15:46:28 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:28 DEBUG : /: >Getattr: errc=0
rclone[TID=1840]: FFFF9E86CBF52E00: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=1840]: FFFF9E86CBF52E00: >>QueryDirectory 0000000000000000:0000000003220040, Address=000000002BE30000, Length=616, Pattern="test", Marker=NULL
2022/04/12 15:46:28 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:28 DEBUG : /test: >Getattr: errc=0
rclone[TID=1840]: FFFF9E86CBF52E00: <<QueryDirectory IoStatus=0[114]
rclone[TID=1840]: FFFF9E86C2140DD0: >>Close 0000000000000000:0000000003220040
2022/04/12 15:46:28 DEBUG : /: Releasedir: fh=0x3
2022/04/12 15:46:28 DEBUG : /: >Releasedir: errc=0
rclone[TID=1840]: FFFF9E86C2140DD0: <<Close IoStatus=0[0]
rclone[TID=1840]: FFFF9E86C6BC59B0: >>Create [UT---C] "\", FILE_OPEN, CreateOptions=20, FileAttributes=0, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006F8[PID=2350], DesiredAccess=100081, GrantedAccess=0, ShareAccess=7
2022/04/12 15:46:28 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:28 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:28 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:28 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:28 DEBUG : /: Opendir:
2022/04/12 15:46:28 DEBUG : /: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:28 DEBUG : /: >OpenFile: fd=/ (r), err=<nil>
2022/04/12 15:46:28 DEBUG : /: >Opendir: errc=0, fh=0x3
rclone[TID=1840]: FFFF9E86C6BC59B0: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FC50, GrantedAccess=100081, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-12T15:46:07.276Z, LastAccessTime=2022-04-12T15:46:07.276Z, LastWriteTime=2022-04-12T15:46:07.276Z, ChangeTime=2022-04-12T15:46:07.276Z, IndexNumber=0:1}
rclone[TID=1840]: FFFF9E86C2140DD0: >>QueryDirectory 0000000000000000:000000000321FC50, Address=000000002BE30000, Length=616, Pattern="test", Marker=NULL
2022/04/12 15:46:28 DEBUG : /test: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:28 DEBUG : /test: >Getattr: errc=0
rclone[TID=1840]: FFFF9E86C2140DD0: <<QueryDirectory IoStatus=0[114]
rclone[TID=1840]: FFFF9E86CBF52E00: >>Close 0000000000000000:000000000321FC50
2022/04/12 15:46:28 DEBUG : /: Releasedir: fh=0x3
2022/04/12 15:46:28 DEBUG : /: >Releasedir: errc=0
rclone[TID=1840]: FFFF9E86CBF52E00: <<Close IoStatus=0[0]
rclone[TID=1840]: FFFF9E86C8103DC0: >>Create [UT---C] "\", FILE_OPEN, CreateOptions=21, FileAttributes=10, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006F8[PID=2350], DesiredAccess=100000, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:28 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:28 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:28 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:28 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:28 DEBUG : /: Opendir:
2022/04/12 15:46:28 DEBUG : /: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:29 DEBUG : /: >OpenFile: fd=/ (r), err=<nil>
2022/04/12 15:46:29 DEBUG : /: >Opendir: errc=0, fh=0x3
rclone[TID=1840]: FFFF9E86C8103DC0: <<Create IoStatus=0[1] UserContext=0000000000000000:000000000321FB90, GrantedAccess=100000, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-12T15:46:07.276Z, LastAccessTime=2022-04-12T15:46:07.276Z, LastWriteTime=2022-04-12T15:46:07.276Z, ChangeTime=2022-04-12T15:46:07.276Z, IndexNumber=0:1}
rclone[TID=1840]: FFFF9E86C8103DC0: >>QueryVolumeInformation
2022/04/12 15:46:29 DEBUG : /: Statfs:
2022/04/12 15:46:29 DEBUG : /: >Statfs: stat={Bsize:4096 Frsize:4096 Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Favail:0 Fsid:0 Flag:0 Namemax:255}, errc=0
rclone[TID=1840]: FFFF9E86C8103DC0: <<QueryVolumeInformation IoStatus=0[0] VolumeInfo={TotalSize=40000:0, FreeSize=40000:0, VolumeLabel="xyzdatablob"}
rclone[TID=1840]: FFFF9E86C6FD6DE0: >>Close 0000000000000000:000000000321FB90
2022/04/12 15:46:29 DEBUG : /: Releasedir: fh=0x3
2022/04/12 15:46:29 DEBUG : /: >Releasedir: errc=0
rclone[TID=1840]: FFFF9E86C6FD6DE0: <<Close IoStatus=0[0]
rclone[TID=1840]: FFFF9E86C6FD6DE0: >>Create [UT---C] "\", FILE_OPEN, CreateOptions=21, FileAttributes=10, Security=NULL, AllocationSize=0:0, AccessToken=00000000000006F8[PID=2350], DesiredAccess=100000, GrantedAccess=0, ShareAccess=3
2022/04/12 15:46:30 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:30 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:30 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:30 DEBUG : /: >Getattr: errc=0
2022/04/12 15:46:30 DEBUG : /: Opendir:
2022/04/12 15:46:30 DEBUG : /: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx
2022/04/12 15:46:30 DEBUG : /: >OpenFile: fd=/ (r), err=<nil>
2022/04/12 15:46:30 DEBUG : /: >Opendir: errc=0, fh=0x3
rclone[TID=1840]: FFFF9E86C6FD6DE0: <<Create IoStatus=0[1] UserContext=0000000000000000:0000000003220280, GrantedAccess=100000, FileInfo={FileAttributes=10, ReparseTag=0, AllocationSize=0:0, FileSize=0:0, CreationTime=2022-04-12T15:46:07.276Z, LastAccessTime=2022-04-12T15:46:07.276Z, LastWriteTime=2022-04-12T15:46:07.276Z, ChangeTime=2022-04-12T15:46:07.276Z, IndexNumber=0:1}
rclone[TID=1840]: FFFF9E86C6FD6DE0: >>QuerySecurity 0000000000000000:0000000003220280
2022/04/12 15:46:30 DEBUG : /: Getattr: fh=0xFFFFFFFFFFFFFFFF
2022/04/12 15:46:30 DEBUG : /: >Getattr: errc=0
rclone[TID=1840]: FFFF9E86C6FD6DE0: <<QuerySecurity IoStatus=0[0] Security="O:S-1-0-65534G:AUD:P(A;;FA;;;S-1-0-65534)(A;;0x1201ef;;;AU)(A;;0x1201ef;;;WD)"
rclone[TID=1840]: FFFF9E86C6FD6DE0: >>QueryVolumeInformation
2022/04/12 15:46:30 DEBUG : /: Statfs:
2022/04/12 15:46:30 DEBUG : /: >Statfs: stat={Bsize:4096 Frsize:4096 Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Favail:0 Fsid:0 Flag:0 Namemax:255}, errc=0
rclone[TID=1840]: FFFF9E86C6FD6DE0: <<QueryVolumeInformation IoStatus=0[0] VolumeInfo={TotalSize=40000:0, FreeSize=40000:0, VolumeLabel="xyzdatablob"}
rclone[TID=1840]: FFFF9E86C6ACF950: >>Close 0000000000000000:0000000003220280
2022/04/12 15:46:30 DEBUG : /: Releasedir: fh=0x3
2022/04/12 15:46:30 DEBUG : /: >Releasedir: errc=0
rclone[TID=1840]: FFFF9E86C6ACF950: <<Close IoStatus=0[0]
The service rclone has been stopped.
2022/04/12 15:46:33 DEBUG : Azure root: Destroy: