Syncing stuck at 0% for newly added device

Two devices are syncing fine: 1.) Win 10 64-bit v0.12.20, 2.) Android v0.12.20 (Note 2)

Added a third device today, but it’s stuck at “Syncing (0%)”: 3.) Android v0.12.20 (Nook HD+ running cyanogenmod)

This problem was reported as an issue previously, but reported as resolved.

Are you sure you accepted the folder on the other device (or added it manually with the same name)?

I added a new folder to sync to the Nook, but I just added a previous folder (one of two synced with the Note) to the list of folders on the Nook, and the Nook is still at 0%.

How big is the folder?

I suspect a book reader is not the best device to try and run syncthing, which uses state of the art cryptography.

The implication is that the Nook might not have the resources to run Syncthing effectively. Syncthing relies on SHA256 hashing and some type of AES for TLS.

I am pretty sure if you sync a small number of small files it should be fine to some extent.

It’s actually a Nook HD+, dual-core 4470 @ 1.5 GHz. The folder only has 17 files totaling 24MB.

Can you check the logs? Do you have rate limit enabled? Provide screenshots?

Thanks for your suggestions. I’ll be afk for this evening, but for now the log file includes: [KA4CU] 18:21:07 INFO: Device Y(…) is “Nook HD+ CyanogenMod” at [dynamic] [KA4CU] 18:21:07 INFO: Device K(…) is “K…” at [dynamic] (Win desktop)

… to last lines of log file: [KA4CU] 18:22:26 INFO: Established secure connection to Y(…) at x.x.x.xx9:63966-x.x.x.xx2:22000 (direct-dial) [KA4CU] 18:22:26 INFO: Device Y(…) client is “syncthing v0.12.20” named “localhost” [KA4CU] 18:25:08 INFO: Connected to already connected device (Y(…))

screenshots will have to wait for now.

I am looking for error messages, not just general messages.

There were no errors.

Ok, the next suggestion would be to enable more verbose logging. If you are using the Android wrapper, suggest you add ‘model’ to the list of debug options.

Hopefully I’ve obfuscated everything I should have. If not, please delete this post. Thanks!

