Ignore Permissions / Different mtimes on Android Sdcard

rahrah · June 20, 2019, 5:54pm

Hello,

Your fix was here, right(?):

commit b7c70a981734803f5dbf45acd6bd2a643c1d75cf
Author: Audrius Butkevicius <audrius.butkevicius@gmail.com>
Date:   Tue Jun 11 07:27:13 2019 +0100

    lib/fs: Enhance mtimefs, use everywhere (fixes #5777) (#5776)

From the log I grepped:

[XHTJH] INFO: syncthing v1.2.0-preview.2-1-g93e428a8 "Fermium Flea" (go1.12.6 android-arm64) rah@xxx.xxx.xxx.xxx 2019-06-19 17:06:08 UTC

Note the: -g93e428a8

From my android build tree:

syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing

git log b7c70a981734803f5dbf45acd6bd2a643c1d75c^^..HEAD |grep ^commit

commit 93e428a8d424f8253c6c0b33a77d3820bc0b7926
commit bf744ded311cdeac6234bce95a8a4871baaefcc0
commit 0d8616689069a689fbc8b6eb0726d6dde85627f0
commit cea59624170c42ac49f0341f5722759d5cfb1e62
commit 02752af86233849746c638f3e8cbbd78cce46878
commit 6b1d7ac727c523d11096e99ed3faaadd8ad095d1
commit abd363e8bb8d2abe34601f3657a9badbbc0b8b27
commit bff1a5f5e446924b875e23232f9d4d178b253c09
commit 38302270d40aefb2394fd7bd6ad31a30d69b7006
commit 1b4fe39a89cf238c66eb1b89650ea1d09ef52aab
commit 6b74cdc6138a0e07f1954eb03ad479438082a8b1
commit 13a746e0fb2e58736a054e5712ff65d8b99f1213
commit 21f50e2f8fb57f30ffc313a115350f0ef9abdd06
commit b7c70a981734803f5dbf45acd6bd2a643c1d75cf
commit 42ce6be9b90981917af85274315a8da07924429c

The commit 93e428a8d424f8253c6c0b33a77d3820bc0b7926 is just me adding Jakob’s patch back in:

git log -p -1

commit 93e428a8d424f8253c6c0b33a77d3820bc0b7926
Author: Richard Hoyle <rah@xxx.xxx.xxx.xx>
Date:   Wed Jun 19 18:06:08 2019 +0100

    Add Debug Statements to mtimefs.go
    
    Add Jakob Borg's (calmh's) debug statements
    as per:
    
    https://forum.syncthing.net/t/ignore-permissions-different-mtimes-on-android-sdcard/13342/17
    
    modified:   lib/fs/mtimefs.go

