Docker 678b96126539 / exfat: out of sync and .tmp not renamed

nerd stats

running Syncthing in a docker container (image ID 678b96126539)

### syncthing --version
syncthing v1.19.2 "Fermium Flea" (go1.17.7 linux-arm64) \
docker@build.syncthing.net 2022-03-21 03:47:47 UTC [noupgrade]

### bind mount options
/dev/path on /var/syncthing type exfat \
(rw,noatime,fmask=0022,dmask=0022,iocharset=utf8,errors=remount-ro)

### ls -ld /var/syncthing
drwxr-xr-x    8 root     root        524288 Apr 15 09:56 /var/syncthing
### 

NB: i’m running as root with PUID,GUID as 0; yes i know that’s dangerous. this is a LAN and i’m trying to eliminate user permission as the cause for error

the problem

files are always out of sync

the gui states

syncing: pull: generic error

in the logs i could find

error:0x400292c900

but not much else (it’s hard to identify error lines)

extra details on the problem

  • set to untrusted; and encryption passwords match
  • empty files sync without a problem
  • files with content are never synced
  • temp files .syncthing.${FILENAME}.tmp are created
    • $ file ${TMPFILE} output => data
    • hashes do not match
  • the docker container is running in Linux, but the mounted storage device is exfat
  • can write, rename, delete from within the container as root

sample reciever logs