[KA4CU] 2016/03/22 10:17:26.294925 rwfolder.go:200: DEBUG: rwFolder/t...@0xc08252aa00 next rescan in 1m7.675340816s
[KA4CU] 2016/03/22 10:17:26.294925 rwfolder.go:332: INFO: Completed initial scan (rw) of folder t...
[KA4CU] 2016/03/22 10:17:27.266159 rwfolder.go:231: DEBUG: rwFolder/t...@0xc08252aa00 ignore patterns have changed, resetting prevVer
[KA4CU] 2016/03/22 10:17:27.266159 rwfolder.go:239: DEBUG: rwFolder/t...@0xc08252aa00 skip (curVer == prevVer) 0 true
[KA4CU] 2016/03/22 10:17:27.438368 model.go:391: DEBUG: model@0xc083330b40 Completion(W..., "S..."): 0.051188 (3249071 / 3250735 = 0.999488)
[KA4CU] 2016/03/22 10:17:27.439869 progressemitter.go:132: DEBUG: progress emitter: bytes completed for t...: 0
[KA4CU] 2016/03/22 10:17:27.439869 model.go:441: DEBUG: model@0xc083330b40 NeedSize("t..."): 0 0
[KA4CU] 2016/03/22 10:17:27.441370 model.go:391: DEBUG: model@0xc083330b40 Completion(Y..., "t..."): 0.000000 (25096414 / 25096414 = 1.000000)
[KA4CU] 2016/03/22 10:17:27.442372 progressemitter.go:132: DEBUG: progress emitter: bytes completed for S...: 0
[KA4CU] 2016/03/22 10:17:27.442372 model.go:441: DEBUG: model@0xc083330b40 NeedSize("S..."): 0 0
[KA4CU] 2016/03/22 10:17:27.482409 progressemitter.go:132: DEBUG: progress emitter: bytes completed for A...: 0
[KA4CU] 2016/03/22 10:17:27.482409 model.go:441: DEBUG: model@0xc083330b40 NeedSize("A..."): 0 0
[KA4CU] 2016/03/22 10:17:27.576499 model.go:391: DEBUG: model@0xc083330b40 Completion(W..., "S..."): 0.051188 (3249071 / 3250735 = 0.999488)
[KA4CU] 2016/03/22 10:17:27.577000 progressemitter.go:132: DEBUG: progress emitter: bytes completed for S...: 0
[KA4CU] 2016/03/22 10:17:27.577000 model.go:441: DEBUG: model@0xc083330b40 NeedSize("S..."): 0 0
[KA4CU] 2016/03/22 10:17:27.581003 progressemitter.go:132: DEBUG: progress emitter: bytes completed for t...: 0
[KA4CU] 2016/03/22 10:17:27.581003 model.go:441: DEBUG: model@0xc083330b40 NeedSize("t..."): 0 0
[KA4CU] 2016/03/22 10:17:27.583005 model.go:391: DEBUG: model@0xc083330b40 Completion(Y..., "t..."): 0.000000 (25096414 / 25096414 = 1.000000)
[KA4CU] 2016/03/22 10:17:27.652071 progressemitter.go:132: DEBUG: progress emitter: bytes completed for A...: 0
[KA4CU] 2016/03/22 10:17:27.652071 model.go:441: DEBUG: model@0xc083330b40 NeedSize("A..."): 0 0
[KA4CU] 2016/03/22 10:17:27.717134 model.go:391: DEBUG: model@0xc083330b40 Completion(W..., "A..."): 0.002634 (28152363487 / 28153105119 = 0.999974)
[KA4CU] 2016/03/22 10:17:27.796709 model.go:391: DEBUG: model@0xc083330b40 Completion(W..., "A..."): 0.002634 (28152363487 / 28153105119 = 0.999974)
[KA4CU] 2016/03/22 10:17:28.701774 progressemitter.go:132: DEBUG: progress emitter: bytes completed for A...: 0
[KA4CU] 2016/03/22 10:17:28.701774 model.go:441: DEBUG: model@0xc083330b40 NeedSize("A..."): 0 0
[KA4CU] 2016/03/22 10:17:28.704276 progressemitter.go:132: DEBUG: progress emitter: bytes completed for S...: 0
[KA4CU] 2016/03/22 10:17:28.704276 model.go:441: DEBUG: model@0xc083330b40 NeedSize("S..."): 0 0
[KA4CU] 2016/03/22 10:17:28.705278 progressemitter.go:132: DEBUG: progress emitter: bytes completed for t...: 0
[KA4CU] 2016/03/22 10:17:28.705278 model.go:441: DEBUG: model@0xc083330b40 NeedSize("t..."): 0 0
[KA4CU] 2016/03/22 10:17:28.705779 model.go:391: DEBUG: model@0xc083330b40 Completion(W..., "S..."): 0.051188 (3249071 / 3250735 = 0.999488)
[KA4CU] 2016/03/22 10:17:28.706279 model.go:391: DEBUG: model@0xc083330b40 Completion(Y..., "t..."): 0.000000 (25096414 / 25096414 = 1.000000)
[KA4CU] 2016/03/22 10:17:28.862172 model.go:391: DEBUG: model@0xc083330b40 Completion(W..., "A..."): 0.002634 (28152363487 / 28153105119 = 0.999974)
[KA4CU] 2016/03/22 10:17:36.517676 upnpservice.go:98: INFO: New UPnP port mapping: external port 7424 to local port 22000.
[KA4CU] 2016/03/22 10:17:37.264182 rwfolder.go:239: DEBUG: rwFolder/A...@0xc08252a280 skip (curVer == prevVer) 0 true
[KA4CU] 2016/03/22 10:17:37.266187 rwfolder.go:239: DEBUG: rwFolder/S...@0xc08252a640 skip (curVer == prevVer) 0 true
[KA4CU] 2016/03/22 10:17:37.266187 rwfolder.go:239: DEBUG: rwFolder/t...@0xc08252aa00 skip (curVer == prevVer) 0 true
[KA4CU] 2016/03/22 10:17:47.264259 rwfolder.go:239: DEBUG: rwFolder/A...@0xc08252a280 skip (curVer == prevVer) 0 true
[KA4CU] 2016/03/22 10:17:47.266263 rwfolder.go:239: DEBUG: rwFolder/t...@0xc08252aa00 skip (curVer == prevVer) 0 true
[KA4CU] 2016/03/22 10:17:47.266263 rwfolder.go:239: DEBUG: rwFolder/S...@0xc08252a640 skip (curVer == prevVer) 0 true

Can you provide the full log, after 10 minutes of running rather than some small excerpt at a random point in time which happens not to contain anything useful.

Sure, but I didn’t see anything else that seemed useful. Is there somewhere I can upload privately so that I don’t accidentally expose private data?

You can email it to me, my email is available on my github profile.

It turns out this was my error for not turning on the device switch when I added the folder on the android side (Devices under Edit Folder).

Audrius referred me to the Getting Started guide (RTFM), but I didn’t readily find a mention of this switch/setting there. It might be helpful to add some more info to the android UI.

Thanks very much for the support.

@cattledogit

Now you got our support. We would like to request from you a suggestion for the “Getting Started Guide” ;). Best would be to edit https://github.com/syncthing/docs/blob/master/intro/getting-started.rst and create a pull request.

Cheers Lars

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