diff --git a/lib/fs/mtimefs.go b/lib/fs/mtimefs.go
index 199fb8ac..c086f9e4 100644
--- a/lib/fs/mtimefs.go
+++ b/lib/fs/mtimefs.go
@@ -59,6 +59,7 @@ func (f *MtimeFS) Chtimes(name string, atime, mtime time.Time) error {
  // because it might be "does not exist" or similar.
  info, err := f.Filesystem.Lstat(name)
  if err != nil {
+  l.Debugln("Chtimes: Lstat:", err)
   return err
  }
 
@@ -86,6 +87,7 @@ func (f *MtimeFS) Stat(name string) (FileInfo, error) {
 func (f *MtimeFS) Lstat(name string) (FileInfo, error) {
  info, err := f.Filesystem.Lstat(name)
  if err != nil {
+  l.Debugln("Lstat:", err)
   return nil, err
  }
 
@@ -150,6 +152,7 @@ func (f *MtimeFS) save(name string, real, virtual time.Time) {
  if real.Equal(virtual) {
   // If the virtual time and the real on disk time are equal we don't
   // need to store anything.
+  l.Debugf("save: clearing saved for %s, time is %v", name, real)
   f.db.Delete(name)
   return
  }
@@ -159,6 +162,7 @@ func (f *MtimeFS) save(name string, real, virtual time.Time) {
   virtual: virtual,
  }
  bs, _ := mtime.Marshal() // Can't fail
+ l.Debugf("save: saving %v / %v for %s", real, virtual, name)
  f.db.PutBytes(name, bs)
 }
 
@@ -169,14 +173,16 @@ func (f *MtimeFS) load(name string) (real, virtual time.Time) {
 
  data, exists := f.db.Bytes(name)
  if !exists {
+  l.Debugln("load: nothing for", name)
   return
  }
 
  var mtime dbMtime
  if err := mtime.Unmarshal(data); err != nil {
+  l.Debugln("load: unmarshal error for", name)
   return
  }
-
+ l.Debugf("load: loaded %v / %v for %s", mtime.real, mtime.virtual, name)
  return mtime.real, mtime.virtual
 }

Since my commit, 93e428a8d, is included as evinced from the git log, with the output statements and the git describe string as per catfriend1’s code, I guess I’d go as far as 95% certain! I’d definitely bet you 50 GBP that it’s there given (and that’s where my doubt lies, now) that your fix was:

b7c70a981734803f5dbf45acd6bd2a643c1d75cf

Hope that’s the commit!

===R

AudriusButkevicius · June 20, 2019, 7:30pm

Right. I need to look into this more and write a better test case I guess.

Catfriend1 · June 20, 2019, 8:10pm

Probably deleting the /src/main/jnilibs folder is necessary for gradle to recognize the change. To be 100% sure, exec gradlew clean cleanNative before starting. Had that problem in the past that I thought gradlew buildNative was uptodate.

rahrah · June 21, 2019, 12:06am

@catfriend1 As you know, my Android build foo is not exactly stellar. The whole clean build thing was clearly an issue so, initially, I zapped the whole tree, and started afresh.

I’ve now got down to naively doing this (which almost certainly wastes time and has redundant steps):

#Zap the lot
rm -rf app/src/main/jniLibs
find syncthing/pkg -type d -exec chmod u+w {} \;
rm -rf syncthing/pkg

#Try to build the go stuff a la catfriend1
cd syncthing
python build-syncthing.py
cd ..

#Clean again
rm -rf app/src/main/jniLibs
#Clean as per gradle
./gradlew cleanNative

#Build
./gradlew buildNative
./gradlew lint assembleDebug

#How did I do
find . -iname \*libsyncthing.so\* -ls
find . -iname \*.apk -ls

I’m reasonably sure that I have good grounds for believing AB’s code is incorporated into the build, especially because the tree I started with was brand spanking new two days ago, and the file I patched already had AB’s changes in it.

I’m very grateful for the time and effort you’ve spent helping me understand the ins and outs of the Android/Gradle build process and your helpful explanations regarding signing debug apps (via PMs).

===R

AudriusButkevicius · June 21, 2019, 11:11pm

Can you try this branch and report back with the logs? There is a suspect as to what can cause this, but the logs will be a lot more verbose this time.

rahrah · June 22, 2019, 12:55am

Hello,

Here are the logs for one file created with code on your new branch: d7187f35.

[XHTJH] DEBUG: load: loaded 2019-05-17 19:05:41 +0000 UTC / 2019-05-17 19:05:41.214081426 +0000 UTC (2019-05-17 19:05:40 +0000 UTC) for C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ (false false)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ goroutine 136 [running]:
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ runtime/debug.Stack(0x4000d1b828, 0x4000ab5220, 0x1e)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /usr/lib64/go1.12.6/go/src/runtime/debug/stack.go:24 +0x80
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*MtimeFS).load(0x4000916120, 0x4002849620, 0x5b, 0x0, 0xed470fd04, 0x60c622e800, 0x5b, 0x40022f2e2e, 0x0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/mtimefs.go:181 +0x98
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*MtimeFS).Walk.func1(0x4002849620, 0x5b, 0x60c5c36140, 0x400046eaa0, 0x0, 0x0, 0x0, 0x60c51733fc)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/mtimefs.go:105 +0xc0
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*walkFilesystem).walk(0x4000166920, 0x4002849620, 0x5b, 0x60c5c36140, 0x400046eaa0, 0x40009dc060, 0x0, 0x0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/walkfs.go:46 +0x6c
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*walkFilesystem).walk(0x4000166920, 0x4000c8c2d0, 0x44, 0x60c5c36140, 0x400014e580, 0x40009dc060, 0x0, 0x0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/walkfs.go:71 +0x310
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*walkFilesystem).walk(0x4000166920, 0x40008a84b0, 0x2d, 0x60c5c36140, 0x400014e400, 0x40009dc060, 0x0, 0x0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/walkfs.go:71 +0x310
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*walkFilesystem).walk(0x4000166920, 0x40009268c0, 0x16, 0x60c5c36140, 0x400014e270, 0x40009dc060, 0x0, 0x0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/walkfs.go:71 +0x310
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*walkFilesystem).walk(0x4000166920, 0x60c548a7ed, 0x1, 0x60c5c36140, 0x400014e040, 0x40009dc060, 0x0, 0x0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/walkfs.go:71 +0x310
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*walkFilesystem).Walk(0x4000166920, 0x60c548a7ed, 0x1, 0x40009dc060, 0x4000b1c000, 0x73a52cc1f0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/walkfs.go:93 +0xac
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*logFilesystem).Walk(0x4000166930, 0x60c548a7ed, 0x1, 0x40009dc060, 0x60c622e800, 0x400014e030)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/logfs.go:126 +0x44
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*MtimeFS).Walk(0x4000916120, 0x60c548a7ed, 0x1, 0x40008bc2d0, 0x4000d1c360, 0x40008bc2d0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/mtimefs.go:103 +0x7c
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/scanner.(*walker).walk.func1(0x400089e100, 0x60c5c2e840, 0x400015ec80, 0x4000d1c300, 0x4000d1c360)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/scanner/walk.go:109 +0xfc
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ created by github.com/syncthing/syncthing/lib/scanner.(*walker).walk
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/scanner/walk.go:106 +0x15c
[XHTJH] DEBUG: mtimefs.go:88 basic /storage/B977-5AE1/Android/data/com.github.catfriend1.syncthingandroid.debug/st/crypted-shared Lstat C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ {0x40016232c0} <nil>
[XHTJH] DEBUG: load: loaded 2019-05-17 19:05:41 +0000 UTC / 2019-05-17 19:05:41.214081426 +0000 UTC (2019-05-17 19:05:40 +0000 UTC) for C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ (false false)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ goroutine 136 [running]:
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ runtime/debug.Stack(0x4000d1b5a8, 0x4000927ca0, 0x1e)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /usr/lib64/go1.12.6/go/src/runtime/debug/stack.go:24 +0x80
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*MtimeFS).load(0x4000916120, 0x4002849620, 0x5b, 0x0, 0xed470fd04, 0x60c622e800, 0x0, 0x60c53d354c, 0x4000671680)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/mtimefs.go:181 +0x98
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*MtimeFS).Lstat(0x4000916120, 0x4002849620, 0x5b, 0x40000d2078, 0x0, 0x2, 0x40000d2000)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/mtimefs.go:94 +0x17c
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/scanner.(*walker).handleItem(0x400089e100, 0x60c5c2e840, 0x400015ec80, 0x4002849620, 0x5b, 0x4000d1c300, 0x4000d1c360, 0x0, 0x0, 0x60c4e368f0, ...)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/scanner/walk.go:289 +0x3c
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/scanner.(*walker).walkAndHashFiles.func1(0x4002849620, 0x5b, 0x60c5c361a0, 0x400089a6c0, 0x0, 0x0, 0x0, 0xed470fd04)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/scanner/walk.go:259 +0x974
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*MtimeFS).Walk.func1(0x4002849620, 0x5b, 0x60c5c36140, 0x400046eaa0, 0x0, 0x0, 0x0, 0x60c51733fc)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/mtimefs.go:111 +0x5c
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*walkFilesystem).walk(0x4000166920, 0x4002849620, 0x5b, 0x60c5c36140, 0x400046eaa0, 0x40009dc060, 0x0, 0x0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/walkfs.go:46 +0x6c
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*walkFilesystem).walk(0x4000166920, 0x4000c8c2d0, 0x44, 0x60c5c36140, 0x400014e580, 0x40009dc060, 0x0, 0x0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/walkfs.go:71 +0x310
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*walkFilesystem).walk(0x4000166920, 0x40008a84b0, 0x2d, 0x60c5c36140, 0x400014e400, 0x40009dc060, 0x0, 0x0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/walkfs.go:71 +0x310
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*walkFilesystem).walk(0x4000166920, 0x40009268c0, 0x16, 0x60c5c36140, 0x400014e270, 0x40009dc060, 0x0, 0x0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/walkfs.go:71 +0x310
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*walkFilesystem).walk(0x4000166920, 0x60c548a7ed, 0x1, 0x60c5c36140, 0x400014e040, 0x40009dc060, 0x0, 0x0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/walkfs.go:71 +0x310
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*walkFilesystem).Walk(0x4000166920, 0x60c548a7ed, 0x1, 0x40009dc060, 0x4000b1c000, 0x73a52cc1f0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/walkfs.go:93 +0xac
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*logFilesystem).Walk(0x4000166930, 0x60c548a7ed, 0x1, 0x40009dc060, 0x60c622e800, 0x400014e030)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/logfs.go:126 +0x44
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*MtimeFS).Walk(0x4000916120, 0x60c548a7ed, 0x1, 0x40008bc2d0, 0x4000d1c360, 0x40008bc2d0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/mtimefs.go:103 +0x7c
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/scanner.(*walker).walk.func1(0x400089e100, 0x60c5c2e840, 0x400015ec80, 0x4000d1c300, 0x4000d1c360)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/scanner/walk.go:109 +0xfc
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ created by github.com/syncthing/syncthing/lib/scanner.(*walker).walk
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/scanner/walk.go:106 +0x15c
[XHTJH] DEBUG: mtimefs.go:88 basic /storage/B977-5AE1/Android/data/com.github.catfriend1.syncthingandroid.debug/st/crypted-shared Lstat C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ {0x4000d8bec0} <nil>
[XHTJH] DEBUG: load: loaded 2019-05-17 19:05:41 +0000 UTC / 2019-05-17 19:05:41.214081426 +0000 UTC (2019-05-17 19:05:40 +0000 UTC) for C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ (false false)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ goroutine 63 [running]:
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ runtime/debug.Stack(0x4000c8feb8, 0x4001303b00, 0x1e)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /usr/lib64/go1.12.6/go/src/runtime/debug/stack.go:24 +0x80
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*MtimeFS).load(0x4000916120, 0x4000768de0, 0x5b, 0x0, 0xed470fd04, 0x60c622e800, 0x0, 0x60c54189ec, 0x400016ac08)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/mtimefs.go:181 +0x98
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*MtimeFS).Lstat(0x4000916120, 0x4000768de0, 0x5b, 0x2d, 0x0, 0x0, 0x0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/mtimefs.go:94 +0x17c
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/osutil.IsDeleted(0x60c5c3b660, 0x4000916120, 0x4000768de0, 0x5b, 0x40016ce000)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/osutil/osutil.go:164 +0x38
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/model.(*folder).scanSubdirs.func6(0x60c5c39e80, 0x4000d84d80, 0x60c5c39e80)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/model/folder.go:479 +0x454
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/db.nativeFileIterator.func1(0x60c5c39e80, 0x4000d84cf0, 0x1800)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/db/set.go:316 +0x138
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/db.(*instance).withHave(0x4000164900, 0x4001242500, 0xb, 0x10, 0x4001303420, 0x20, 0x20, 0x60c6251778, 0x0, 0x0, ...)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/db/instance.go:153 +0x328
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/db.(*FileSet).WithPrefixedHaveTruncated(0x400015ebc0, 0xffffffffffffffff, 0xffffffffffffffff, 0xffffffffffffffff, 0xffffffffffffffff, 0x60c548a7e0, 0x0, 0x4001200dc0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/db/set.go:184 +0x268
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/model.(*folder).scanSubdirs(0x4000115600, 0x0, 0x1, 0x0, 0x0, 0x0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/model/folder.go:428 +0x76c
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/model.(*folder).scanTimerFired(0x4000115600)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/model/folder.go:541 +0x30
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/model.(*folder).Serve(0x4000115600)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/model/folder.go:178 +0x628
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/thejerf/suture.(*Supervisor).runService.func1(0x40002a3860, 0x4000000004, 0x73a5207568, 0x4000168280)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/pkg/mod/github.com/thejerf/suture@v3.0.2+incompatible/supervisor.go:600 +0x34
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ created by github.com/thejerf/suture.(*Supervisor).runService
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/pkg/mod/github.com/thejerf/suture@v3.0.2+incompatible/supervisor.go:588 +0x4c
[XHTJH] DEBUG: receiveonly/cpdpj-ytgwa@0x4000115600 taking shortcut on C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ
[XHTJH] DEBUG: mtimefs.go:59 basic /storage/B977-5AE1/Android/data/com.github.catfriend1.syncthingandroid.debug/st/crypted-shared Chtimes C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ 2019-05-17 19:05:41.214081426 +0000 UTC 2019-05-17 19:05:41.214081426 +0000 UTC <nil>
[XHTJH] DEBUG: mtimefs.go:63 basic /storage/B977-5AE1/Android/data/com.github.catfriend1.syncthingandroid.debug/st/crypted-shared Lstat C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ {0x4002de0540} <nil>
[XHTJH] DEBUG: save: saving 2019-05-17 19:05:41 +0000 UTC / 2019-05-17 19:05:41.214081426 +0000 UTC for C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ

Attached in next message. Firefox keeps crashing on upload. I’m not going to report that! ;^)

Thanks again!

===Rich

rahrah · June 22, 2019, 1:11am

Chromium crashed, too, in the same place. Too late to investigate further.

The best I can do is past a base64 encoded version of the file above in .tgz format.


H4sIAAAAAAAAA+2c61PbOBDA+dy/wh+hd7ElWZZl5uam74POXQsNLX1MpyPLcmIwdsZ2eNzN/e8n
yXkYErhcD1KDtR9MhJ2Jsr9daVe7UFbfRqysxDeEjsYZDOzqvNq4ZQFSCMbqJ/Q9oMewHkvxMCZ4
A7oecJGPsU82AHRdD29Y4LYnskzGZcUKy9oo2PBfnhNFuY4JrVe+fNw5eL3z1Xrx8tn737atNGdR
fRWRhQAMesDrQd+CwTbwtjG0flLIrPcHzy1n2X0bQQwoxIg0ntxcfBDMb29ZcV5Yz9ERffPm4757
trM3rILBnt8vdvYd9/TtKH43+jzCz86eCjrqfU5f9weOuzPef3s+3ue09243fZFjUMKTpw7YDT/9
iY/2wOGH6jP79AF/ZG8u9q3NmKWlsPR169GVb3yXHzzIi3xcJZmwoEusL8U4y5Js8HV7nXOQH1ol
J8KJRDge2P2K8eNNcI6l8iMYUkR/tuoRCz2EgBrB9SrJcsZl4aRJSLAzyKENkU3kC6csuHNp8k6p
Jm8P8m2EpfmcU7BWlkk1HIc2z0+c8iLj1VCSbLyS83fi0t58/Iea8Kv+lq2caKLpABJY61aOEMUB
qUdeqK76pYiwD+IIYDUggBOEBAWNp9Q7UYwEEvo9a0Y0zCWF81gU9YVlUZEnkVNGx45cOJ2n9bhf
jaMk3yvyI8Grcq6d3uT5nnq2oT1JeCW1OidKqVK9kj2kahE6D2ir4R+y9NiOxxmHm8uhS8Qed4lc
LacOiIlgDMwMYn5Rj0LfdWPeXejAU9B5Kz3+TLJ+laSivJBx1MmWrcYTx4eEBNc7/k02oJeNiAPS
MIZu4VdqrOljFUycE36f4QNOOYrqEV4OH2LhUQP/CnxfL/cuvNeuDyijONQjFF1LHwND/0HSDxCh
vI6tybX0kW/oPzj6ijSmzBfa6+G18AE28O8z/MMV4V8GrEYh5KBe932XeYhzGHcWeeAq5KyVgV6a
D24A7q4G/HJiP/V9t2PApSonaZ0+JpQBcRuBX8rlFw5yrkFNw1mUr0/Y5EIPLt/rFupLObz2br9t
3l1ylmWimCzqoqh38ubhDaCBgGCGnUsHbmzenuD0EnFwhX+HiE90qZf0mnmgmMdrZc4LwSoRWeHF
9+PvMjK9JkNvgVnDlym1QlYm3HLKKi/YQDjPAt/veU9fwulsnYhVzJGfbE8nwaq4SEQWQXs2g8nM
7en5vsOLi5Fk1yuHrJAIfy8rVt2p8v/SngoJchEHf1u/ZEn669UvbopinSqKeWxWFAuQz5kpirWw
KDbbjd3I9TCfAiM+JLRLO+59LI7pVX0lK1BPgAgBn86Yo+bvQXdRB9rd4T0Ip4fyW6diV6bN/zWc
XmoPy0LshYIpFi6hsRzZtt0hE7kazCGq42+3/UaifkrV7LByqI9ZViqez0ulNGCELyuez7aQLluB
p60g8Nt/zmJ6Jm4vFoA6FljM49oA3fRMmJ4J0zNhSmemZ8LQNz0Thr7pmegefNMzYXomTM+E6Zkw
PROmZ8L0TJieifuMrIM9EyCioTA9E2vumSBu61omOI1FOG2ZgC5wQ2BaJu6+ZQL4hEbie1omMJSb
86xlAhLGAe3QhvugWiYWrKA+K+3sWcg96JDIS7mUp/Zu+UKkQm7cm9PzrZDME5+bIeuWRS661f9S
622qPuW6RBN22+a6J3kkUum9cZ5GKjhW4WJ/HEZJUbc1kBnxQDTSIIojOk+Y9L0O0dVKc2qV6QKm
r9Mg7LXtoCMK7YxVyalQR1u7lSiYDOdnqe9SrjyuAyLaKX+NZKIkKsXShXV+1DpPlSw3HyeZ3Fwz
LmQWK9+xw07F7JASB7ODCYgw8uqRXoIhaES8uF6qm1cde3nQb7Qudq4dTVrAVLl6vfb0aZaLWmkG
yp37otqyD+Ub9goRJzKYVtZwILMHzuqNenJ6FdaVyfiK/N/fzQ5I5+Gbtjy5iPBurhyQ6i0ekbaZ
zA17/NRMoEcaiRfsbli+sLUjqk+1W9edtAzqgcwnildJMXd/zbXD+DxcV5nbdmxylV5fFPOtvOvQ
oK99jvywvbcaiiNRxI7M3saFkJj645EElJS5RCV3WEUrkXFCs4aEmEvnKbEWPKv6A98jsz/UgoSi
h5EujY4HCp5zreqenLo2sNFPSSbvjWQmEqZC3poqU8GWpq49dK2p0/IS0orYDbh6aaXaS/HCxlgI
LmTKmWfphcNH0eiod1ENztiT5upmVexYTsQqh3lR8XFl5dld6vGGUpcXrKfU9XyoPrO8U2tZtTa1
6nNLq2UN3RH3YZUJUSSAh68rE5Yyv9JXZbi3VSa84zLgox/9P5uNGDFixIgRI0aMGDFixIgRI0aM
GDFixIgRI0aMGDFiZJn8A347x1IAeAAA

The orig tgz file has this sha1:

a377d03e65a6367495872830c210aa7c90ffd000

===R

AudriusButkevicius · June 22, 2019, 8:33am

Does this have the scanning part?

rahrah · June 22, 2019, 10:16am

Hello,

I started up syncthing on the phone, saw it do it’s scan: all was up to date.
I reset it the phone, restarted syncthing, saw it do it’s scan: same problems, files needed reverting.
I reverted, then looked at the log file.
I look at the log file, but there’s no array print out like this:

BlockSize:131072, Blocks:[Block{0
/131072/3920915798/6fe58fd9cbb7e19de29295c710453d7a98dc4d0ac6492dedf3cd98e4429f0
a2b} Block{131072/131072/55154110/00f5df6fb2877b4e252f1333391e3c7bf00600bb46373e
f38aea72b3645f0a79} Block{262144/131072/3648095085/71ef26f4aa762df443caf458a0b9c
6691f364771647f8da6d0ba84636c0f32ff} Block{393216/131072
......

for any file.

grep 'Blocks:\[Block{.*Block' syncthing.log

I assume those lines contain the block hashes for each file and some sort of block ID/sequence number/offset. I assume they would be logged whenever a scan is done. Perhaps/probably I’m doing something wrong.

This has happened before when I sent you the logs.

I’m have STTRACE set to fs, model, scanner.

I have no more time today to work out what’s going wrong. Sorry.

===Rich

AudriusButkevicius · June 22, 2019, 1:03pm

I deliberately prevented logging them as they were not of interest and pushing important content far away.

rahrah · June 24, 2019, 10:58am

Sorry for the delay in getting back to you.

What do I need to provide? I’m not sure what the logs are missing.

Do I need to enable something else, other than these:

STTRACE set to fs , model , scanner ?

===Rich

AudriusButkevicius · June 24, 2019, 12:00pm

No that should be all, but I am after the bit which says “rescan:”

rahrah · June 24, 2019, 4:16pm

Hello,

With the logs I sent you early on Saturday morning, I’d enabled these STRACE options: fs, model, scanner

I then found a file with the ‘taking shortcut’ tag.

I then grepped the log for for all instances of that file name.

There were no instances of rescan: for any log entries for that file name.

Indeed, there were only 36 instances of the string rescan: in the whole 138800 line log file. There were 456 instances of ‘taking shortcut’.

I chose to send you logs for the file:

C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ

since it’s on a gocryptfs system. There are no rescan: results for the directories:

3HuQOxuQc8-RIlDo40s1mA

3vOpfRpZp4BwAe8p-ZlJSg

And only six for the parent:

C2j8NNXQ3wHPht9gP7SrHQ

[XHTJH] DEBUG: rescan: File{Name:"C2j8NNXQ3wHPht9gP7SrHQ/QN3TennwAuMpafsF3wUzzg", Sequence:5802, Permissions:0644, ModTime:2019-05-15 17:33:27.9606002 +0000 UTC, Version:{[{NPAZACX 1} {WR6WMT7 1} {3Y3FLDP 5}]}, Length:843, Deleted:false, Invalid:false, LocalFlags:0x0, NoPermissions:false, BlockSize:131072, Blocks:[]} 2019-05-15 17:33:26 +0000 UTC -rwxr-x---
[XHTJH] DEBUG: rescan: File{Name:"C2j8NNXQ3wHPht9gP7SrHQ/aYb08IeENFKfb8SRO0oSEA", Sequence:5834, Permissions:0644, ModTime:2019-02-19 16:51:33.300790892 +0000 UTC, Version:{[{NPAZACX 1} {WKOOOGB 1} {WR6WMT7 1} {3ABJ3OJ 1}]}, Length:182122, Deleted:false, Invalid:false, LocalFlags:0x0, NoPermissions:false, BlockSize:131072, Blocks:[]} 2019-02-19 16:51:32 +0000 UTC -rwxr-x---
[XHTJH] DEBUG: rescan: File{Name:"C2j8NNXQ3wHPht9gP7SrHQ/Gp2-KHm9iX5ZKD8IMDDbtg", Sequence:5793, Permissions:0644, ModTime:2019-04-26 23:12:13.314726157 +0000 UTC, Version:{[{NPAZACX 1} {WKOOOGB 1} {WR6WMT7 1} {3ABJ3OJ 1}]}, Length:1483437, Deleted:false, Invalid:false, LocalFlags:0x0, NoPermissions:false, BlockSize:131072, Blocks:[]} 2019-04-26 23:12:12 +0000 UTC -rwxr-x---
[XHTJH] DEBUG: rescan: File{Name:"C2j8NNXQ3wHPht9gP7SrHQ/ELsghBv8LpG-FnPncri9nr6I2aI2syJ3zbS6Y3_cFQE", Sequence:5792, Permissions:0644, ModTime:2019-05-23 01:47:35.870642361 +0000 UTC, Version:{[{NPAZACX 1} {WKOOOGB 1} {WR6WMT7 1} {3ABJ3OJ 1}]}, Length:630612, Deleted:false, Invalid:false, LocalFlags:0x0, NoPermissions:false, BlockSize:131072, Blocks:[]} 2019-05-23 01:47:34 +0000 UTC -rwxr-x---
[XHTJH] DEBUG: rescan: File{Name:"C2j8NNXQ3wHPht9gP7SrHQ/MbTN-IGY-QFs9yXnBPKpvcLQNrhw37LNExiYzyyYGOc", Sequence:5799, Permissions:0644, ModTime:2019-05-07 17:52:35.828636826 +0000 UTC, Version:{[{NPAZACX 1} {WKOOOGB 1} {WR6WMT7 1} {3ABJ3OJ 1}]}, Length:331943, Deleted:false, Invalid:false, LocalFlags:0x0, NoPermissions:false, BlockSize:131072, Blocks:[]} 2019-05-07 17:52:34 +0000 UTC -rwxr-x---
[XHTJH] DEBUG: rescan: File{Name:"C2j8NNXQ3wHPht9gP7SrHQ/j6NRrsoODWs4zJEb33dN3Q", Sequence:5877, Permissions:0644, ModTime:2019-04-26 23:12:13.3147261 +0000 UTC, Version:{[{NPAZACX 1} {WR6WMT7 1} {3Y3FLDP 2}]}, Length:1483437, Deleted:false, Invalid:false, LocalFlags:0x0, NoPermissions:false, BlockSize:131072, Blocks:[]} 2019-04-26 23:12:12 +0000 UTC -rwxr-x---

===Rich

rahrah · June 24, 2019, 4:23pm

I’ve just done the same again, having removed other shared directories, and have this the following which does contain a rescan: line for the file chosen. Happy to pm the entire file that has 313 instances of taking shortcut.


[XHTJH] DEBUG: load: loaded 2019-05-17 19:05:41 +0000 UTC / 2019-05-17 19:05:41.214081426 +0000 UTC (2019-05-17 19:05:40 +0000 UTC) for C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ (false false)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ goroutine 131 [running]:
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ runtime/debug.Stack(0x400091b828, 0x4000fc9d40, 0x1e)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /usr/lib64/go1.12.6/go/src/runtime/debug/stack.go:24 +0x80
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*MtimeFS).load(0x4000374990, 0x400160f380, 0x5b, 0x0, 0xed470fd04, 0x61dd132800, 0x5b, 0x40002f2e2e, 0x0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/mtimefs.go:181 +0x98
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*MtimeFS).Walk.func1(0x400160f380, 0x5b, 0x61dcb3a140, 0x40007b20f0, 0x0, 0x0, 0x0, 0x61dc0773fc)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/mtimefs.go:105 +0xc0
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*walkFilesystem).walk(0x400007b1d0, 0x400160f380, 0x5b, 0x61dcb3a140, 0x40007b20f0, 0x400035eca0, 0x0, 0x0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/walkfs.go:46 +0x6c
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*walkFilesystem).walk(0x400007b1d0, 0x40004aa140, 0x44, 0x61dcb3a140, 0x4000408af0, 0x400035eca0, 0x0, 0x0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/walkfs.go:71 +0x310
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*walkFilesystem).walk(0x400007b1d0, 0x4000194690, 0x2d, 0x61dcb3a140, 0x40004089d0, 0x400035eca0, 0x0, 0x0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/walkfs.go:71 +0x310
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*walkFilesystem).walk(0x400007b1d0, 0x4000406bc0, 0x16, 0x61dcb3a140, 0x40004088a0, 0x400035eca0, 0x0, 0x0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/walkfs.go:71 +0x310
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*walkFilesystem).walk(0x400007b1d0, 0x61dc38e7ed, 0x1, 0x61dcb3a140, 0x40004087f0, 0x400035eca0, 0x0, 0x0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/walkfs.go:71 +0x310
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*walkFilesystem).Walk(0x400007b1d0, 0x61dc38e7ed, 0x1, 0x400035eca0, 0x4000068e00, 0x779ef12008)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/walkfs.go:93 +0xac
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*logFilesystem).Walk(0x400007b1e0, 0x61dc38e7ed, 0x1, 0x400035eca0, 0x61dd132800, 0x40004087e0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/logfs.go:126 +0x44
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*MtimeFS).Walk(0x4000374990, 0x61dc38e7ed, 0x1, 0x400037ad20, 0x4000230480, 0x400037ad20)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/mtimefs.go:103 +0x7c
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/scanner.(*walker).walk.func1(0x4000248180, 0x61dcb32840, 0x4000042940, 0x4000230420, 0x4000230480)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/scanner/walk.go:109 +0xfc
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ created by github.com/syncthing/syncthing/lib/scanner.(*walker).walk
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/scanner/walk.go:106 +0x15c
[XHTJH] DEBUG: mtimefs.go:88 basic /storage/B977-5AE1/Android/data/com.github.catfriend1.syncthingandroid.debug/st/crypted-shared Lstat C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ {0x400036d8c0} <nil>
[XHTJH] DEBUG: load: loaded 2019-05-17 19:05:41 +0000 UTC / 2019-05-17 19:05:41.214081426 +0000 UTC (2019-05-17 19:05:40 +0000 UTC) for C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ (false false)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ goroutine 131 [running]:
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ runtime/debug.Stack(0x400091b5a8, 0x4000fc9ea0, 0x1e)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /usr/lib64/go1.12.6/go/src/runtime/debug/stack.go:24 +0x80
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*MtimeFS).load(0x4000374990, 0x400160f380, 0x5b, 0x0, 0xed470fd04, 0x61dd132800, 0x0, 0x61dc2d754c, 0x4000338600)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/mtimefs.go:181 +0x98
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*MtimeFS).Lstat(0x4000374990, 0x400160f380, 0x5b, 0x40000ca078, 0x0, 0x2, 0x40000ca000)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/mtimefs.go:94 +0x17c
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/scanner.(*walker).handleItem(0x4000248180, 0x61dcb32840, 0x4000042940, 0x400160f380, 0x5b, 0x4000230420, 0x4000230480, 0x0, 0x0, 0x61dbd3a8f0, ...)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/scanner/walk.go:289 +0x3c
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/scanner.(*walker).walkAndHashFiles.func1(0x400160f380, 0x5b, 0x61dcb3a1a0, 0x40007534d0, 0x0, 0x0, 0x0, 0xed470fd04)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/scanner/walk.go:259 +0x974
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*MtimeFS).Walk.func1(0x400160f380, 0x5b, 0x61dcb3a140, 0x40007b20f0, 0x0, 0x0, 0x0, 0x61dc0773fc)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/mtimefs.go:111 +0x5c
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*walkFilesystem).walk(0x400007b1d0, 0x400160f380, 0x5b, 0x61dcb3a140, 0x40007b20f0, 0x400035eca0, 0x0, 0x0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/walkfs.go:46 +0x6c
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*walkFilesystem).walk(0x400007b1d0, 0x40004aa140, 0x44, 0x61dcb3a140, 0x4000408af0, 0x400035eca0, 0x0, 0x0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/walkfs.go:71 +0x310
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*walkFilesystem).walk(0x400007b1d0, 0x4000194690, 0x2d, 0x61dcb3a140, 0x40004089d0, 0x400035eca0, 0x0, 0x0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/walkfs.go:71 +0x310
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*walkFilesystem).walk(0x400007b1d0, 0x4000406bc0, 0x16, 0x61dcb3a140, 0x40004088a0, 0x400035eca0, 0x0, 0x0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/walkfs.go:71 +0x310
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*walkFilesystem).walk(0x400007b1d0, 0x61dc38e7ed, 0x1, 0x61dcb3a140, 0x40004087f0, 0x400035eca0, 0x0, 0x0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/walkfs.go:71 +0x310
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*walkFilesystem).Walk(0x400007b1d0, 0x61dc38e7ed, 0x1, 0x400035eca0, 0x4000068e00, 0x779ef12008)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/walkfs.go:93 +0xac
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*logFilesystem).Walk(0x400007b1e0, 0x61dc38e7ed, 0x1, 0x400035eca0, 0x61dd132800, 0x40004087e0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/logfs.go:126 +0x44
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*MtimeFS).Walk(0x4000374990, 0x61dc38e7ed, 0x1, 0x400037ad20, 0x4000230480, 0x400037ad20)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/mtimefs.go:103 +0x7c
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/scanner.(*walker).walk.func1(0x4000248180, 0x61dcb32840, 0x4000042940, 0x4000230420, 0x4000230480)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/scanner/walk.go:109 +0xfc
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ created by github.com/syncthing/syncthing/lib/scanner.(*walker).walk
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/scanner/walk.go:106 +0x15c
[XHTJH] DEBUG: rescan: File{Name:"C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ", Sequence:4710, Permissions:0750, ModTime:2019-05-17 19:05:41.214081426 +0000 UTC, Version:{[{NPAZACX 1} {WKOOOGB 1} {WR6WMT7 1} {2VVXIMR 1} {3ABJ3OJ 2}]}, Length:13131181, Deleted:false, Invalid:false, LocalFlags:0x0, NoPermissions:false, BlockSize:131072, Blocks:[]} 2019-05-17 19:05:40 +0000 UTC -rwxr-x---
[XHTJH] DEBUG: to hash: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ File{Name:"C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ", Sequence:0, Permissions:0750, ModTime:2019-05-17 19:05:40 +0000 UTC, Version:{[{NPAZACX 1} {WKOOOGB 1} {WR6WMT7 1} {XHTJHWI 1} {2VVXIMR 1} {3ABJ3OJ 2}]}, Length:13131181, Deleted:false, Invalid:false, LocalFlags:0x8, NoPermissions:true, BlockSize:131072, Blocks:[]}
[XHTJH] DEBUG: real to hash: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ
[XHTJH] DEBUG: mtimefs.go:124 basic /storage/B977-5AE1/Android/data/com.github.catfriend1.syncthingandroid.debug/st/crypted-shared Open C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ {0x4000930d78 C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ} <nil>
[XHTJH] DEBUG: load: loaded 2019-05-17 19:05:41 +0000 UTC / 2019-05-17 19:05:41.214081426 +0000 UTC (2019-05-17 19:05:40 +0000 UTC) for C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ (false false)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ goroutine 405 [running]:
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ runtime/debug.Stack(0x400030f7c8, 0x4000720240, 0x1e)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /usr/lib64/go1.12.6/go/src/runtime/debug/stack.go:24 +0x80
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*MtimeFS).load(0x4000374990, 0x400160f380, 0x5b, 0x0, 0xed470fd04, 0x61dd132800, 0x4000338780, 0x61dc2dad8c, 0x61dcab4a40)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/mtimefs.go:181 +0x98
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*mtimeFile).Stat(0x4001043d40, 0x61dcb3b258, 0x4001043d40, 0x61dcb3b240, 0x4001043d40)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/mtimefs.go:215 +0xd0
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/scanner.HashFile(0x61dcb32840, 0x4000042940, 0x61dcb3f660, 0x4000374990, 0x400160f380, 0x5b, 0x20000, 0x61dcb205c0, 0x4001468ca0, 0x61dbde7e01, ...)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/scanner/blockqueue.go:29 +0x188
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/scanner.(*parallelHasher).hashFiles(0x4000d0e370, 0x61dcb32840, 0x4000042940)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/scanner/blockqueue.go:107 +0x240
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ created by github.com/syncthing/syncthing/lib/scanner.newParallelHasher
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/scanner/blockqueue.go:87 +0x134
[XHTJH] DEBUG: load: loaded 2019-05-17 19:05:41 +0000 UTC / 2019-05-17 19:05:41.214081426 +0000 UTC (2019-05-17 19:05:40 +0000 UTC) for C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ (false false)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ goroutine 405 [running]:
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ runtime/debug.Stack(0x400030f7c8, 0x40007203c0, 0x1e)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /usr/lib64/go1.12.6/go/src/runtime/debug/stack.go:24 +0x80
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*MtimeFS).load(0x4000374990, 0x400160f380, 0x5b, 0x0, 0xed470fd04, 0x61dd132800, 0xc80000, 0x5dad, 0x4000720380)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/mtimefs.go:181 +0x98
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*mtimeFile).Stat(0x4001043d40, 0x4000042940, 0x779c6cee90, 0x4001043d40, 0x20000)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/mtimefs.go:215 +0xd0
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/scanner.HashFile(0x61dcb32840, 0x4000042940, 0x61dcb3f660, 0x4000374990, 0x400160f380, 0x5b, 0x20000, 0x61dcb205c0, 0x4001468ca0, 0x61dbde7e01, ...)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/scanner/blockqueue.go:48 +0x468
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/scanner.(*parallelHasher).hashFiles(0x4000d0e370, 0x61dcb32840, 0x4000042940)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/scanner/blockqueue.go:107 +0x240
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ created by github.com/syncthing/syncthing/lib/scanner.newParallelHasher
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/scanner/blockqueue.go:87 +0x134
[XHTJH] DEBUG: mtimefs.go:88 basic /storage/B977-5AE1/Android/data/com.github.catfriend1.syncthingandroid.debug/st/crypted-shared Lstat C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ {0x40001ad380} <nil>
[XHTJH] DEBUG: load: loaded 2019-05-17 19:05:41 +0000 UTC / 2019-05-17 19:05:41.214081426 +0000 UTC (2019-05-17 19:05:40 +0000 UTC) for C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ (false false)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ goroutine 60 [running]:
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ runtime/debug.Stack(0x400084feb8, 0x4002b87f00, 0x1e)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /usr/lib64/go1.12.6/go/src/runtime/debug/stack.go:24 +0x80
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*MtimeFS).load(0x4000374990, 0x400108fd40, 0x5b, 0x0, 0xed470fd04, 0x61dd132800, 0x0, 0x61dc31c9ec, 0x400003c7e8)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/mtimefs.go:181 +0x98
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/fs.(*MtimeFS).Lstat(0x4000374990, 0x400108fd40, 0x5b, 0x2d, 0x0, 0x0, 0x0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/fs/mtimefs.go:94 +0x17c
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/osutil.IsDeleted(0x61dcb3f660, 0x4000374990, 0x400108fd40, 0x5b, 0x4001706000)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/osutil/osutil.go:164 +0x38
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/model.(*folder).scanSubdirs.func6(0x61dcb3de80, 0x40002a4ab0, 0x61dcb3de80)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/model/folder.go:479 +0x454
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/db.nativeFileIterator.func1(0x61dcb3de80, 0x40002a4a20, 0x1800)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/db/set.go:316 +0x138
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/db.(*instance).withHave(0x40004e46c0, 0x40001830e0, 0xb, 0x10, 0x4002b87940, 0x20, 0x20, 0x61dd155778, 0x0, 0x0, ...)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/db/instance.go:153 +0x328
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/db.(*FileSet).WithPrefixedHaveTruncated(0x4000042880, 0xffffffffffffffff, 0xffffffffffffffff, 0xffffffffffffffff, 0xffffffffffffffff, 0x61dc38e7e0, 0x0, 0x4000e3d6c0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/db/set.go:184 +0x268
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/model.(*folder).scanSubdirs(0x40004ce840, 0x0, 0x1, 0x0, 0x0, 0x0)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/model/folder.go:428 +0x76c
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/model.(*folder).scanTimerFired(0x40004ce840)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/model/folder.go:541 +0x30
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/syncthing/syncthing/lib/model.(*folder).Serve(0x40004ce840)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/src/github.com/syncthing/syncthing/lib/model/folder.go:178 +0x628
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ github.com/thejerf/suture.(*Supervisor).runService.func1(0x40004e7680, 0x4000000002, 0x779c6c2bc8, 0x40000c02b8)
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/pkg/mod/github.com/thejerf/suture@v3.0.2+incompatible/supervisor.go:600 +0x34
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ created by github.com/thejerf/suture.(*Supervisor).runService
[XHTJH] DEBUG: C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ  /home/xfer/xfer/android/sdk/rah/AndroidStudioProjects/syncthing-android-rah/syncthing/pkg/mod/github.com/thejerf/suture@v3.0.2+incompatible/supervisor.go:588 +0x4c
[XHTJH] DEBUG: receiveonly/cpdpj-ytgwa@0x40004ce840 taking shortcut on C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ
[XHTJH] DEBUG: mtimefs.go:59 basic /storage/B977-5AE1/Android/data/com.github.catfriend1.syncthingandroid.debug/st/crypted-shared Chtimes C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ 2019-05-17 19:05:41.214081426 +0000 UTC 2019-05-17 19:05:41.214081426 +0000 UTC <nil>
[XHTJH] DEBUG: mtimefs.go:63 basic /storage/B977-5AE1/Android/data/com.github.catfriend1.syncthingandroid.debug/st/crypted-shared Lstat C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ {0x400114e6c0} <nil>
[XHTJH] DEBUG: save: saving 2019-05-17 19:05:41 +0000 UTC / 2019-05-17 19:05:41.214081426 +0000 UTC for C2j8NNXQ3wHPht9gP7SrHQ/3vOpfRpZp4BwAe8p-ZlJSg/3HuQOxuQc8-RIlDo40s1mA/0IbYz4jP0WVtZaYV4XaNyQ

===Rich

post_24jun19_2_log.txt (29.9 KB)

AudriusButkevicius · June 24, 2019, 5:10pm

Can you try this on normal files and not gocryptofs? My money is that gocryptofs itself is getting in the way, as it seems the timestamp inaccuracy moves by a second magically.

AudriusButkevicius · June 24, 2019, 6:00pm

Or there is some sort of silly caching going on on fat/android, whereby a recently written file has second accuracy timestamp, but after some magical condition drops down to two second accuracy.

AudriusButkevicius · June 24, 2019, 6:04pm

Fat is 2 second accuracy, so I have no idea how we end up with 41st second past the minute, which later turns into 40th second past the minute.

rahrah · June 24, 2019, 6:43pm

Hello,

This situation does pertain for all the normal files, too. I just chose the crypted ones cos I’m paranoid and don’t want to leak too much info in a public forum. Syncthing is definitely a poster boy for the paranoid.

Or there is some sort of silly caching going on on fat/android, whereby a recently written file has second accuracy timestamp, but after some magical condition drops down to two second accuracy.

I feel this is what is happening. About a third of the files on read-only dirs go out of sync, which I assumed were those that fell between the granularity of the time stamps. 313 files were out of sync in my encrypted hiearchy as against 1082 that exist there.

I wondered some posts ago if it were possible to allow for an advanced option that would allow files to be automatically reverted if these conditions were met:

Blob/block data (the file contents) to be unchanged throughout the cluster.
Mtime being out of sync by a definable amount.
Directory to be receive only.
All other meta data unchanged.

If only the mtime meta data has changed, but the blob is unchanged, then having an advanced option to ignore this weird condition would not really be a ‘nuke my data’ option, or would it?

I’ll send some non gocryptfs data later.

Thanks again for your efforts on this.

===Rich

rahrah · June 24, 2019, 6:49pm

Just did a quick test:

Rsync syncthing git repo to new syncthing shared repo: 2331 files and 432 dirs (including the .git/* stuff).
Shared with android phone and waited until synced (no other cluster member sharing this other than Linux host and Android phone).
Rebooted phone.
1225 “Locally Changed items” in hierarchy.

Will send logs later.

===Rich

calmh · June 24, 2019, 6:52pm

I had a gut feeling this might be the case (fs cache having better precision than actual fs) when I read the initial issue but didn’t dare suggest something so idiotic