2022-04-15 13:36:06 folderconfiguration.go:109 basic /var/syncthing/SyncthingTest Stat . {0x40010be180} <nil>
2022-04-15 13:36:06 folderconfiguration.go:127 basic /var/syncthing/SyncthingTest Stat .stfolder {0x40010be240} <nil>
2022-04-15 13:36:06 folder.go:330 basic /var/syncthing/config/index-v0.14.0.db Usage . {1890504933376 1989640978432} <nil>
2022-04-15 13:36:06 folderconfiguration.go:109 basic /var/syncthing/SyncthingTest Stat . {0x40010be300} <nil>
2022-04-15 13:36:06 folderconfiguration.go:127 basic /var/syncthing/SyncthingTest Stat .stfolder {0x40010be3c0} <nil>
2022-04-15 13:36:06 folder.go:330 basic /var/syncthing/config/index-v0.14.0.db Usage . {1890504933376 1989640978432} <nil>
2022-04-15 13:36:06 ignore.go:385 basic /var/syncthing/SyncthingTest Open .stignore <nil> open /var/syncthing/SyncthingTest/.stignore: no such file or directory
2022-04-15 13:36:06 folder_sendrecv.go:2060 basic /var/syncthing/SyncthingTest Lstat .emptyfile {0x400115e600} <nil>
2022-04-15 13:36:06 util.go:110 basic /var/syncthing/SyncthingTest Stat . {0x400115e6c0} <nil>
2022-04-15 13:36:06 util.go:139 basic /var/syncthing/SyncthingTest Remove .emptyfile <nil>
2022-04-15 13:36:06 basic /var/syncthing/SyncthingTest Watch: Sending .emptyfile remove
2022-04-15 13:36:33 folderconfiguration.go:109 basic /var/syncthing/SyncthingTest Stat . {0x4000096780} <nil>
2022-04-15 13:36:33 folderconfiguration.go:127 basic /var/syncthing/SyncthingTest Stat .stfolder {0x4000096840} <nil>
2022-04-15 13:36:33 folder.go:330 basic /var/syncthing/config/index-v0.14.0.db Usage . {1890504933376 1989640978432} <nil>
2022-04-15 13:36:33 folderconfiguration.go:109 basic /var/syncthing/SyncthingTest Stat . {0x4000096900} <nil>
2022-04-15 13:36:33 folderconfiguration.go:127 basic /var/syncthing/SyncthingTest Stat .stfolder {0x40000969c0} <nil>
2022-04-15 13:36:33 folder.go:330 basic /var/syncthing/config/index-v0.14.0.db Usage . {1890504933376 1989640978432} <nil>
2022-04-15 13:36:33 ignore.go:385 basic /var/syncthing/SyncthingTest Open .stignore <nil> open /var/syncthing/SyncthingTest/.stignore: no such file or directory
2022-04-15 13:36:33 folder_sendrecv.go:696 basic /var/syncthing/SyncthingTest Lstat . {0x4000096b40} <nil>
2022-04-15 13:36:33 blockqueue.go:20 basic /var/syncthing/SyncthingTest Open .syncthing..emptyfile.tmp <nil> open /var/syncthing/SyncthingTest/.syncthing..emptyfile.tmp: no such file or directory
2022-04-15 13:36:33 util.go:110 basic /var/syncthing/SyncthingTest Stat . {0x4000096cc0} <nil>
2022-04-15 13:36:33 util.go:139 basic /var/syncthing/SyncthingTest Remove .syncthing..emptyfile.tmp remove /var/syncthing/SyncthingTest/.syncthing..emptyfile.tmp: no such file or directory
2022-04-15 13:36:33 folderconfiguration.go:260 basic /var/syncthing/SyncthingTest Usage . {1890504933376 1989640978432} <nil>
2022-04-15 13:36:33 util.go:110 basic /var/syncthing/SyncthingTest Stat . {0x4000096e40} <nil>
2022-04-15 13:36:33 sharedpullerstate.go:183 basic /var/syncthing/SyncthingTest OpenFile .syncthing..emptyfile.tmp 194 -rw-rw-rw- {{0x4004b32210 .syncthing..emptyfile.tmp} 0x40040ced50} <nil>
2022-04-15 13:36:33 basic /var/syncthing/SyncthingTest Watch: Ignoring .syncthing..emptyfile.tmp
2022-04-15 13:36:33 sharedpullerstate.go:189 basic /var/syncthing/SyncthingTest Hide .syncthing..emptyfile.tmp <nil>
2022-04-15 13:36:33 basic /var/syncthing/SyncthingTest Watch: Ignoring .syncthing..emptyfile.tmp
2022-04-15 13:36:33 sharedpullerstate.go:341 basic /var/syncthing/SyncthingTest Unhide .syncthing..emptyfile.tmp <nil>
2022-04-15 13:36:33 folder_sendrecv.go:696 basic /var/syncthing/SyncthingTest Lstat . {0x4000097140} <nil>
2022-04-15 13:36:33 blockqueue.go:20 basic /var/syncthing/SyncthingTest Open .syncthing..emptyfile.tmp {{0x4004b32260 .syncthing..emptyfile.tmp} 0x40040ced50} <nil>
2022-04-15 13:36:33 folderconfiguration.go:260 basic /var/syncthing/SyncthingTest Usage . {1890504933376 1989640978432} <nil>
2022-04-15 13:36:33 util.go:110 basic /var/syncthing/SyncthingTest Stat . {0x4000097440} <nil>
2022-04-15 13:36:33 sharedpullerstate.go:183 basic /var/syncthing/SyncthingTest OpenFile .syncthing..emptyfile.tmp 2 -rw-rw-rw- {{0x4004b322b8 .syncthing..emptyfile.tmp} 0x40040ced50} <nil>
2022-04-15 13:36:33 sharedpullerstate.go:189 basic /var/syncthing/SyncthingTest Hide .syncthing..emptyfile.tmp <nil>
2022-04-15 13:36:33 basic /var/syncthing/SyncthingTest Watch: Ignoring .syncthing..emptyfile.tmp
2022-04-15 13:36:33 sharedpullerstate.go:341 basic /var/syncthing/SyncthingTest Unhide .syncthing..emptyfile.tmp <nil>
2022-04-15 13:36:33 folder_sendrecv.go:1600 basic /var/syncthing/SyncthingTest Lstat .emptyfile <nil> lstat /var/syncthing/SyncthingTest/.emptyfile: no such file or directory
2022-04-15 13:36:33 osutil.go:87 basic /var/syncthing/SyncthingTest Stat . {0x4000097800} <nil>
2022-04-15 13:36:33 osutil.go:33 basic /var/syncthing/SyncthingTest Rename .syncthing..emptyfile.tmp .emptyfile <nil>
2022-04-15 13:36:33 basic /var/syncthing/SyncthingTest Watch: Sending .emptyfile non-remove
2022-04-15 13:36:33 basic /var/syncthing/SyncthingTest Watch: Ignoring .syncthing..emptyfile.tmp
2022-04-15 13:36:33 folder_sendrecv.go:1634 basic /var/syncthing/SyncthingTest Chtimes .emptyfile 2022-04-15 13:36:22 +0000 UTC 2022-04-15 13:36:22 +0000 UTC <nil>
2022-04-15 13:36:33 basic /var/syncthing/SyncthingTest Watch: Sending .emptyfile non-remove
2022-04-15 13:36:33 folder_sendrecv.go:1707 basic /var/syncthing/SyncthingTest Open . {{0x40034ce148 .} 0x40040ced50} <nil>
2022-04-15 13:36:43 folderconfiguration.go:109 basic /var/syncthing/SyncthingTest Stat . {0x40011c6a80} <nil>
2022-04-15 13:36:43 folderconfiguration.go:127 basic /var/syncthing/SyncthingTest Stat .stfolder {0x40011c6b40} <nil>
2022-04-15 13:36:43 folder.go:330 basic /var/syncthing/config/index-v0.14.0.db Usage . {1890504933376 1989640978432} <nil>
2022-04-15 13:36:43 folderconfiguration.go:109 basic /var/syncthing/SyncthingTest Stat . {0x40011c6c00} <nil>
2022-04-15 13:36:43 folderconfiguration.go:127 basic /var/syncthing/SyncthingTest Stat .stfolder {0x40011c6cc0} <nil>
2022-04-15 13:36:43 folder.go:330 basic /var/syncthing/config/index-v0.14.0.db Usage . {1890504933376 1989640978432} <nil>
2022-04-15 13:36:43 ignore.go:385 basic /var/syncthing/SyncthingTest Open .stignore <nil> open /var/syncthing/SyncthingTest/.stignore: no such file or directory
2022-04-15 13:36:43 folder_sendrecv.go:696 basic /var/syncthing/SyncthingTest Lstat . {0x40011c6e40} <nil>
2022-04-15 13:36:43 blockqueue.go:20 basic /var/syncthing/SyncthingTest Open .syncthing.helloworld.tmp <nil> open /var/syncthing/SyncthingTest/.syncthing.helloworld.tmp: no such file or directory
2022-04-15 13:36:43 util.go:110 basic /var/syncthing/SyncthingTest Stat . {0x40011c6fc0} <nil>
2022-04-15 13:36:43 util.go:139 basic /var/syncthing/SyncthingTest Remove .syncthing.helloworld.tmp remove /var/syncthing/SyncthingTest/.syncthing.helloworld.tmp: no such file or directory
2022-04-15 13:36:43 folderconfiguration.go:260 basic /var/syncthing/SyncthingTest Usage . {1890504933376 1989640978432} <nil>
2022-04-15 13:36:43 util.go:110 basic /var/syncthing/SyncthingTest Stat . {0x40011c7140} <nil>
2022-04-15 13:36:43 sharedpullerstate.go:183 basic /var/syncthing/SyncthingTest OpenFile .syncthing.helloworld.tmp 194 -rw-rw-rw- {{0x4003de8168 .syncthing.helloworld.tmp} 0x40040ced50} <nil>
2022-04-15 13:36:43 basic /var/syncthing/SyncthingTest Watch: Ignoring .syncthing.helloworld.tmp
2022-04-15 13:36:43 sharedpullerstate.go:189 basic /var/syncthing/SyncthingTest Hide .syncthing.helloworld.tmp <nil>
2022-04-15 13:36:43 basic /var/syncthing/SyncthingTest Watch: Ignoring .syncthing.helloworld.tmp
2022-04-15 13:36:43 sharedpullerstate.go:341 basic /var/syncthing/SyncthingTest Unhide .syncthing.helloworld.tmp <nil>
2022-04-15 13:36:43 folder_sendrecv.go:696 basic /var/syncthing/SyncthingTest Lstat . {0x40011c7440} <nil>
2022-04-15 13:36:43 blockqueue.go:20 basic /var/syncthing/SyncthingTest Open .syncthing.helloworld.tmp {{0x4003de8310 .syncthing.helloworld.tmp} 0x40040ced50} <nil>
2022-04-15 13:36:43 folderconfiguration.go:260 basic /var/syncthing/SyncthingTest Usage . {1890504933376 1989640978432} <nil>
2022-04-15 13:36:43 util.go:110 basic /var/syncthing/SyncthingTest Stat . {0x40011c7740} <nil>
2022-04-15 13:36:43 sharedpullerstate.go:183 basic /var/syncthing/SyncthingTest OpenFile .syncthing.helloworld.tmp 2 -rw-rw-rw- {{0x4003de8368 .syncthing.helloworld.tmp} 0x40040ced50} <nil>
2022-04-15 13:36:43 sharedpullerstate.go:189 basic /var/syncthing/SyncthingTest Hide .syncthing.helloworld.tmp <nil>
2022-04-15 13:36:43 basic /var/syncthing/SyncthingTest Watch: Ignoring .syncthing.helloworld.tmp
2022-04-15 13:36:43 sharedpullerstate.go:341 basic /var/syncthing/SyncthingTest Unhide .syncthing.helloworld.tmp <nil>
2022-04-15 13:36:43 folder_sendrecv.go:1600 basic /var/syncthing/SyncthingTest Lstat helloworld <nil> lstat /var/syncthing/SyncthingTest/helloworld: no such file or directory
2022-04-15 13:36:43 osutil.go:87 basic /var/syncthing/SyncthingTest Stat . {0x400115ec00} <nil>
2022-04-15 13:36:43 osutil.go:33 basic /var/syncthing/SyncthingTest Rename .syncthing.helloworld.tmp helloworld <nil>
2022-04-15 13:36:43 basic /var/syncthing/SyncthingTest Watch: Sending helloworld non-remove
2022-04-15 13:36:43 basic /var/syncthing/SyncthingTest Watch: Ignoring .syncthing.helloworld.tmp
2022-04-15 13:36:43 folder_sendrecv.go:1634 basic /var/syncthing/SyncthingTest Chtimes helloworld 2022-04-15 13:36:36 +0000 UTC 2022-04-15 13:36:36 +0000 UTC <nil>
2022-04-15 13:36:43 folder_sendrecv.go:1707 basic /var/syncthing/SyncthingTest Open . {{0x4003e0e030 .} 0x40040ced50} <nil>
2022-04-15 13:36:43 basic /var/syncthing/SyncthingTest Watch: Sending helloworld non-remove
2022-04-15 13:36:53 folderconfiguration.go:109 basic /var/syncthing/SyncthingTest Stat . {0x4000097c80} <nil>
2022-04-15 13:36:53 folderconfiguration.go:127 basic /var/syncthing/SyncthingTest Stat .stfolder {0x4000097d40} <nil>
2022-04-15 13:36:53 folder.go:330 basic /var/syncthing/config/index-v0.14.0.db Usage . {1890504933376 1989640978432} <nil>
2022-04-15 13:36:53 ignore.go:385 basic /var/syncthing/SyncthingTest Open .stignore <nil> open /var/syncthing/SyncthingTest/.stignore: no such file or directory
2022-04-15 13:36:53 walk: path=helloworld
2022-04-15 13:36:53 walk.go:230 basic /var/syncthing/SyncthingTest Walk helloworld 0x6e20e0 <nil>
2022-04-15 13:36:53 osutil.go:134 basic /var/syncthing/SyncthingTest Lstat helloworld {0x40011c7a40} <nil>
2022-04-15 13:37:27 folderconfiguration.go:109 basic /var/syncthing/SyncthingTest Stat . {0x400115f200} <nil>
2022-04-15 13:37:27 folderconfiguration.go:127 basic /var/syncthing/SyncthingTest Stat .stfolder {0x400115f2c0} <nil>
2022-04-15 13:37:27 folder.go:330 basic /var/syncthing/config/index-v0.14.0.db Usage . {1890504933376 1989640978432} <nil>
2022-04-15 13:37:27 folderconfiguration.go:109 basic /var/syncthing/SyncthingTest Stat . {0x400115f380} <nil>
2022-04-15 13:37:27 folderconfiguration.go:127 basic /var/syncthing/SyncthingTest Stat .stfolder {0x400115f440} <nil>
2022-04-15 13:37:27 folder.go:330 basic /var/syncthing/config/index-v0.14.0.db Usage . {1890504933376 1989640978432} <nil>
2022-04-15 13:37:27 ignore.go:385 basic /var/syncthing/SyncthingTest Open .stignore <nil> open /var/syncthing/SyncthingTest/.stignore: no such file or directory
2022-04-15 13:37:27 folder_sendrecv.go:696 basic /var/syncthing/SyncthingTest Lstat . {0x400115f5c0} <nil>
2022-04-15 13:37:27 blockqueue.go:20 basic /var/syncthing/SyncthingTest Open .syncthing.helloworld.tmp <nil> open /var/syncthing/SyncthingTest/.syncthing.helloworld.tmp: no such file or directory
2022-04-15 13:37:27 util.go:110 basic /var/syncthing/SyncthingTest Stat . {0x400115f740} <nil>
2022-04-15 13:37:27 util.go:139 basic /var/syncthing/SyncthingTest Remove .syncthing.helloworld.tmp remove /var/syncthing/SyncthingTest/.syncthing.helloworld.tmp: no such file or directory
2022-04-15 13:37:27 folderconfiguration.go:260 basic /var/syncthing/SyncthingTest Usage . {1890504933376 1989640978432} <nil>
2022-04-15 13:37:27 util.go:110 basic /var/syncthing/SyncthingTest Stat . {0x400115f8c0} <nil>
2022-04-15 13:37:27 sharedpullerstate.go:183 basic /var/syncthing/SyncthingTest OpenFile .syncthing.helloworld.tmp 194 -rw-rw-rw- {{0x40045bc0b0 .syncthing.helloworld.tmp} 0x40040ced50} <nil>
2022-04-15 13:37:27 basic /var/syncthing/SyncthingTest Watch: Ignoring .syncthing.helloworld.tmp
2022-04-15 13:37:27 sharedpullerstate.go:189 basic /var/syncthing/SyncthingTest Hide .syncthing.helloworld.tmp <nil>
2022-04-15 13:37:27 basic /var/syncthing/SyncthingTest Watch: Ignoring .syncthing.helloworld.tmp
2022-04-15 13:37:27 folder_sendrecv.go:1439 basic /var/syncthing/SyncthingTest Open helloworld {{0x40045bc0c0 helloworld} 0x40040ced50} <nil>
2022-04-15 13:37:27 sharedpullerstate.go:341 basic /var/syncthing/SyncthingTest Unhide .syncthing.helloworld.tmp <nil>
2022-04-15 13:37:27 folder_sendrecv.go:696 basic /var/syncthing/SyncthingTest Lstat . {0x40011c7c80} <nil>
2022-04-15 13:37:27 blockqueue.go:20 basic /var/syncthing/SyncthingTest Open .syncthing.helloworld.tmp {{0x4002e28148 .syncthing.helloworld.tmp} 0x40040ced50} <nil>
2022-04-15 13:37:27 util.go:110 basic /var/syncthing/SyncthingTest Stat . {0x4000d9a000} <nil>
2022-04-15 13:37:27 basic /var/syncthing/SyncthingTest Watch: Ignoring .syncthing.helloworld.tmp
2022-04-15 13:37:27 util.go:139 basic /var/syncthing/SyncthingTest Remove .syncthing.helloworld.tmp <nil>
2022-04-15 13:37:27 folderconfiguration.go:260 basic /var/syncthing/SyncthingTest Usage . {1890504933376 1989640978432} <nil>
2022-04-15 13:37:27 util.go:110 basic /var/syncthing/SyncthingTest Stat . {0x4000d9a180} <nil>
2022-04-15 13:37:27 sharedpullerstate.go:183 basic /var/syncthing/SyncthingTest OpenFile .syncthing.helloworld.tmp 194 -rw-rw-rw- {{0x4002e281b0 .syncthing.helloworld.tmp} 0x40040ced50} <nil>
2022-04-15 13:37:27 basic /var/syncthing/SyncthingTest Watch: Ignoring .syncthing.helloworld.tmp
2022-04-15 13:37:27 sharedpullerstate.go:189 basic /var/syncthing/SyncthingTest Hide .syncthing.helloworld.tmp <nil>
2022-04-15 13:37:27 basic /var/syncthing/SyncthingTest Watch: Ignoring .syncthing.helloworld.tmp
2022-04-15 13:37:27 folder_sendrecv.go:1439 basic /var/syncthing/SyncthingTest Open helloworld {{0x4002e281c0 helloworld} 0x40040ced50} <nil>
2022-04-15 13:37:27 sharedpullerstate.go:341 basic /var/syncthing/SyncthingTest Unhide .syncthing.helloworld.tmp <nil>
2022-04-15 13:37:27 folder_sendrecv.go:696 basic /var/syncthing/SyncthingTest Lstat . {0x4000d9a540} <nil>
2022-04-15 13:37:27 blockqueue.go:20 basic /var/syncthing/SyncthingTest Open .syncthing.helloworld.tmp {{0x4002e28208 .syncthing.helloworld.tmp} 0x40040ced50} <nil>
2022-04-15 13:37:27 util.go:110 basic /var/syncthing/SyncthingTest Stat . {0x4000d9a840} <nil>
2022-04-15 13:37:27 util.go:139 basic /var/syncthing/SyncthingTest Remove .syncthing.helloworld.tmp <nil>
2022-04-15 13:37:27 folderconfiguration.go:260 basic /var/syncthing/SyncthingTest Usage . {1890504933376 1989640978432} <nil>
2022-04-15 13:37:27 basic /var/syncthing/SyncthingTest Watch: Ignoring .syncthing.helloworld.tmp
2022-04-15 13:37:27 util.go:110 basic /var/syncthing/SyncthingTest Stat . {0x4000d9a9c0} <nil>
2022-04-15 13:37:27 sharedpullerstate.go:183 basic /var/syncthing/SyncthingTest OpenFile .syncthing.helloworld.tmp 194 -rw-rw-rw- {{0x4002e28278 .syncthing.helloworld.tmp} 0x40040ced50} <nil>
2022-04-15 13:37:27 basic /var/syncthing/SyncthingTest Watch: Ignoring .syncthing.helloworld.tmp
2022-04-15 13:37:27 sharedpullerstate.go:189 basic /var/syncthing/SyncthingTest Hide .syncthing.helloworld.tmp <nil>
2022-04-15 13:37:27 basic /var/syncthing/SyncthingTest Watch: Ignoring .syncthing.helloworld.tmp
2022-04-15 13:37:27 folder_sendrecv.go:1439 basic /var/syncthing/SyncthingTest Open helloworld {{0x40045bc0f0 helloworld} 0x40040ced50} <nil>
2022-04-15 13:37:27 sharedpullerstate.go:341 basic /var/syncthing/SyncthingTest Unhide .syncthing.helloworld.tmp <nil>
2022-04-15 13:37:27 Puller (folder "SyncthingTest" (0n9m5-ni7ut), item "helloworld"): syncing: pull: generic error
2022-04-15 13:37:27 "SyncthingTest" (0n9m5-ni7ut): Failed to sync 1 items
2022-04-15 13:37:27 Folder "SyncthingTest" (0n9m5-ni7ut) isn't making sync progress - retrying in 1m0s.

