Nullpointerexception on Android x86

Nutomic commented 10 years ago

In syncthing-android (wrapper for syncthing which uses goleveldb), there is a crash reproducible Nullpointerexception and crash in the goleveldb code.

crash log

original issue

I don't have this myself, but @MStrecke and @Eucyon do, and could probably try a linnux-x86 compatible binary on their device via command line.

I also don't know what to do for a minimal example, but I can try to do what you need (or maybe @calmh can help).

Edit: The same code runs without problems on Android ARMv5 and ARMv7.

syndtr commented 10 years ago

For a start could you check whether s is nil or not? For example:

// Allocate a file number.
func (s *session) allocFileNum() (num uint64) {
    if s == nil {
        panic("s is nil")
    }
    return atomic.AddUint64(&s.stFileNum, 1) - 1
}

I can't see how this could happen in this particular code path, but just to make sure.

From my experience 64-bit atomic variable tend to cause problem and need certain workaround on 32-bit platform (e.g. need 64-bit alignment on x86, I don't know if this is still true).

From Nutomic/syncthing-android#72 I suspect the problem caused by binary translation, but I'm curious though why the issue also occurred with native x86 binary (crash log of that would be great). If so, then the workaround would be replacing atomic variable with mutex instead.

Eucyon commented 10 years ago

Dear all,

please find attached a log containing installation and running of the x86 and the ARM version of STfA on a Motorola Razr I with Atom (x86) CPU.

Thanks + best regards,

Martin

Am 06.08.2014 um 04:24 schrieb Suryandaru Triandana:

For a start could you check whether |s| is nil or not? For example:

// Allocate a file number. func (s *session) allocFileNum() (num uint64) { if s == nil { panic("s is nil") } return atomic.AddUint64(&s.stFileNum, 1) - 1 }

I can't see how this could happen in this particular code path, but just to make sure.

From my experience 64-bit atomic variable tend to cause problem and need certain workaround on 32-bit platform (e.g. need 64-bit alignment on x86, I don't know if this is still true).

From Nutomic/syncthing-android#72 https://github.com/Nutomic/syncthing-android/issues/72 I suspect the problem caused by binary translation, but I'm curious though why the issue also occurred with native x86 binary (crash log of that would be great). If so, then the workaround would be replacing atomic variable with mutex instead.

— Reply to this email directly or view it on GitHub https://github.com/syndtr/goleveldb/issues/60#issuecomment-51286715.

08-05 18:59:42.693 W/ActivityManager(384): Permission denied: checkComponentPermission() owningUid=10086 08-05 18:59:43.233 D/ModemStatsService(8570): onSignalStrengthsChanged 08-05 18:59:43.233 D/ModemStatsService(8570): GSM, mRssi=-77 08-05 18:59:45.233 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 18:59:45.233 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 18:59:45.233 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 18:59:45.233 I/WifiHW (384): REPLY: RSSI=-53 08-05 18:59:45.233 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 18:59:45.233 I/WifiHW (384): REPLY: NOISE=-97 08-05 18:59:45.233 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 18:59:45.783 D/ModemStatsService(8570): onSignalStrengthsChanged 08-05 18:59:45.783 D/ModemStatsService(8570): GSM, mRssi=-79 08-05 18:59:47.563 I/ActivityManager(384): START {act=android.intent.action.MAIN cat=[android.intent.category.LAUNCHER] flg=0x10000000 pkg=com.nutomic.syncthingandroid cmp=com.nutomic.syncthingandroid/.gui.MainActivity u=0} from pid 10420 08-05 18:59:47.583 W/ApplicationContext(384): Unable to create files directory /data/data/com.nutomic.syncthingandroid/files 08-05 18:59:47.633 I/ActivityManager(384): Start proc com.nutomic.syncthingandroid for activity com.nutomic.syncthingandroid/.gui.MainActivity: pid=10756 uid=10101 gids={1015, 3003, 1028} 08-05 18:59:47.643 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1354 handle: 0x5d849f30 size: 540 x 888 fmt: 1 usage: 0x933 08-05 18:59:47.673 E/Trace (10756): error opening trace file: No such file or directory (2) 08-05 18:59:47.693 W/IMGSRV (10420): :0: gralloc_unregister_buffer: ID: 1351 handle: 0x5497d1b0 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 18:59:47.693 W/IMGSRV (10420): :0: gralloc_unregister_buffer: ID: 1352 handle: 0x548abd40 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 18:59:47.693 W/IMGSRV (10420): :0: gralloc_unregister_buffer: ID: 1353 handle: 0x5497dfa0 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 18:59:47.693 W/IMGSRV (384): :0: gralloc_device_free: ID: 1351 handle: 0x5af1f540 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 18:59:47.693 W/IMGSRV (384): :0: gralloc_device_free: ID: 1352 handle: 0x5b93a5f0 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 18:59:47.783 D/PhoneStatusBar(516): addNotification score=-20 08-05 18:59:47.803 I/SyncthingService(10756): App started for the first time. Copying default config, keys will be generated automatically 08-05 18:59:47.853 I/ConfigXml(10756): Writing updated config back to file 08-05 18:59:47.873 D/libEGL (10756): loaded /vendor/lib/egl/libEGL_POWERVR_SGX540_121.so 08-05 18:59:47.883 D/libEGL (10756): loaded /vendor/lib/egl/libGLESv1_CM_POWERVR_SGX540_121.so 08-05 18:59:47.893 D/libEGL (10756): loaded /vendor/lib/egl/libGLESv2_POWERVR_SGX540_121.so 08-05 18:59:48.003 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1355 handle: 0x5df35780 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 18:59:48.003 W/IMGSRV (10756): :0: gralloc_register_buffer: ID: 1355 handle: 0x530cc370 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 18:59:48.013 D/OpenGLRenderer(10756): Enabling debug mode 0 08-05 18:59:48.103 I/ConfigXml(10756): Checking for needed config updates 08-05 18:59:48.103 I/ConfigXml(10756): Initializing API key with random string 08-05 18:59:48.103 I/ConfigXml(10756): Writing updated config back to file 08-05 18:59:48.223 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1356 handle: 0x59617d90 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 18:59:48.223 W/IMGSRV (10756): :0: gralloc_register_buffer: ID: 1356 handle: 0x54c94c90 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 18:59:48.243 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 18:59:48.243 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 18:59:48.243 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 18:59:48.243 I/WifiHW (384): REPLY: RSSI=-53 08-05 18:59:48.243 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 18:59:48.243 I/WifiHW (384): REPLY: NOISE=-97 08-05 18:59:48.243 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 18:59:48.243 W/IMGSRV (384): :0: gralloc_device_free: ID: 1353 handle: 0x5621d9d0 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 18:59:48.253 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1357 handle: 0x5bc84730 size: 513 x 168 fmt: 5 usage: 0xb00 08-05 18:59:48.253 W/IMGSRV (10756): :0: gralloc_register_buffer: ID: 1357 handle: 0x54c96120 size: 513 x 168 fmt: 5 usage: 0xb00 08-05 18:59:48.353 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1358 handle: 0x5b94e1c0 size: 513 x 641 fmt: 5 usage: 0xb00 08-05 18:59:48.353 W/IMGSRV (10756): :0: gralloc_register_buffer: ID: 1358 handle: 0x55244390 size: 513 x 641 fmt: 5 usage: 0xb00 08-05 18:59:48.363 I/SyncthingService(10756): Web GUI will be available at http://127.0.0.1:8080 08-05 18:59:48.413 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1359 handle: 0x596698c0 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 18:59:48.413 W/IMGSRV (10756): :0: gralloc_register_buffer: ID: 1359 handle: 0x55c050c0 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 18:59:48.433 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1360 handle: 0x5bc4de70 size: 513 x 168 fmt: 5 usage: 0xb00 08-05 18:59:48.433 W/IMGSRV (10756): :0: gralloc_register_buffer: ID: 1360 handle: 0x5630efc0 size: 513 x 168 fmt: 5 usage: 0xb00 08-05 18:59:48.443 W/IMGSRV (384): :0: gralloc_device_free: ID: 1354 handle: 0x5d849f30 size: 540 x 888 fmt: 1 usage: 0x933 08-05 18:59:48.483 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1361 handle: 0x5d849f30 size: 513 x 641 fmt: 5 usage: 0xb00 08-05 18:59:48.483 W/IMGSRV (10756): :0: gralloc_register_buffer: ID: 1361 handle: 0x5645f9c0 size: 513 x 641 fmt: 5 usage: 0xb00 08-05 18:59:48.503 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1362 handle: 0x5c3c6800 size: 513 x 168 fmt: 5 usage: 0xb00 08-05 18:59:48.503 I/ActivityManager(384): Displayed com.nutomic.syncthingandroid/.gui.MainActivity: +883ms 08-05 18:59:48.503 W/IMGSRV (10756): :0: gralloc_register_buffer: ID: 1362 handle: 0x56460c00 size: 513 x 168 fmt: 5 usage: 0xb00 08-05 18:59:48.533 W/PostTask(10756): Failed to call Rest API at http://127.0.0.1:8080/rest/shutdown 08-05 18:59:48.533 W/PostTask(10756): org.apache.http.conn.HttpHostConnectException: Connection to http://127.0.0.1:8080 refused 08-05 18:59:48.533 W/PostTask(10756): at org.apache.http.impl.conn.DefaultClientConnectionOperator.openConnection(DefaultClientConnectionOperator.java:183) 08-05 18:59:48.533 W/PostTask(10756): at org.apache.http.impl.conn.AbstractPoolEntry.open(AbstractPoolEntry.java:164) 08-05 18:59:48.533 W/PostTask(10756): at org.apache.http.impl.conn.AbstractPooledConnAdapter.open(AbstractPooledConnAdapter.java:119) 08-05 18:59:48.533 W/PostTask(10756): at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:360) 08-05 18:59:48.533 W/PostTask(10756): at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:555) 08-05 18:59:48.533 W/PostTask(10756): at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:487) 08-05 18:59:48.533 W/PostTask(10756): at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:465) 08-05 18:59:48.533 W/PostTask(10756): at com.nutomic.syncthingandroid.syncthing.PostTask.doInBackground(PostTask.java:44) 08-05 18:59:48.533 W/PostTask(10756): at com.nutomic.syncthingandroid.syncthing.PostTask.doInBackground(PostTask.java:17) 08-05 18:59:48.533 W/PostTask(10756): at android.os.AsyncTask$2.call(AsyncTask.java:287) 08-05 18:59:48.533 W/PostTask(10756): at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:305) 08-05 18:59:48.533 W/PostTask(10756): at java.util.concurrent.FutureTask.run(FutureTask.java:137) 08-05 18:59:48.533 W/PostTask(10756): at android.os.AsyncTask$SerialExecutor$1.run(AsyncTask.java:230) 08-05 18:59:48.533 W/PostTask(10756): at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1076) 08-05 18:59:48.533 W/PostTask(10756): at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:569) 08-05 18:59:48.533 W/PostTask(10756): at java.lang.Thread.run(Thread.java:856) 08-05 18:59:48.533 W/PostTask(10756): Caused by: java.net.ConnectException: failed to connect to /127.0.0.1 (port 8080): connect failed: ECONNREFUSED (Connection refused) 08-05 18:59:48.533 W/PostTask(10756): at libcore.io.IoBridge.connect(IoBridge.java:114) 08-05 18:59:48.533 W/PostTask(10756): at java.net.PlainSocketImpl.connect(PlainSocketImpl.java:192) 08-05 18:59:48.533 W/PostTask(10756): at java.net.PlainSocketImpl.connect(PlainSocketImpl.java:460) 08-05 18:59:48.533 W/PostTask(10756): at java.net.Socket.connect(Socket.java:832) 08-05 18:59:48.533 W/PostTask(10756): at org.apache.http.conn.scheme.PlainSocketFactory.connectSocket(PlainSocketFactory.java:119) 08-05 18:59:48.533 W/PostTask(10756): at org.apache.http.impl.conn.DefaultClientConnectionOperator.openConnection(DefaultClientConnectionOperator.java:144) 08-05 18:59:48.533 W/PostTask(10756): ... 15 more 08-05 18:59:48.533 W/PostTask(10756): Caused by: libcore.io.ErrnoException: connect failed: ECONNREFUSED (Connection refused) 08-05 18:59:48.533 W/PostTask(10756): at libcore.io.Posix.connect(Native Method) 08-05 18:59:48.533 W/PostTask(10756): at libcore.io.BlockGuardOs.connect(BlockGuardOs.java:85) 08-05 18:59:48.533 W/PostTask(10756): at libcore.io.IoBridge.connectErrno(IoBridge.java:127) 08-05 18:59:48.533 W/PostTask(10756): at libcore.io.IoBridge.connect(IoBridge.java:112) 08-05 18:59:48.533 W/PostTask(10756): ... 20 more 08-05 18:59:49.473 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1363 handle: 0x5df3a2c0 size: 513 x 641 fmt: 5 usage: 0xb00 08-05 18:59:49.483 W/IMGSRV (10756): :0: gralloc_register_buffer: ID: 1363 handle: 0x5639be90 size: 513 x 641 fmt: 5 usage: 0xb00 08-05 18:59:49.853 W/IMGSRV (10756): :0: gralloc_unregister_buffer: ID: 1358 handle: 0x55244390 size: 513 x 641 fmt: 5 usage: 0xb00 08-05 18:59:49.853 W/IMGSRV (10756): :0: gralloc_unregister_buffer: ID: 1361 handle: 0x5645f9c0 size: 513 x 641 fmt: 5 usage: 0xb00 08-05 18:59:49.853 W/IMGSRV (10756): :0: gralloc_unregister_buffer: ID: 1363 handle: 0x5639be90 size: 513 x 641 fmt: 5 usage: 0xb00 08-05 18:59:49.853 W/IMGSRV (384): :0: gralloc_device_free: ID: 1358 handle: 0x5b94e1c0 size: 513 x 641 fmt: 5 usage: 0xb00 08-05 18:59:49.853 W/IMGSRV (384): :0: gralloc_device_free: ID: 1363 handle: 0x5df3a2c0 size: 513 x 641 fmt: 5 usage: 0xb00 08-05 18:59:50.133 W/IMGSRV (384): :0: gralloc_device_free: ID: 1361 handle: 0x5d849f30 size: 513 x 641 fmt: 5 usage: 0xb00 08-05 18:59:50.903 D/ModemStatsService(8570): onSignalStrengthsChanged 08-05 18:59:50.903 D/ModemStatsService(8570): GSM, mRssi=-83 08-05 18:59:51.243 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 18:59:51.243 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 18:59:51.243 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 18:59:51.243 I/WifiHW (384): REPLY: RSSI=-47 08-05 18:59:51.243 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 18:59:51.243 I/WifiHW (384): REPLY: NOISE=-97 08-05 18:59:51.243 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 18:59:54.243 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 18:59:54.243 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 18:59:54.253 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 18:59:54.253 I/WifiHW (384): REPLY: RSSI=-47 08-05 18:59:54.253 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 18:59:54.253 I/WifiHW (384): REPLY: NOISE=-97 08-05 18:59:54.253 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 18:59:55.633 D/BatteryTempPolicy(384): updateBatteryTemp temperature = 350, Threshhold = 3 08-05 18:59:55.633 D/WifiService(384): ACTION_BATTERY_CHANGED pluggedType: 0 08-05 18:59:55.643 D/GpsLocationProvider(384): Gps MessageHandler. msg.what 11 msg.arg1:0 msg.arg2: 0 08-05 18:59:55.643 I/SBar.BatteryController(516): Show 'discharging': status=3, level=87 08-05 18:59:56.143 V/AlarmManager(384): sending alarm Alarm{214868b8 type 0 com.android.vending} 08-05 18:59:57.253 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 18:59:57.253 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 18:59:57.253 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 18:59:57.253 I/WifiHW (384): REPLY: RSSI=-47 08-05 18:59:57.253 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 18:59:57.253 I/WifiHW (384): REPLY: NOISE=-97 08-05 18:59:57.253 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 18:59:57.833 I/qtaguid (9693): Failed write_ctrl(u 40) res=-1 errno=22 08-05 18:59:57.833 I/qtaguid (9693): Untagging socket 40 failed errno=-22 08-05 18:59:57.833 W/NetworkManagementSocketTagger(9693): untagSocket(40) failed with errno -22 08-05 18:59:57.873 D/Finsky (9693): [1] 5.onFinished: Installation state replication succeeded. 08-05 18:59:58.593 D/ModemStatsService(8570): onSignalStrengthsChanged 08-05 18:59:58.593 D/ModemStatsService(8570): GSM, mRssi=-81 08-05 18:59:59.983 V/AlarmManager(384): sending alarm Alarm{211d31d0 type 3 android} 08-05 19:00:00.253 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:00:00.253 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:00:00.253 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:00:00.253 I/WifiHW (384): REPLY: RSSI=-47 08-05 19:00:00.253 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:00:00.253 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:00:00.253 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:00:01.143 D/ModemStatsService(8570): onSignalStrengthsChanged 08-05 19:00:01.143 D/ModemStatsService(8570): GSM, mRssi=-83 08-05 19:00:03.253 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:00:03.253 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:00:03.253 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:00:03.253 I/WifiHW (384): REPLY: RSSI=-47 08-05 19:00:03.253 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:00:03.253 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:00:03.253 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:00:03.713 D/ModemStatsService(8570): onSignalStrengthsChanged 08-05 19:00:03.713 D/ModemStatsService(8570): GSM, mRssi=-81 08-05 19:00:06.263 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:00:06.263 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:00:06.263 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:00:06.263 I/WifiHW (384): REPLY: RSSI=-47 08-05 19:00:06.263 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:00:06.263 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:00:06.263 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:00:06.263 D/ModemStatsService(8570): onSignalStrengthsChanged 08-05 19:00:06.263 D/ModemStatsService(8570): GSM, mRssi=-83 08-05 19:00:08.833 D/ModemStatsService(8570): onSignalStrengthsChanged 08-05 19:00:08.833 D/ModemStatsService(8570): GSM, mRssi=-81 08-05 19:00:09.263 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:00:09.263 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:00:09.263 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:00:09.263 I/WifiHW (384): REPLY: RSSI=-47 08-05 19:00:09.263 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:00:09.263 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:00:09.263 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:00:11.383 D/ModemStatsService(8570): onSignalStrengthsChanged 08-05 19:00:11.383 D/ModemStatsService(8570): GSM, mRssi=-85 08-05 19:00:11.583 I/SBar.NetworkController(516): refreshSignalCluster: wifi: mWifiConnected=true Wifi=stat_sys_wifi_signal_4_fully Activity=stat_sys_wifi_inout Accessibility="WLAN, drei Balken" 08-05 19:00:12.263 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:00:12.263 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:00:12.263 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:00:12.263 I/WifiHW (384): REPLY: RSSI=-43 08-05 19:00:12.263 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:00:12.263 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:00:12.263 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:00:15.273 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:00:15.273 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:00:15.273 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:00:15.273 I/WifiHW (384): REPLY: RSSI=-43 08-05 19:00:15.273 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:00:15.273 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:00:15.273 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:00:16.513 D/ModemStatsService(8570): onSignalStrengthsChanged 08-05 19:00:16.513 D/ModemStatsService(8570): GSM, mRssi=-77 08-05 19:00:18.273 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:00:18.273 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:00:18.273 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:00:18.273 I/WifiHW (384): REPLY: RSSI=-43 08-05 19:00:18.273 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:00:18.273 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:00:18.273 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:00:19.073 D/ModemStatsService(8570): onSignalStrengthsChanged 08-05 19:00:19.073 D/ModemStatsService(8570): GSM, mRssi=-75 08-05 19:00:19.813 E/ia_watchdog(132): Timer interrupt 08-05 19:00:19.813 E/ia_watchdog(132): waiting for a timer interrupt 08-05 19:00:21.273 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:00:21.273 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:00:21.273 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:00:21.273 I/WifiHW (384): REPLY: RSSI=-46 08-05 19:00:21.273 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:00:21.273 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:00:21.273 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:00:24.283 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:00:24.283 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:00:24.283 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:00:24.283 I/WifiHW (384): REPLY: RSSI=-46 08-05 19:00:24.283 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:00:24.283 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:00:24.283 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:00:27.283 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:00:27.283 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:00:27.283 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:00:27.283 I/WifiHW (384): REPLY: RSSI=-46 08-05 19:00:27.283 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:00:27.283 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:00:27.283 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:00:29.313 D/ModemStatsService(8570): onSignalStrengthsChanged 08-05 19:00:29.313 D/ModemStatsService(8570): GSM, mRssi=-77 08-05 19:00:29.313 I/SBar.NetworkController(516): onSignalStrengthsChanged SignalStrength: 18 -1 -1 -1 -1 -1 -1 -1 -1 -1 -1 -1 gsm|lte 0 -108 -1 false 4 4 0 0 0 99 99 99 4 4 4 4 4 99 99 99 level=4 08-05 19:00:30.283 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:00:30.283 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:00:30.283 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:00:30.283 I/WifiHW (384): REPLY: RSSI=-47 08-05 19:00:30.283 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:00:30.283 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:00:30.283 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:00:32.613 I/SBar.NetworkController(516): refreshSignalCluster: mobile: Signal=stat_sys_signal_4 Roaming=(none) mSimIconId=(none) Accessibility="Volle Telefonsignalstärke","Kein Roaming","" 08-05 19:00:33.293 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:00:33.293 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:00:33.293 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:00:33.293 I/WifiHW (384): REPLY: RSSI=-42 08-05 19:00:33.293 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:00:33.293 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:00:33.293 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:00:34.433 D/ModemStatsService(8570): onSignalStrengthsChanged 08-05 19:00:34.433 D/ModemStatsService(8570): GSM, mRssi=-79 08-05 19:00:36.293 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:00:36.293 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:00:36.293 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:00:36.293 I/WifiHW (384): REPLY: RSSI=-55 08-05 19:00:36.293 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:00:36.293 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:00:36.293 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:00:39.293 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:00:39.293 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:00:39.293 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:00:39.293 I/WifiHW (384): REPLY: RSSI=-53 08-05 19:00:39.293 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:00:39.293 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:00:39.293 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:00:39.553 D/ModemStatsService(8570): onSignalStrengthsChanged 08-05 19:00:39.553 D/ModemStatsService(8570): GSM, mRssi=-77 08-05 19:00:42.303 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:00:42.303 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:00:42.303 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:00:42.303 I/WifiHW (384): REPLY: RSSI=-57 08-05 19:00:42.303 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:00:42.303 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:00:42.303 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:00:42.303 I/SBar.NetworkController(516): onReceive: WifiManager.RSSI_CHANGED_ACTION | WIFI_STATE_CHANGED_ACTION | NETWORK_STATE_CHANGED_ACTION Received 08-05 19:00:42.303 I/SBar.NetworkController(516): refreshSignalCluster: wifi: mWifiConnected=true Wifi=stat_sys_wifi_signal_3_fully Activity=stat_sys_wifi_inout Accessibility="WLAN, zwei Balken" 08-05 19:00:45.303 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:00:45.303 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:00:45.303 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:00:45.303 I/WifiHW (384): REPLY: RSSI=-57 08-05 19:00:45.303 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:00:45.303 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:00:45.303 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:00:48.303 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:00:48.303 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:00:48.303 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:00:48.303 I/WifiHW (384): REPLY: RSSI=-57 08-05 19:00:48.303 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:00:48.303 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:00:48.303 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:00:51.303 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:00:51.303 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:00:51.303 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:00:51.313 I/WifiHW (384): REPLY: RSSI=-57 08-05 19:00:51.313 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:00:51.313 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:00:51.313 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:00:52.633 I/SBar.NetworkController(516): refreshSignalCluster: mobile: mHasMobileDataFeature=true DataTypeShown=(none) Activity=(none) Accessibility="H plus" 08-05 19:00:54.313 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:00:54.313 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:00:54.313 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:00:54.313 I/WifiHW (384): REPLY: RSSI=-58 08-05 19:00:54.313 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:00:54.313 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:00:54.313 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:00:55.793 D/BatteryTempPolicy(384): updateBatteryTemp temperature = 350, Threshhold = 3 08-05 19:00:55.793 D/GpsLocationProvider(384): Gps MessageHandler. msg.what 11 msg.arg1:0 msg.arg2: 0 08-05 19:00:55.793 D/WifiService(384): ACTION_BATTERY_CHANGED pluggedType: 0 08-05 19:00:55.793 I/SBar.BatteryController(516): Show 'discharging': status=3, level=86 08-05 19:00:57.313 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:00:57.313 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:00:57.313 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:00:57.313 I/WifiHW (384): REPLY: RSSI=-58 08-05 19:00:57.313 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:00:57.313 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:00:57.313 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:00:59.983 V/AlarmManager(384): sending alarm Alarm{214165c0 type 3 android} 08-05 19:01:00.323 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:01:00.323 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:01:00.323 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:01:00.323 I/WifiHW (384): REPLY: RSSI=-58 08-05 19:01:00.323 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:01:00.323 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:01:00.323 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:01:01.653 E/dalvikvm(384): JIT CODE cache full 08-05 19:01:01.653 I/dalvikvm(384): codeGenBasicBlockJit returns negative number 08-05 19:01:03.323 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:01:03.323 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:01:03.323 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:01:03.323 I/WifiHW (384): REPLY: RSSI=-59 08-05 19:01:03.323 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:01:03.323 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:01:03.323 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:01:05.863 I/SyncthingNativeCode(10756): panic: runtime error: invalid memory address or nil pointer dereference 08-05 19:01:05.863 I/SyncthingNativeCode(10756): [signal 0xb code=0x1 addr=0x0 pc=0x222f80] 08-05 19:01:05.863 I/SyncthingNativeCode(10756): goroutine 1 [running]: 08-05 19:01:05.863 I/SyncthingNativeCode(10756): runtime.panic(0x3c1430, 0x900c80) 08-05 19:01:05.863 I/SyncthingNativeCode(10756): /usr/lib/go/src/pkg/runtime/panic.c:266 +0x134 08-05 19:01:05.863 I/SyncthingNativeCode(10756): sync/atomic.addUint64(0x5079ba80, 0x1, 0x0, 0x1, 0x0) 08-05 19:01:05.863 I/SyncthingNativeCode(10756): /usr/lib/go/src/pkg/sync/atomic/64bit_arm.go:31 +0x78 08-05 19:01:05.873 I/SyncthingNativeCode(10756): github.com/syndtr/goleveldb/leveldb.(_session).allocFileNum(0x5079ba80, 0x0, 0x0) 08-05 19:01:05.873 I/SyncthingNativeCode(10756): /home/felix/golang/src/github.com/syncthing/syncthing/Godeps/_workspace/src/github.com/syndtr/goleveldb/leveldb/session_util.go:108 +0x58 08-05 19:01:05.873 I/SyncthingNativeCode(10756): github.com/syndtr/goleveldb/leveldb.(_session).newManifest(0x5079ba80, 0x0, 0x0, 0x0, 0x0) 08-05 19:01:05.873 I/SyncthingNativeCode(10756): /home/felix/golang/src/github.com/syncthing/syncthing/Godeps/_workspace/src/github.com/syndtr/goleveldb/leveldb/session_util.go:172 +0x38 08-05 19:01:05.873 I/SyncthingNativeCode(10756): github.com/syndtr/goleveldb/leveldb.(_session).create(0x5079ba80, 0x505cf0a0, 0x505cf001) 08-05 19:01:05.873 I/SyncthingNativeCode(10756): /home/felix/golang/src/github.com/syncthing/syncthing/Godeps/_workspace/src/github.com/syndtr/goleveldb/leveldb/session.go:93 +0x3c 08-05 19:01:05.873 I/SyncthingNativeCode(10756): github.com/syndtr/goleveldb/leveldb.Open(0x403a2a40, 0x507e7cc0, 0x0, 0x0, 0x4039b740, ...) 08-05 19:01:05.873 I/SyncthingNativeCode(10756): /home/felix/golang/src/github.com/syncthing/syncthing/Godeps/_workspace/src/github.com/syndtr/goleveldb/leveldb/db.go:158 +0x158 08-05 19:01:05.873 I/SyncthingNativeCode(10756): github.com/syndtr/goleveldb/leveldb.OpenFile(0x507e7900, 0x33, 0x0, 0x0, 0x0, ...) 08-05 19:01:05.873 I/SyncthingNativeCode(10756): /home/felix/golang/src/github.com/syncthing/syncthing/Godeps/_workspace/src/github.com/syndtr/goleveldb/leveldb/db.go:189 +0x94 08-05 19:01:05.873 I/SyncthingNativeCode(10756): main.main() 08-05 19:01:05.873 I/SyncthingNativeCode(10756): /home/felix/golang/src/github.com/syncthing/syncthing/cmd/syncthing/main.go:237 +0x1598 08-05 19:01:05.873 I/SyncthingNativeCode(10756): goroutine 4 [select]: 08-05 19:01:05.883 I/SyncthingNativeCode(10756): github.com/syncthing/syncthing/events.(_Subscription).Poll(0x5064dfe0, 0xf8475800, 0xd, 0x0, 0x0, ...) 08-05 19:01:05.883 I/SyncthingNativeCode(10756): /home/felix/golang/src/github.com/syncthing/syncthing/events/events.go:157 +0x334 08-05 19:01:05.883 I/SyncthingNativeCode(10756): github.com/syncthing/syncthing/events.(_BufferedSubscription).pollingLoop(0x505faba0) 08-05 19:01:05.883 I/SyncthingNativeCode(10756): /home/felix/golang/src/github.com/syncthing/syncthing/events/events.go:189 +0x40 08-05 19:01:05.883 I/SyncthingNativeCode(10756): created by github.com/syncthing/syncthing/events.NewBufferedSubscription 08-05 19:01:05.883 I/SyncthingNativeCode(10756): /home/felix/golang/src/github.com/syncthing/syncthing/events/events.go:183 +0x190 08-05 19:01:05.883 I/SyncthingNativeCode(10756): goroutine 5 [chan receive]: 08-05 19:01:05.883 I/SyncthingNativeCode(10756): main.trackCPUUsage() 08-05 19:01:05.893 I/SyncthingNativeCode(10756): /home/felix/golang/src/github.com/syncthing/syncthing/cmd/syncthing/gui_unix.go:22 +0x124 08-05 19:01:05.893 I/SyncthingNativeCode(10756): created by main.init·2 08-05 19:01:05.893 I/SyncthingNativeCode(10756): /home/felix/golang/src/github.com/syncthing/syncthing/cmd/syncthing/gui_unix.go:15 +0x3c 08-05 19:01:05.893 I/SyncthingNativeCode(10756): goroutine 7 [chan receive]: 08-05 19:01:05.893 I/SyncthingNativeCode(10756): main.saveConfigLoop(0x50808500, 0x38) 08-05 19:01:05.893 I/SyncthingNativeCode(10756): /home/felix/golang/src/github.com/syncthing/syncthing/cmd/syncthing/main.go:651 +0x48 08-05 19:01:05.893 I/SyncthingNativeCode(10756): created by main.main 08-05 19:01:05.893 I/SyncthingNativeCode(10756): /home/felix/golang/src/github.com/syncthing/syncthing/cmd/syncthing/main.go:237 +0xffc 08-05 19:01:05.903 W/SyncthingNativeCode(10756): Syncthing binary crashed with error code 2 08-05 19:01:05.933 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1364 handle: 0x5699d080 size: 513 x 482 fmt: 1 usage: 0x933 08-05 19:01:05.933 W/IMGSRV (10756): :0: gralloc_register_buffer: ID: 1364 handle: 0x5592b6d0 size: 513 x 482 fmt: 1 usage: 0x933 08-05 19:01:06.323 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:01:06.323 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:01:06.323 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:01:06.323 I/WifiHW (384): REPLY: RSSI=-59 08-05 19:01:06.323 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:01:06.323 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:01:06.323 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:01:07.123 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1365 handle: 0x5c56e640 size: 513 x 482 fmt: 1 usage: 0x933 08-05 19:01:07.123 W/IMGSRV (10756): :0: gralloc_register_buffer: ID: 1365 handle: 0x56469a70 size: 513 x 482 fmt: 1 usage: 0x933 08-05 19:01:07.153 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1366 handle: 0x59617cf0 size: 513 x 482 fmt: 1 usage: 0x933 08-05 19:01:07.153 W/IMGSRV (10756): :0: gralloc_register_buffer: ID: 1366 handle: 0x5592b910 size: 513 x 482 fmt: 1 usage: 0x933 08-05 19:01:09.333 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:01:09.333 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:01:09.333 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:01:09.333 I/WifiHW (384): REPLY: RSSI=-59 08-05 19:01:09.333 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:01:09.333 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:01:09.333 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:01:10.313 D/ModemStatsService(8570): onSignalStrengthsChanged 08-05 19:01:10.313 D/ModemStatsService(8570): GSM, mRssi=-81 08-05 19:01:11.283 I/AndroidRuntime(10756): VM exiting with result code 0, cleanup skipped. 08-05 19:01:11.303 W/InputDispatcher(384): channel '21413900 com.nutomic.syncthingandroid/com.nutomic.syncthingandroid.gui.MainActivity (server)' ~ Consumer closed input channel or an error occurred. events=0x9 08-05 19:01:11.303 E/InputDispatcher(384): channel '21413900 com.nutomic.syncthingandroid/com.nutomic.syncthingandroid.gui.MainActivity (server)' ~ Channel is unrecoverably broken and will be disposed! 08-05 19:01:11.303 W/InputDispatcher(384): Attempted to unregister already unregistered input channel '21413900 com.nutomic.syncthingandroid/com.nutomic.syncthingandroid.gui.MainActivity (server)' 08-05 19:01:11.303 I/ActivityManager(384): Process com.nutomic.syncthingandroid (pid 10756) has died. 08-05 19:01:11.303 I/WindowState(384): WIN DEATH: Window{21eeb430 com.nutomic.syncthingandroid/com.nutomic.syncthingandroid.gui.MainActivity paused=false} 08-05 19:01:11.303 W/ActivityManager(384): Scheduling restart of crashed service com.nutomic.syncthingandroid/.syncthing.SyncthingService in 5000ms 08-05 19:01:11.303 W/ActivityManager(384): Force removing ActivityRecord{21776488 com.nutomic.syncthingandroid/.gui.MainActivity}: app died, no saved state 08-05 19:01:11.303 I/WindowState(384): WIN DEATH: Window{21413900 com.nutomic.syncthingandroid/com.nutomic.syncthingandroid.gui.MainActivity paused=false} 08-05 19:01:11.303 I/WindowState(384): WIN DEATH: Window{2187ba50 paused=false} 08-05 19:01:11.303 I/WindowManager(384): WINDOW DIED Window{21413900 com.nutomic.syncthingandroid/com.nutomic.syncthingandroid.gui.MainActivity paused=false} 08-05 19:01:11.313 W/IMGSRV (384): :0: gralloc_device_free: ID: 1355 handle: 0x5df35780 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 19:01:11.343 W/IMGSRV (384): :0: gralloc_device_free: ID: 1359 handle: 0x596698c0 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 19:01:11.343 W/IMGSRV (384): :0: gralloc_device_free: ID: 1356 handle: 0x59617d90 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 19:01:11.923 I/Choreographer(7814): Skipped 33 frames! The application may be doing too much work on its main thread. 08-05 19:01:11.923 D/hwcomposer(384): isOverlayLayer: got an overlay layer 08-05 19:01:11.923 D/hwcomposer(384): isOverlayLayer: got an overlay layer 08-05 19:01:11.923 D/hwcomposer(384): int IntelDisplayPlaneManager::setZOrderConfig(int, int): set zorder: 1 08-05 19:01:11.923 D/hwcomposer(384): void IntelHWComposerLayerList::clearWithOpenGL() const: clear fb here, size 540 x 960 08-05 19:01:11.973 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1367 handle: 0x59080190 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 19:01:11.973 W/IMGSRV (384): :0: gralloc_device_free: ID: 1357 handle: 0x5bc84730 size: 513 x 168 fmt: 5 usage: 0xb00 08-05 19:01:11.973 W/IMGSRV (384): :0: gralloc_device_free: ID: 1362 handle: 0x5c3c6800 size: 513 x 168 fmt: 5 usage: 0xb00 08-05 19:01:11.973 W/IMGSRV (384): :0: gralloc_device_free: ID: 1364 handle: 0x5699d080 size: 513 x 482 fmt: 1 usage: 0x933 08-05 19:01:11.973 W/IMGSRV (384): :0: gralloc_device_free: ID: 1366 handle: 0x59617cf0 size: 513 x 482 fmt: 1 usage: 0x933 08-05 19:01:11.973 D/hwcomposer(384): isOverlayLayer: got an overlay layer 08-05 19:01:11.973 D/hwcomposer(384): isOverlayLayer: got an overlay layer 08-05 19:01:11.973 D/hwcomposer(384): void IntelHWComposerLayerList::clearWithOpenGL() const: clear fb here, size 540 x 960 08-05 19:01:11.973 W/IMGSRV (7814): :0: gralloc_register_buffer: ID: 1367 handle: 0x55c0a3f0 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 19:01:12.013 W/IMGSRV (384): :0: gralloc_device_free: ID: 1360 handle: 0x5bc4de70 size: 513 x 168 fmt: 5 usage: 0xb00 08-05 19:01:12.013 W/IMGSRV (384): :0: gralloc_device_free: ID: 1365 handle: 0x5c56e640 size: 513 x 482 fmt: 1 usage: 0x933 08-05 19:01:12.023 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1368 handle: 0x5bc9a300 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 19:01:12.023 D/hwcomposer(384): isOverlayLayer: got an overlay layer 08-05 19:01:12.023 D/hwcomposer(384): isOverlayLayer: got an overlay layer 08-05 19:01:12.023 W/IMGSRV (7814): :0: gralloc_register_buffer: ID: 1368 handle: 0x55bff9b0 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 19:01:12.023 D/hwcomposer(384): void IntelHWComposerLayerList::clearWithOpenGL() const: clear fb here, size 540 x 960 08-05 19:01:12.033 W/InputMethodManagerService(384): Got RemoteException sending setActive(false) notification to pid 10756 uid 10101 08-05 19:01:12.073 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1369 handle: 0x5e92d350 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 19:01:12.073 D/hwcomposer(384): isOverlayLayer: got an overlay layer 08-05 19:01:12.073 D/hwcomposer(384): isOverlayLayer: got an overlay layer 08-05 19:01:12.073 W/IMGSRV (7814): :0: gralloc_register_buffer: ID: 1369 handle: 0x55bfeaa0 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 19:01:12.073 D/hwcomposer(384): void IntelHWComposerLayerList::clearWithOpenGL() const: clear fb here, size 540 x 960 08-05 19:01:12.113 D/hwcomposer(384): int IntelDisplayPlaneManager::setZOrderConfig(int, int): set zorder: 3 08-05 19:01:12.153 D/hwcomposer(384): bool IntelOverlayContext::disable(): disable overlay... 08-05 19:01:12.173 D/hwcomposer(384): bool IntelOverlayContext::disable(): disable overlay... 08-05 19:01:12.333 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:01:12.333 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:01:12.333 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:01:12.333 I/WifiHW (384): REPLY: RSSI=-41 08-05 19:01:12.333 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:01:12.333 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:01:12.333 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:01:12.333 I/SBar.NetworkController(516): onReceive: WifiManager.RSSI_CHANGED_ACTION | WIFI_STATE_CHANGED_ACTION | NETWORK_STATE_CHANGED_ACTION Received 08-05 19:01:12.333 I/SBar.NetworkController(516): refreshSignalCluster: wifi: mWifiConnected=true Wifi=stat_sys_wifi_signal_4_fully Activity=(none) Accessibility="WLAN, drei Balken" 08-05 19:01:12.823 D/ModemStatsService(8570): onSignalStrengthsChanged 08-05 19:01:12.823 D/ModemStatsService(8570): GSM, mRssi=-85 08-05 19:01:13.633 D/Vibrator_instance(384): intelVibraOff : Turn OFF vibrator request 08-05 19:01:13.633 D/EVENT_THREAD(384): void CEventThread::trig(): in 08-05 19:01:13.633 D/EVENT_THREAD(384): void CEventThread::trig(): out 08-05 19:01:13.633 D/Vibrator_instance(384): intelVibraOn : Turn ON vibrator for 20 ms request 08-05 19:01:13.633 D/EVENT_THREAD(384): void CEventThread::trig(): in 08-05 19:01:13.633 D/EVENT_THREAD(384): void CEventThread::trig(): out 08-05 19:01:13.753 D/dalvikvm(516): GC_FOR_ALLOC freed 3334K, 54% free 13356K/28864K, paused 23ms, total 23ms 08-05 19:01:13.793 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1370 handle: 0x5df35780 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 19:01:13.793 W/IMGSRV (516): :0: gralloc_register_buffer: ID: 1370 handle: 0x5657fdf0 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 19:01:13.833 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1371 handle: 0x5699faa0 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 19:01:13.843 W/IMGSRV (516): :0: gralloc_register_buffer: ID: 1371 handle: 0x5309f080 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 19:01:15.333 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:01:15.333 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:01:15.333 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:01:15.333 I/WifiHW (384): REPLY: RSSI=-41 08-05 19:01:15.333 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:01:15.333 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:01:15.333 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:01:15.433 D/ModemStatsService(8570): onSignalStrengthsChanged 08-05 19:01:15.433 D/ModemStatsService(8570): GSM, mRssi=-83 08-05 19:01:15.443 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1372 handle: 0x560c6400 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 19:01:15.453 W/IMGSRV (516): :0: gralloc_register_buffer: ID: 1372 handle: 0x551d83e0 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 19:01:15.863 E/ia_watchdog(132): Timer interrupt 08-05 19:01:15.863 E/ia_watchdog(132): waiting for a timer interrupt 08-05 19:01:16.303 I/ActivityManager(384): Start proc com.nutomic.syncthingandroid for service com.nutomic.syncthingandroid/.syncthing.SyncthingService: pid=10790 uid=10101 gids={1015, 3003, 1028} 08-05 19:01:16.313 E/Trace (10790): error opening trace file: No such file or directory (2) 08-05 19:01:16.313 D/PhoneStatusBar(516): addNotification score=-20 08-05 19:01:16.363 I/ConfigXml(10790): Checking for needed config updates 08-05 19:01:16.363 I/SyncthingService(10790): Web GUI will be available at http://127.0.0.1:8080 08-05 19:01:16.403 W/PostTask(10790): Failed to call Rest API at http://127.0.0.1:8080/rest/shutdown 08-05 19:01:16.403 W/PostTask(10790): org.apache.http.conn.HttpHostConnectException: Connection to http://127.0.0.1:8080 refused 08-05 19:01:16.403 W/PostTask(10790): at org.apache.http.impl.conn.DefaultClientConnectionOperator.openConnection(DefaultClientConnectionOperator.java:183) 08-05 19:01:16.403 W/PostTask(10790): at org.apache.http.impl.conn.AbstractPoolEntry.open(AbstractPoolEntry.java:164) 08-05 19:01:16.403 W/PostTask(10790): at org.apache.http.impl.conn.AbstractPooledConnAdapter.open(AbstractPooledConnAdapter.java:119) 08-05 19:01:16.403 W/PostTask(10790): at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:360) 08-05 19:01:16.403 W/PostTask(10790): at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:555) 08-05 19:01:16.403 W/PostTask(10790): at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:487) 08-05 19:01:16.403 W/PostTask(10790): at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:465) 08-05 19:01:16.403 W/PostTask(10790): at com.nutomic.syncthingandroid.syncthing.PostTask.doInBackground(PostTask.java:44) 08-05 19:01:16.403 W/PostTask(10790): at com.nutomic.syncthingandroid.syncthing.PostTask.doInBackground(PostTask.java:17) 08-05 19:01:16.403 W/PostTask(10790): at android.os.AsyncTask$2.call(AsyncTask.java:287) 08-05 19:01:16.403 W/PostTask(10790): at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:305) 08-05 19:01:16.403 W/PostTask(10790): at java.util.concurrent.FutureTask.run(FutureTask.java:137) 08-05 19:01:16.403 W/PostTask(10790): at android.os.AsyncTask$SerialExecutor$1.run(AsyncTask.java:230) 08-05 19:01:16.403 W/PostTask(10790): at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1076) 08-05 19:01:16.403 W/PostTask(10790): at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:569) 08-05 19:01:16.403 W/PostTask(10790): at java.lang.Thread.run(Thread.java:856) 08-05 19:01:16.403 W/PostTask(10790): Caused by: java.net.ConnectException: failed to connect to /127.0.0.1 (port 8080): connect failed: ECONNREFUSED (Connection refused) 08-05 19:01:16.403 W/PostTask(10790): at libcore.io.IoBridge.connect(IoBridge.java:114) 08-05 19:01:16.403 W/PostTask(10790): at java.net.PlainSocketImpl.connect(PlainSocketImpl.java:192) 08-05 19:01:16.403 W/PostTask(10790): at java.net.PlainSocketImpl.connect(PlainSocketImpl.java:460) 08-05 19:01:16.403 W/PostTask(10790): at java.net.Socket.connect(Socket.java:832) 08-05 19:01:16.403 W/PostTask(10790): at org.apache.http.conn.scheme.PlainSocketFactory.connectSocket(PlainSocketFactory.java:119) 08-05 19:01:16.403 W/PostTask(10790): at org.apache.http.impl.conn.DefaultClientConnectionOperator.openConnection(DefaultClientConnectionOperator.java:144) 08-05 19:01:16.403 W/PostTask(10790): ... 15 more 08-05 19:01:16.403 W/PostTask(10790): Caused by: libcore.io.ErrnoException: connect failed: ECONNREFUSED (Connection refused) 08-05 19:01:16.403 W/PostTask(10790): at libcore.io.Posix.connect(Native Method) 08-05 19:01:16.403 W/PostTask(10790): at libcore.io.BlockGuardOs.connect(BlockGuardOs.java:85) 08-05 19:01:16.403 W/PostTask(10790): at libcore.io.IoBridge.connectErrno(IoBridge.java:127) 08-05 19:01:16.403 W/PostTask(10790): at libcore.io.IoBridge.connect(IoBridge.java:112) 08-05 19:01:16.403 W/PostTask(10790): ... 20 more 08-05 19:01:17.383 E/CRASHLOG(178): log service stopped whereas property is set .. restarting 08-05 19:01:17.953 D/ModemStatsService(8570): onSignalStrengthsChanged 08-05 19:01:17.953 D/ModemStatsService(8570): GSM, mRssi=-85 08-05 19:01:18.343 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:01:18.343 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:01:18.343 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:01:18.343 I/WifiHW (384): REPLY: RSSI=-47 08-05 19:01:18.343 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:01:18.343 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:01:18.343 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:01:19.103 D/dalvikvm(140): WAIT_FOR_CONCURRENT_GC blocked 0ms 08-05 19:01:19.103 I/ActivityManager(384): Start proc com.nolanlawson.logcat for activity com.nolanlawson.logcat/.LogcatActivity: pid=10817 uid=10114 gids={1015, 1028} 08-05 19:01:19.123 D/dalvikvm(140): GC_EXPLICIT freed 42K, 3% free 8259K/8472K, paused 2ms+1ms, total 25ms 08-05 19:01:19.123 D/dalvikvm(140): WAIT_FOR_CONCURRENT_GC blocked 0ms 08-05 19:01:19.143 D/dalvikvm(140): GC_EXPLICIT freed <1K, 3% free 8259K/8472K, paused 1ms+0ms, total 19ms 08-05 19:01:19.143 D/dalvikvm(140): WAIT_FOR_CONCURRENT_GC blocked 0ms 08-05 19:01:19.163 D/dalvikvm(140): GC_EXPLICIT freed <1K, 3% free 8259K/8472K, paused 1ms+1ms, total 15ms 08-05 19:01:19.163 I/dalvikvm(10817): Turning on JNI app bug workarounds for target SDK version 10... 08-05 19:01:19.173 E/Trace (10817): error opening trace file: No such file or directory (2) 08-05 19:01:19.193 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1373 handle: 0x56207590 size: 540 x 888 fmt: 2 usage: 0x933 08-05 19:01:19.213 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1374 handle: 0x560c8db0 size: 246 x 218 fmt: 1 usage: 0x933 08-05 19:01:19.273 W/IMGSRV (7814): :0: gralloc_unregister_buffer: ID: 1367 handle: 0x55c0a3f0 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 19:01:19.273 W/IMGSRV (7814): :0: gralloc_unregister_buffer: ID: 1368 handle: 0x55bff9b0 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 19:01:19.273 W/IMGSRV (7814): :0: gralloc_unregister_buffer: ID: 1369 handle: 0x55bfeaa0 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 19:01:19.273 W/IMGSRV (384): :0: gralloc_device_free: ID: 1367 handle: 0x59080190 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 19:01:19.273 W/IMGSRV (384): :0: gralloc_device_free: ID: 1369 handle: 0x5e92d350 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 19:01:19.373 W/IMGSRV (516): :0: gralloc_unregister_buffer: ID: 1370 handle: 0x5657fdf0 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 19:01:19.373 W/IMGSRV (516): :0: gralloc_unregister_buffer: ID: 1371 handle: 0x5309f080 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 19:01:19.373 W/IMGSRV (516): :0: gralloc_unregister_buffer: ID: 1372 handle: 0x551d83e0 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 19:01:19.373 W/IMGSRV (384): :0: gralloc_device_free: ID: 1370 handle: 0x5df35780 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 19:01:19.373 W/IMGSRV (384): :0: gralloc_device_free: ID: 1372 handle: 0x560c6400 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 19:01:19.423 W/IMGSRV (384): :0: gralloc_device_free: ID: 1368 handle: 0x5bc9a300 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 19:01:19.433 V/PhoneStatusBar(516): setLightsOn(true) 08-05 19:01:19.453 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1375 handle: 0x5c5d77a0 size: 540 x 888 fmt: 2 usage: 0x933 08-05 19:01:19.463 W/IMGSRV (10817): :0: gralloc_register_buffer: ID: 1375 handle: 0x527ef220 size: 540 x 888 fmt: 2 usage: 0x933 08-05 19:01:19.483 I/ActivityManager(384): Displayed com.nolanlawson.logcat/.LogcatActivity: +392ms 08-05 19:01:19.573 W/IMGSRV (384): :0: gralloc_device_free: ID: 1371 handle: 0x5699faa0 size: 540 x 888 fmt: 5 usage: 0xb00 08-05 19:01:19.683 W/IMGSRV (384): :0: gralloc_device_free: ID: 1373 handle: 0x56207590 size: 540 x 888 fmt: 2 usage: 0x933 08-05 19:01:19.783 W/IMGSRV (384): :0: gralloc_device_free: ID: 1374 handle: 0x560c8db0 size: 246 x 218 fmt: 1 usage: 0x933 08-05 19:01:19.783 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1376 handle: 0x59617d20 size: 540 x 888 fmt: 2 usage: 0x933 08-05 19:01:19.793 W/IMGSRV (10817): :0: gralloc_register_buffer: ID: 1376 handle: 0x527f0b90 size: 540 x 888 fmt: 2 usage: 0x933 08-05 19:01:19.873 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1377 handle: 0x560c8db0 size: 540 x 888 fmt: 2 usage: 0x933 08-05 19:01:19.873 W/IMGSRV (10817): :0: gralloc_register_buffer: ID: 1377 handle: 0x530c4300 size: 540 x 888 fmt: 2 usage: 0x933 08-05 19:01:21.343 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:01:21.343 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:01:21.343 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:01:21.343 I/WifiHW (384): REPLY: RSSI=-47 08-05 19:01:21.343 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:01:21.343 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:01:21.343 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:01:22.503 I/ActivityManager(384): Process com.android.keychain (pid 10447) has died. 08-05 19:01:22.983 I/ActivityManager(384): Process com.motorola.modemservice (pid 8570) has died. 08-05 19:01:22.983 W/ActivityManager(384): Scheduling restart of crashed service com.motorola.bach.modemstats/.ModemStatsService in 5000ms 08-05 19:01:24.343 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:01:24.343 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:01:24.343 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:01:24.343 I/WifiHW (384): REPLY: RSSI=-42 08-05 19:01:24.343 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:01:24.343 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:01:24.343 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:01:25.893 D/dalvikvm(10817): GC_CONCURRENT freed 6719K, 30% free 16269K/23152K, paused 13ms+40ms, total 134ms 08-05 19:01:26.153 I/WindowState(384): WIN DEATH: Window{218d5548 com.android.browser/com.android.browser.BrowserActivity paused=false} 08-05 19:01:26.153 I/ActivityManager(384): Process com.android.browser (pid 10577) has died. 08-05 19:01:26.163 W/IMGSRV (384): :0: gralloc_device_free: ID: 1304 handle: 0x5e930a20 size: 256 x 256 fmt: 1 usage: 0x133 08-05 19:01:27.343 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:01:27.343 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:01:27.353 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:01:27.353 I/WifiHW (384): REPLY: RSSI=-42 08-05 19:01:27.353 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:01:27.353 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:01:27.353 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:01:27.413 I/Choreographer(10817): Skipped 108 frames! The application may be doing too much work on its main thread. 08-05 19:01:27.993 I/ActivityManager(384): Start proc com.motorola.modemservice for service com.motorola.bach.modemstats/.ModemStatsService: pid=10844 uid=10050 gids={1007, 1028} 08-05 19:01:28.003 E/Trace (10844): error opening trace file: No such file or directory (2) 08-05 19:01:28.053 D/ModemStatsService(10844): onCreate 08-05 19:01:28.073 D/ModemStatsService(10844): internet_profile_ids:[0, 2, 3] 08-05 19:01:28.073 D/ModemStatsService(10844): onStartCommand 08-05 19:01:28.073 D/ModemStatsService(10844): receive intent android.net.conn.CONNECTIVITY_CHANGE_IMMEDIATE 08-05 19:01:28.073 D/ModemStatsService(10844): handleConnectivityAction 08-05 19:01:28.113 D/ModemStatsService(10844): handleConnectivityAction: network info = [NetworkInfo: type: WIFI(1)[], state: CONNECTED/CONNECTED, reason: (unspecified), extra: (none), roaming: false, failover: false, isAvailable: true] 08-05 19:01:28.113 D/ModemStatsService(10844): logDataStallEvent for Wifi/Ethernet is connected 08-05 19:01:28.113 D/ModemStatsService(10844): data stall not start, return 08-05 19:01:28.113 D/ModemStatsService(10844): receive intent android.intent.action.SIM_STATE_CHANGED 08-05 19:01:28.113 D/ModemStatsService(10844): receive intent android.intent.action.SIM_STATE_CHANGED: LOADED 08-05 19:01:28.113 D/ModemStatsService(10844): onServiceStateChanged 08-05 19:01:28.113 D/ModemStatsService(10844): old state=1, new state=0 08-05 19:01:28.113 D/ModemStatsService(10844): old data state=1, new data state=0 08-05 19:01:28.113 D/ModemStatsService(10844): old network type=0, new network type=10 08-05 19:01:28.113 D/ModemStatsService(10844): logRATChangedEvent 08-05 19:01:28.113 D/ModemStatsService(10844): start time on rat timer 08-05 19:01:28.113 D/ModemStatsService(10844): time on rat timer start 08-05 19:01:28.113 D/ModemStatsService(10844): not in service -> in service 08-05 19:01:28.113 D/ModemStatsService(10844): onCallStateChanged 08-05 19:01:28.113 D/ModemStatsService(10844): state, is 0 incomingnumber is 08-05 19:01:28.113 D/ModemStatsService(10844): onDataActivity 08-05 19:01:28.113 D/ModemStatsService(10844): direction is 0 08-05 19:01:28.123 D/ModemStatsService(10844): onSignalStrengthsChanged 08-05 19:01:28.123 D/ModemStatsService(10844): GSM, mRssi=-79 08-05 19:01:28.193 D/ModemStatsService(10844): onSignalStrengthsChanged 08-05 19:01:28.193 D/ModemStatsService(10844): GSM, mRssi=-83 08-05 19:01:30.353 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:01:30.353 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:01:30.353 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:01:30.353 I/WifiHW (384): REPLY: RSSI=-42 08-05 19:01:30.353 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:01:30.353 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:01:30.353 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:01:30.793 D/ModemStatsService(10844): onSignalStrengthsChanged 08-05 19:01:30.793 D/ModemStatsService(10844): GSM, mRssi=-85 08-05 19:01:33.313 D/ModemStatsService(10844): onSignalStrengthsChanged 08-05 19:01:33.313 D/ModemStatsService(10844): GSM, mRssi=-89 08-05 19:01:33.353 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:01:33.353 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:01:33.353 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:01:33.353 I/WifiHW (384): REPLY: RSSI=-47 08-05 19:01:33.353 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:01:33.353 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:01:33.353 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:01:33.793 W/SettingsValues(587): Cannot load auto correction threshold setting. currentAutoCorrectionSetting: 0, autoCorrectionThresholdValues: [, 0.185, 0.067, 0] 08-05 19:01:33.863 D/PhoneStatusBar(516): addNotification score=0 08-05 19:01:33.893 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1378 handle: 0x5908fcb0 size: 540 x 805 fmt: 1 usage: 0x933 08-05 19:01:33.893 W/IMGSRV (587): :0: gralloc_register_buffer: ID: 1378 handle: 0x540a8910 size: 540 x 805 fmt: 1 usage: 0x933 08-05 19:01:34.833 D/Vibrator_instance(384): intelVibraOff : Turn OFF vibrator request 08-05 19:01:34.833 D/EVENT_THREAD(384): void CEventThread::trig(): in 08-05 19:01:34.833 D/EVENT_THREAD(384): void CEventThread::trig(): out 08-05 19:01:34.833 D/Vibrator_instance(384): intelVibraOn : Turn ON vibrator for 20 ms request 08-05 19:01:34.833 D/EVENT_THREAD(384): void CEventThread::trig(): in 08-05 19:01:34.833 D/EVENT_THREAD(384): void CEventThread::trig(): out 08-05 19:01:34.853 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1379 handle: 0x59618f90 size: 540 x 805 fmt: 1 usage: 0x933 08-05 19:01:34.853 W/IMGSRV (587): :0: gralloc_register_buffer: ID: 1379 handle: 0x539b9e60 size: 540 x 805 fmt: 1 usage: 0x933 08-05 19:01:34.853 D/Vibrator_instance(384): intelVibraOff : Turn OFF vibrator request 08-05 19:01:34.853 D/EVENT_THREAD(384): void CEventThread::trig(): in 08-05 19:01:34.853 D/EVENT_THREAD(384): void CEventThread::trig(): out 08-05 19:01:34.973 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1380 handle: 0x56ec30c0 size: 540 x 805 fmt: 1 usage: 0x933 08-05 19:01:34.973 W/IMGSRV (587): :0: gralloc_register_buffer: ID: 1380 handle: 0x539ba190 size: 540 x 805 fmt: 1 usage: 0x933 08-05 19:01:35.063 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1381 handle: 0x5b3a2d60 size: 304 x 372 fmt: 1 usage: 0x933 08-05 19:01:35.063 W/IMGSRV (10817): :0: gralloc_register_buffer: ID: 1381 handle: 0x5436b470 size: 304 x 372 fmt: 1 usage: 0x933 08-05 19:01:35.083 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1382 handle: 0x5be90490 size: 304 x 372 fmt: 1 usage: 0x933 08-05 19:01:35.093 W/IMGSRV (10817): :0: gralloc_register_buffer: ID: 1382 handle: 0x5435a870 size: 304 x 372 fmt: 1 usage: 0x933 08-05 19:01:35.273 D/Vibrator_instance(384): intelVibraOff : Turn OFF vibrator request 08-05 19:01:35.273 D/EVENT_THREAD(384): void CEventThread::trig(): in 08-05 19:01:35.273 D/EVENT_THREAD(384): void CEventThread::trig(): out 08-05 19:01:35.273 D/Vibrator_instance(384): intelVibraOn : Turn ON vibrator for 20 ms request 08-05 19:01:35.273 D/EVENT_THREAD(384): void CEventThread::trig(): in 08-05 19:01:35.273 D/EVENT_THREAD(384): void CEventThread::trig(): out 08-05 19:01:35.293 D/Vibrator_instance(384): intelVibraOff : Turn OFF vibrator request 08-05 19:01:35.293 D/EVENT_THREAD(384): void CEventThread::trig(): in 08-05 19:01:35.293 D/EVENT_THREAD(384): void CEventThread::trig(): out 08-05 19:01:35.473 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1383 handle: 0x5620f510 size: 304 x 217 fmt: 1 usage: 0x933 08-05 19:01:35.473 W/IMGSRV (10817): :0: gralloc_register_buffer: ID: 1383 handle: 0x54358410 size: 304 x 217 fmt: 1 usage: 0x933 08-05 19:01:35.913 D/ModemStatsService(10844): onSignalStrengthsChanged 08-05 19:01:35.913 D/ModemStatsService(10844): GSM, mRssi=-91 08-05 19:01:35.913 I/SBar.NetworkController(516): onSignalStrengthsChanged SignalStrength: 11 -1 -1 -1 -1 -1 -1 -1 -1 -1 -1 -1 gsm|lte 0 -108 -1 false 3 3 0 0 0 99 99 99 4 4 4 4 4 99 99 99 level=3 08-05 19:01:35.923 I/SBar.NetworkController(516): refreshSignalCluster: mobile: Signal=stat_sys_signal_3 Roaming=(none) mSimIconId=(none) Accessibility="Telefonsignal - drei Balken","Kein Roaming","" 08-05 19:01:36.013 D/Vibrator_instance(384): intelVibraOff : Turn OFF vibrator request 08-05 19:01:36.013 D/EVENT_THREAD(384): void CEventThread::trig(): in 08-05 19:01:36.013 D/EVENT_THREAD(384): void CEventThread::trig(): out 08-05 19:01:36.013 D/Vibrator_instance(384): intelVibraOn : Turn ON vibrator for 20 ms request 08-05 19:01:36.013 D/EVENT_THREAD(384): void CEventThread::trig(): in 08-05 19:01:36.013 D/EVENT_THREAD(384): void CEventThread::trig(): out 08-05 19:01:36.033 D/Vibrator_instance(384): intelVibraOff : Turn OFF vibrator request 08-05 19:01:36.033 D/EVENT_THREAD(384): void CEventThread::trig(): in 08-05 19:01:36.033 D/EVENT_THREAD(384): void CEventThread::trig(): out 08-05 19:01:36.183 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1384 handle: 0x59617a30 size: 304 x 167 fmt: 1 usage: 0x933 08-05 19:01:36.183 W/IMGSRV (10817): :0: gralloc_unregister_buffer: ID: 1381 handle: 0x5436b470 size: 304 x 372 fmt: 1 usage: 0x933 08-05 19:01:36.183 W/IMGSRV (10817): :0: gralloc_register_buffer: ID: 1384 handle: 0x5378b3b0 size: 304 x 167 fmt: 1 usage: 0x933 08-05 19:01:36.193 W/IMGSRV (384): :0: gralloc_device_free: ID: 1381 handle: 0x5b3a2d60 size: 304 x 372 fmt: 1 usage: 0x933 08-05 19:01:36.243 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1385 handle: 0x59080150 size: 304 x 167 fmt: 1 usage: 0x933 08-05 19:01:36.243 W/IMGSRV (10817): :0: gralloc_unregister_buffer: ID: 1382 handle: 0x5435a870 size: 304 x 372 fmt: 1 usage: 0x933 08-05 19:01:36.243 W/IMGSRV (10817): :0: gralloc_register_buffer: ID: 1385 handle: 0x5378b5d0 size: 304 x 167 fmt: 1 usage: 0x933 08-05 19:01:36.273 W/IMGSRV (384): :0: gralloc_device_free: ID: 1382 handle: 0x5be90490 size: 304 x 372 fmt: 1 usage: 0x933 08-05 19:01:36.273 W/IMGSRV (384): :0: gralloc_device_alloc: ID: 1386 handle: 0x5bc7acc0 size: 304 x 167 fmt: 1 usage: 0x933 08-05 19:01:36.273 W/IMGSRV (10817): :0: gralloc_unregister_buffer: ID: 1383 handle: 0x54358410 size: 304 x 217 fmt: 1 usage: 0x933 08-05 19:01:36.273 W/IMGSRV (10817): :0: gralloc_register_buffer: ID: 1386 handle: 0x5378b9e0 size: 304 x 167 fmt: 1 usage: 0x933 08-05 19:01:36.273 W/IMGSRV (384): :0: gralloc_device_free: ID: 1383 handle: 0x5620f510 size: 304 x 217 fmt: 1 usage: 0x933 08-05 19:01:36.353 I/WifiHW (384): CMD: SIGNAL_POLL 08-05 19:01:36.353 D/wpa_supplicant(458): ctrl_iface: SIGNAL_POLL 08-05 19:01:36.353 D/wpa_supplicant(458): nl80211: survey data missing! 08-05 19:01:36.353 I/WifiHW (384): REPLY: RSSI=-47 08-05 19:01:36.353 I/WifiHW (384): REPLY: LINKSPEED=54 08-05 19:01:36.353 I/WifiHW (384): REPLY: NOISE=-97 08-05 19:01:36.353 I/WifiHW (384): REPLY: FREQUENCY=2422 08-05 19:01:36.503 D/Vibrator_instance(384): intelVibraOff : Turn OFF vibrator request 08-05 19:01:36.503 D/EVENT_THREAD(384): void CEventThread::trig(): in 08-05 19:01:36.503 D/EVENT_THREAD(384): void CEventThread::trig(): out 08-05 19:01:36.503 D/Vibrator_instance(384): intelVibraOn : Turn ON vibrator for 20 ms request 08-05 19:01:36.503 D/EVENT_THREAD(384): void CEventThread::trig(): in 08-05 19:01:36.503 D/EVENT_THREAD(384): void CEventThread::trig(): out 08-05 19:01:36.523 D/Vibrator_instance(384): intelVibraOff : Turn OFF vibrator request 08-05 19:01:36.523 D/EVENT_THREAD(384): void CEventThread::trig(): in 08-05 19:01:36.523 D/EVENT_THREAD(384): void CEventThread::trig(): out 08-05 19:01:37.223 I/SyncthingNativeCode(10790): panic: runtime error: invalid memory address or nil pointer dereference 08-05 19:01:37.223 I/SyncthingNativeCode(10790): [signal 0xb code=0x1 addr=0x0 pc=0x222f80] 08-05 19:01:37.223 I/SyncthingNativeCode(10790): goroutine 1 [running]: 08-05 19:01:37.223 I/SyncthingNativeCode(10790): runtime.panic(0x3c1430, 0x900c80) 08-05 19:01:37.223 I/SyncthingNativeCode(10790): /usr/lib/go/src/pkg/runtime/panic.c:266 +0x134 08-05 19:01:37.233 I/SyncthingNativeCode(10790): sync/atomic.addUint64(0x5066da80, 0x1, 0x0, 0x1, 0x0) 08-05 19:01:37.233 I/SyncthingNativeCode(10790): /usr/lib/go/src/pkg/sync/atomic/64bit_arm.go:31 +0x78 08-05 19:01:37.233 I/SyncthingNativeCode(10790): github.com/syndtr/goleveldb/leveldb.(_session).allocFileNum(0x5066da80, 0x0, 0x0) 08-05 19:01:37.233 I/SyncthingNativeCode(10790): /home/felix/golang/src/github.com/syncthing/syncthing/Godeps/_workspace/src/github.com/syndtr/goleveldb/leveldb/session_util.go:108 +0x58 08-05 19:01:37.233 I/SyncthingNativeCode(10790): github.com/syndtr/goleveldb/leveldb.(_session).newManifest(0x5066da80, 0x0, 0x0, 0x0, 0x0) 08-05 19:01:37.233 I/SyncthingNativeCode(10790): /home/felix/golang/src/github.com/syncthing/syncthing/Godeps/_workspace/src/github.com/syndtr/goleveldb/leveldb/session_util.go:172 +0x38 08-05 19:01:37.233 I/SyncthingNativeCode(10790): github.com/syndtr/goleveldb/leveldb.(_session).create(0x5066da80, 0x505cf0a0, 0x505cf001) 08-05 19:01:37.233 I/SyncthingNativeCode(10790): /home/felix/golang/src/github.com/syncthing/syncthing/Godeps/_workspace/src/github.com/syndtr/goleveldb/leveldb/session.go:93 +0x3c 08-05 19:01:37.233 I/SyncthingNativeCode(10790): github.com/syndtr/goleveldb/leveldb.Open(0x403a2260, 0x506b9340, 0x0, 0x0, 0x4039b740, ...) 08-05 19:01:37.233 I/SyncthingNativeCode(10790): /home/felix/golang/src/github.com/syncthing/syncthing/Godeps/_workspace/src/github.com/syndtr/goleveldb/leveldb/db.go:158 +0x158 08-05 19:01:37.233 I/SyncthingNativeCode(10790): github.com/syndtr/goleveldb/leveldb.OpenFile(0x5060efc0, 0x33, 0x0, 0x0, 0x0, ...) 08-05 19:01:37.233 I/SyncthingNativeCode(10790): /home/felix/golang/src/github.com/syncthing/syncthing/Godeps/_workspace/src/github.com/syndtr/goleveldb/leveldb/db.go:189 +0x94 08-05 19:01:37.233 I/SyncthingNativeCode(10790): main.main() 08-05 19:01:37.243 I/SyncthingNativeCode(10790): /home/felix/golang/src/github.com/syncthing/syncthing/cmd/syncthing/main.go:237 +0x1598 08-05 19:01:37.243 I/SyncthingNativeCode(10790): goroutine 4 [select]: 08-05 19:01:37.243 I/SyncthingNativeCode(10790): github.com/syncthing/syncthing/events.(_Subscription).Poll(0x50718fe0, 0xf8475800, 0xd, 0x0, 0x0, ...) 08-05 19:01:37.243 I/SyncthingNativeCode(10790): /home/felix/golang/src/github.com/syncthing/syncthing/events/events.go:157 +0x334 08-05 19:01:37.243 I/SyncthingNativeCode(10790): github.com/syncthing/syncthing/events.(_BufferedSubscription).pollingLoop(0x505eaba0) 08-05 19:01:37.243 I/SyncthingNativeCode(10790): /home/felix/golang/src/github.com/syncthing/syncthing/events/events.go:189 +0x40 08-05 19:01:37.243 I/SyncthingNativeCode(10790): created by github.com/syncthing/syncthing/events.NewBufferedSubscription 08-05 19:01:37.243 I/SyncthingNativeCode(10790): /home/felix/golang/src/github.com/syncthing/syncthing/events/events.go:183 +0x190 08-05 19:01:37.253 I/SyncthingNativeCode(10790): goroutine 5 [chan receive]: 08-05 19:01:37.253 I/SyncthingNativeCode(10790): main.trackCPUUsage() 08-05 19:01

syndtr commented 10 years ago

It seems that both panic were produced by addUint64, this is strange though, since x86 binary should never reach this code path.

$ find atomic/ -type f | xargs grep addUint64
atomic/asm_linux_arm.s: B       ·addUint64(SB)
atomic/asm_linux_arm.s: B       ·addUint64(SB)
atomic/asm_freebsd_arm.s:       B ·addUint64(SB)
atomic/asm_freebsd_arm.s:       B ·addUint64(SB)
atomic/asm_nacl_arm.s:  B ·addUint64(SB)
atomic/asm_nacl_arm.s:  B ·addUint64(SB)
atomic/asm_netbsd_arm.s:        B ·addUint64(SB)
atomic/asm_netbsd_arm.s:        B ·addUint64(SB)
atomic/64bit_arm.go:func addUint64(val *uint64, delta uint64) (new uint64) {

As you can see addUint64 only called from ARM's asm.

@Eucyon are you sure one of the panic were produced by x86 binary?

MStrecke commented 10 years ago

I'm the "other" Razr-I user with that problem.

The app was installed via the Android App Store. I also tried the X86 version from the Syncthing-Android release - same problem, most likely because it IS the same app.

So, as far as I can tell I'm using the X86 build of the Android wrapper app.

I can't say anything about the syncthing binary itself (the part that is written in Go and is causing the problem). This binary comes bundled with the app.

Nutomic commented 10 years ago

To be absolutely sure it's the right binary, you could try running the linux-amd64 binary from syncthing releases in a terminal on the phone.

But I haven't changed the build process, so I doubt that the binaries would be mixed up

syndtr commented 10 years ago

Apparently libsyncthing in x86 version apk is also an ARM EABI.

$ readelf -h syncthing-android-x86-release/lib/x86/libsyncthing.so 
ELF Header:
  Magic:   7f 45 4c 46 01 01 01 00 00 00 00 00 00 00 00 00 
  Class:                             ELF32
  Data:                              2's complement, little endian
  Version:                           1 (current)
  OS/ABI:                            UNIX - System V
  ABI Version:                       0
  Type:                              EXEC (Executable file)
  Machine:                           ARM
  Version:                           0x1
  Entry point address:               0x57fd4
  Start of program headers:          52 (bytes into file)
  Start of section headers:          244 (bytes into file)
  Flags:                             0x5000202, has entry point, Version5 EABI, soft-float ABI
  Size of this header:               52 (bytes)
  Size of program headers:           32 (bytes)
  Number of program headers:         6
  Size of section headers:           40 (bytes)
  Number of section headers:         13
  Section header string table index: 6

Nutomic commented 10 years ago

Okay you're right, there's definitely something going wrong in the build process. Now I'll have to figure out what exactly.

Sorry for bothering you.

Eucyon commented 10 years ago

Hello all,

back now from work.

Yes, in the log the last occurence of "adduinit" is in line 9061, the last installation of STfA is from up line 7021, and it's a x86 installtion.

Am 06.08.2014 um 07:55 schrieb Suryandaru Triandana:

It seems that both panic were produced by |addUint64|, this is strange though, since x86 binary should never reach this code path.

$ find atomic/ -type f xargs grep addUint64 atomic/asm_linux_arm.s: B ·addUint64(SB) atomic/asm_linux_arm.s: B ·addUint64(SB) atomic/asm_freebsd_arm.s: B ·addUint64(SB) atomic/asm_freebsd_arm.s: B ·addUint64(SB) atomic/asm_nacl_arm.s: B ·addUint64(SB) atomic/asm_nacl_arm.s: B ·addUint64(SB) atomic/asm_netbsd_arm.s: B ·addUint64(SB) atomic/asm_netbsd_arm.s: B ·addUint64(SB) atomic/64bit_arm.go:func addUint64(val *uint64, delta uint64) (new uint64) {

As you can see |addUint64| only called from ARM's asm.

@Eucyon https://github.com/Eucyon are you sure one of the panic were produced by x86 binary?

— Reply to this email directly or view it on GitHub https://github.com/syndtr/goleveldb/issues/60#issuecomment-51296510.

syndtr / goleveldb

Nullpointerexception on Android x86 #60