sample sender logs

Running something due to request
2022-04-15 15:48:49 sendonly/0n9m5-ni7ut@0x40000a4380 scanning
2022-04-15 15:48:49 folderconfiguration.go:109 basic /storage/01A3-6E27/home/syncthing_test Stat . {0x4002aa18c0} <nil>
2022-04-15 15:48:49 folderconfiguration.go:127 basic /storage/01A3-6E27/home/syncthing_test Stat .stfolder {0x4002aa1980} <nil>
2022-04-15 15:48:49 folder.go:330 basic /data/user/0/com.github.catfriend1.syncthingandroid/files/index-v0.14.0.db Usage . {11132882944 50571653120} <nil>
2022-04-15 15:48:49 walk: path=.
2022-04-15 15:48:49 walk: path=.stfolder
2022-04-15 15:48:49 walk: path=.emptyfile
2022-04-15 15:48:49 walk: path=helloworld
2022-04-15 15:48:49 sendonly/0n9m5-ni7ut@0x40000a4380 finished scanning, detected 0 changes

Suggest you post full logs. The generic error is on the receiving side presumably, the errors I assume should be on the sending side?

hmmm i don’t expect there to be errors on the sending device. it’s worked fine with a different receipient. i’ll try to get sensible portion of the log

added sample logs :smile:

This all looks fine. What do the logs on the other side look like?

Is exfat on the other side?

Might want to enable model debugging facility on the other side.

hmmmm there doesn’t seem to be much activity on the other side (added logs to OP); can’t believe i hadn’t thought of this before

Is exfat on the other side?

exfat i mentioned earlier is the receiver

i can’t really remember what the fs was on the sender; should be exfat. it’s the external storage on Android; and mount says it’s fuse. with the abstraction of Android storage APIs, i don’t think it matters much?

and yes, ignore permissions is enabled everywhere

the Syncthing app is https://play.google.com/store/apps/details?id=com.github.catfriend1.syncthingandroid because i was having issues with the official app crashing randomly

Android normally uses FAT (not exFAT) on the external storage, and because of that, it does have a lot of limitations regarding supported filenames, special characters, and much more :wink:.

well, even if that were the case, the problem would be with creating files; not sending them :wink:

Is that with model logging enabled?

I’d expect to see requests coming in.

unfortunately, yes :confused: more logs again, did a few rescans and modified the file too

2022-04-15 16:10:03 Enabled debug data for "model"
2022-04-15 16:10:03 Enabled debug data for "fs"
2022-04-15 16:10:52 sendonly/0n9m5-ni7ut@0x4000190a80 Running something due to request
2022-04-15 16:10:52 sendonly/0n9m5-ni7ut@0x4000190a80 scanning
2022-04-15 16:10:52 folderconfiguration.go:109 basic /storage/01A3-6E27/home/syncthing_test Stat . {0x400042a3c0} <nil>
2022-04-15 16:10:52 folderconfiguration.go:127 basic /storage/01A3-6E27/home/syncthing_test Stat .stfolder {0x400042a480} <nil>
2022-04-15 16:10:52 folder.go:330 basic /data/user/0/com.github.catfriend1.syncthingandroid/files/index-v0.14.0.db Usage . {11130810368 50571653120} <nil>
2022-04-15 16:10:52 walk: path=.
2022-04-15 16:10:52 walk: path=.stfolder
2022-04-15 16:10:52 walk: path=.emptyfile
2022-04-15 16:10:52 walk: path=helloworld
2022-04-15 16:10:52 sendonly/0n9m5-ni7ut@0x4000190a80 finished scanning, detected 0 changes
2022-04-15 16:11:29 basic /storage/01A3-6E27/home/syncthing_test Watch: Sending helloworld non-remove
2022-04-15 16:11:29 basic /storage/01A3-6E27/home/syncthing_test Watch: Sending helloworld non-remove
2022-04-15 16:11:34 basic /storage/01A3-6E27/home/syncthing_test Watch: Sending helloworld non-remove
2022-04-15 16:11:39 sendonly/0n9m5-ni7ut@0x4000190a80 Scan due to watcher
2022-04-15 16:11:39 sendonly/0n9m5-ni7ut@0x4000190a80 scanning
2022-04-15 16:11:39 folderconfiguration.go:109 basic /storage/01A3-6E27/home/syncthing_test Stat . {0x400042ac00} <nil>
2022-04-15 16:11:39 folderconfiguration.go:127 basic /storage/01A3-6E27/home/syncthing_test Stat .stfolder {0x400042acc0} <nil>
2022-04-15 16:11:39 folder.go:330 basic /data/user/0/com.github.catfriend1.syncthingandroid/files/index-v0.14.0.db Usage . {11147468800 50571653120} <nil>
2022-04-15 16:11:39 walk: path=helloworld
2022-04-15 16:11:39 folderconfiguration.go:109 basic /storage/01A3-6E27/home/syncthing_test Stat . {0x400042b200} <nil>
2022-04-15 16:11:39 folderconfiguration.go:127 basic /storage/01A3-6E27/home/syncthing_test Stat .stfolder {0x400042b2c0} <nil>
2022-04-15 16:11:39 folder.go:330 basic /data/user/0/com.github.catfriend1.syncthingandroid/files/index-v0.14.0.db Usage . {11147464704 50571653120} <nil>
2022-04-15 16:11:39 indexHandler@0x4000170100 for 0n9m5-ni7ut to ZOJUV2W at 192.168.83.17:22000-192.168.83.254:22000/tcp-server/TLS1.3-TLS_CHACHA20_POLY1305_SHA256: Sending 1 files (<149 bytes)
2022-04-15 16:11:39 sendonly/0n9m5-ni7ut@0x4000190a80 finished scanning, detected 1 changes
2022-04-15 16:11:41 progress emitter: bytes completed for 0n9m5-ni7ut: 0
2022-04-15 16:11:41 model@0x40002af6c0 Completion(ZOJUV2W-XZ342UV-2JWE7TL-POINR72-3NBZ72J-7XLKHNJ-WPI2IFB-Q6VVUAU, "0n9m5-ni7ut"): map[completion:0 globalBytes:23 globalItems:2 needBytes:23 needDeletes:0 needItems:1 sequence:4]

Seems like the log terminates before the remote device asks for data?

I’d make sure you didn’t do something like setup device passwords for unencrypted folders, or chose wrong folder types.

sorry, i don’t know what you mean. the password for untrusted device? (they match; configured on both)


this is on me for not rtfm, but for the same folder

  • sender - send only
  • receiver - receive only

is allowed, right?

it’s what i’d used before and didn’t really have any issues…

You should not configure passwords if you don’t plan to use encrypted folder types.

Not sure what you are trying to achieve by doing that.

If you’ve input the password on both sides, but none of them is actually set to “Receive Encrypted”, then I’d say you’re probably affected by https://github.com/syncthing/syncthing/issues/8277. To fix this, you need to either remove the password completely, or remove the folder on one side, and then add it again as “Receive Encrypted” (without any password; it will be greyed out automatically).

AHA! that was the issue! i’d misunderstood the whole untrusted device feature. i thought it was a way to encrypt between A and B

reading again, i see it’s A → X → B. where X “receives encrypted”


truth is, i forgot that :see_no_evil:

All device to device traffic is protected by TLS.


gotcha! seems all good now


thanks much team! @AudriusButkevicius @tomasz86 :smiling_face_with_three_hearts:

2 Likes

This topic was automatically closed 30 days after the last reply. New replies are no longer allowed.