[vz-dev] vzlogger 0.3.3 stürzt nach 5 - 10 min ab

Wilhelm Eßt wilhelm.esst at tsv-gersthofen.de
Sat Mar 3 09:51:01 CET 2012 

Hallo,

Am Mittwoch, 29. Februar 2012, 19:14:46 schrieb Thorben Thuermer:
> ich vermute mal, es ist es immernoch der hier?
> http://bugs.volkszaehler.org/view.php?id=131
> http://volkszaehler.org/pipermail/volkszaehler-dev/2012-February/001505.htm
> l
> https://github.com/stv0g/vzlogger/commit/d67c965d46c73c12837fa44a483f3ba5b
> 6c732a5
> 
> (sollte aber im git gefixt sein...)
> ansonsten haben wir _schon_wieder_ einen memory-corruption bug,
> steffen wird sich freuen...

jetzt bin ich mal dazugekommen genauer nachzusehen:

Die oben genannten Änderungen sind in meiner Version bereits drin.

Hier noch mal die letzten Zuckungen von vzlogger; diesmal unter Beobachtung 
von valgrind.

---> snip
[Mar 03 08:55:11][ch0]  CURL: Received 17 bytes
[Mar 03 08:55:11][ch0]  CURL: Connection #0 to host (nil) left intact
[Mar 03 08:55:11][ch0]  Request succeeded with code: 200
[Mar 03 08:55:11][ch1]  CURL: Received 17 bytes
[Mar 03 08:55:11][ch1]  CURL: Connection #0 to host (nil) left intact
[Mar 03 08:55:11][ch1]  Request succeeded with code: 200
error: unknown type in sml_value_to_double
error: unknown type in sml_value_to_double
error: unknown type in sml_value_to_double
[Mar 03 08:55:14][mtr0] Got 8 new readings from meter:
[Mar 03 08:55:14][mtr0] Reading: id=129-129:199.130.3*255 value=0.00 
ts=1330761314.264
[Mar 03 08:55:14][mtr0] Reading: id=1-0:0.0.9*255 value=0.00 ts=1330761314.264
[Mar 03 08:55:14][mtr0] Reading: id=1-0:1.8.0*255 value=363055.50 
ts=1330761314.264
[Mar 03 08:55:14][mtr0] Reading: id=1-0:1.8.1*255 value=363055.50 
ts=1330761314.264
[Mar 03 08:55:14][mtr0] Reading: id=1-0:1.8.2*255 value=0.00 ts=1330761314.265
[Mar 03 08:55:14][mtr0] Reading: id=1-0:15.7.0*255 value=2007.50 
ts=1330761314.265
[Mar 03 08:55:14][mtr0] Reading: id=129-129:199.130.5*255 value=0.00 
ts=1330761314.265
[Mar 03 08:55:14][mtr0] Reading: id=0-0:0.0.0*0 value=0.00 ts=0.000
[Mar 03 08:55:14][ch0]  Adding reading to queue (value=363055.50 
ts=1330761314.264)
[Mar 03 08:55:14][ch0]  JSON request body: [ [ 1330761314264.491943, 
363055.500000 ] ]
[Mar 03 08:55:14][ch0]  CURL: Re-using existing connection! (#0) with host 
(nil)
[Mar 03 08:55:14][ch0]  CURL: Connected to (nil) (127.0.0.1) port 80 (#0)
[Mar 03 08:55:14][ch0]  CURL: Sent 43 bytes.. 
[Mar 03 08:55:14][ch0]  CURL: upload completely sent off: 43 out of 43 bytes
[Mar 03 08:55:14][ch0]  CURL: additional stuff not fine transfer.c:1037: 0 0
[Mar 03 08:55:14][ch0]  Buffer dump (size=1 keep=0): {363055.50!}
[Mar 03 08:55:14][ch1]  Adding reading to queue (value=2007.50 
ts=1330761314.265)
[Mar 03 08:55:14][ch1]  JSON request body: [ [ 1330761314264.512939, 
2007.500000 ] ]
[Mar 03 08:55:14][ch1]  CURL: Re-using existing connection! (#0) with host 
(nil)
[Mar 03 08:55:14][ch1]  CURL: Connected to (nil) (127.0.0.1) port 80 (#0)
[Mar 03 08:55:14][ch1]  CURL: Sent 41 bytes.. 
[Mar 03 08:55:14][ch1]  CURL: upload completely sent off: 41 out of 41 bytes
[Mar 03 08:55:14][ch1]  CURL: additional stuff not fine transfer.c:1037: 0 0
[Mar 03 08:55:14][ch1]  Buffer dump (size=1 keep=0): {2007.50!}
[Mar 03 08:55:14][ch1]  CURL: HTTP 1.1 or later with persistent connection, 
pipelining supported
[Mar 03 08:55:14][ch1]  CURL: Received 17 bytes
[Mar 03 08:55:14][ch1]  CURL: Connection #0 to host (nil) left intact
[Mar 03 08:55:14][ch1]  Request succeeded with code: 200
[Mar 03 08:55:14][ch0]  CURL: HTTP 1.1 or later with persistent connection, 
pipelining supported
[Mar 03 08:55:14][ch0]  CURL: Received 17 bytes
[Mar 03 08:55:14][ch0]  CURL: Connection #0 to host (nil) left intact
[Mar 03 08:55:14][ch0]  Request succeeded with code: 200
*** longjmp causes uninitialized stack frame ***: vzlogger terminated
======= Backtrace: =========
/lib/i386-linux-gnu/i686/cmov/libc.so.6(__fortify_fail+0x50)[0x41fcc90]
/lib/i386-linux-gnu/i686/cmov/libc.so.6(+0xe4bfa)[0x41fcbfa]
/usr/lib/i386-linux-gnu/libcurl.so.4(+0x9445)[0x40a4445]
vzlogger[0x804aff9]
/lib/i386-linux-gnu/i686/cmov/libc.so.6(__libc_start_main+0xe6)[0x412ee46]
vzlogger[0x804a5d1]
======= Memory map: ========
04000000-0401b000 r-xp 00000000 08:07 2568313    /lib/i386-linux-
gnu/ld-2.13.so
0401b000-0401c000 r--p 0001b000 08:07 2568313    /lib/i386-linux-
gnu/ld-2.13.so
0401c000-0401d000 rw-p 0001c000 08:07 2568313    /lib/i386-linux-
gnu/ld-2.13.so
0401d000-0401f000 rw-p 00000000 00:00 0 
0401f000-04020000 r-xp 00000000 08:07 654132     
/usr/lib/valgrind/vgpreload_core-x86-linux.so
04020000-04021000 rw-p 00000000 08:07 654132     
/usr/lib/valgrind/vgpreload_core-x86-linux.so
04021000-0402a000 r-xp 00000000 08:07 654705     
/usr/lib/valgrind/vgpreload_memcheck-x86-linux.so
0402a000-0402b000 rw-p 00008000 08:07 654705     
/usr/lib/valgrind/vgpreload_memcheck-x86-linux.so
0402b000-0402d000 rw-p 00000000 00:00 0 
0402d000-04037000 r-xp 00000000 08:07 3238337    /lib/i386-linux-
gnu/i686/cmov/libnss_files-2.13.so
04037000-04038000 r--p 00009000 08:07 3238337    /lib/i386-linux-
gnu/i686/cmov/libnss_files-2.13.so
04038000-04039000 rw-p 0000a000 08:07 3238337    /lib/i386-linux-
gnu/i686/cmov/libnss_files-2.13.so
04054000-04069000 r-xp 00000000 08:07 3238108    /lib/i386-linux-
gnu/i686/cmov/libpthread-2.13.so
04069000-0406a000 r--p 00014000 08:07 3238108    /lib/i386-linux-
gnu/i686/cmov/libpthread-2.13.so
0406a000-0406b000 rw-p 00015000 08:07 3238108    /lib/i386-linux-
gnu/i686/cmov/libpthread-2.13.so
0406b000-0406e000 rw-p 00000000 00:00 0 
0406e000-04092000 r-xp 00000000 08:07 3238194    /lib/i386-linux-
gnu/i686/cmov/libm-2.13.so
04092000-04093000 r--p 00023000 08:07 3238194    /lib/i386-linux-
gnu/i686/cmov/libm-2.13.so
04093000-04094000 rw-p 00024000 08:07 3238194    /lib/i386-linux-
gnu/i686/cmov/libm-2.13.so
04094000-0409a000 r-xp 00000000 08:07 1586219    /usr/lib/libjson.so.0.0.1
0409a000-0409b000 rw-p 00005000 08:07 1586219    /usr/lib/libjson.so.0.0.1
0409b000-04105000 r-xp 00000000 08:07 3156818    /usr/lib/i386-linux-
gnu/libcurl.so.4.2.0
04105000-04106000 ---p 0006a000 08:07 3156818    /usr/lib/i386-linux-
gnu/libcurl.so.4.2.0
04106000-04108000 r--p 0006a000 08:07 3156818    /usr/lib/i386-linux-
gnu/libcurl.so.4.2.0
04108000-04109000 rw-p 0006c000 08:07 3156818    /usr/lib/i386-linux-
gnu/libcurl.so.4.2.0
04109000-0410d000 r-xp 00000000 08:07 3239006    /lib/libuuid.so.1.3.0
0410d000-0410e000 rw-p 00003000 08:07 3239006    /lib/libuuid.so.1.3.0
0410e000-04116000 r-xp 00000000 08:07 1586906    
/usr/lib/libmicrohttpd.so.5.2.1
04116000-04117000 rw-p 00008000 08:07 1586906    
/usr/lib/libmicrohttpd.so.5.2.1
04117000-04118000 rw-p 00000000 00:00 0 
04118000-0426e000 r-xp 00000000 08:07 3238335    /lib/i386-linux-
gnu/i686/cmov/libc-2.13.so
0426e000-0426f000 ---p 00156000 08:07 3238335    /lib/i386-linux-
gnu/i686/cmov/libc-2.13.so
0426f000-04271000 r--p 00156000 08:07 3238335    /lib/i386-linux-
gnu/i686/cmov/libc-2.13.so
04271000-04272000 rw-p 00158000 08:07 3238335    /lib/i386-linux-
gnu/i686/cmov/libc-2.13.so
04272000-04275000 rw-p 00000000 00:00 0 
04275000-042a7000 r-xp 00000000 08:07 3157423    /usr/lib/i386-linux-
gnu/libidn.so.11.6.6
042a7000-042a8000 rw-p 00032000 08:07 3157423    /usr/lib/i386-linux-
gnu/libidn.so.11.6.6
042a8000-042ce000 r-xp 00000000 08:07 3109219    /usr/lib/libssh2.so.1.0.1
042ce000-042cf000 rw-p 00025000 08:07 3109219    /usr/lib/libssh2.so.1.0.1
042cf000-042dc000 r-xp 00000000 08:07 3157366    /usr/lib/i386-linux-
gnu/liblber-2.4.so.2.8.1
042dc000-042dd000 r--p 0000d000 08:07 3157366    /usr/lib/i386-linux-
gnu/liblber-2.4.so.2.8.1
042dd000-042de000 rw-p 0000e000 08:07 3157366    /usr/lib/i386-linux-
gnu/liblber-2.4.so.2.8.1
042de000-0432c000 r-xp 00000000 08:07 3157365    /usr/lib/i386-linux-
gnu/libldap_r-2.4.so.2.8.1
0432c000-0432d000 r--p 0004d000 08:07 3157365    /usr/lib/i386-linux-
gnu/libldap_r-2.4.so.2.8.1
0432d000-0432e000 rw-p 0004e000 08:07 3157365    /usr/lib/i386-linux-
gnu/libldap_r-2.4.so.2.8.1
0432e000-04330000 rw-p 00000000 00:00 0 
04330000-04337000 r-xp 00000000 08:07 3238526    /lib/i386-linux-
gnu/i686/cmov/librt-2.13.so
04337000-04338000 r--p 00006000 08:07 3238526    /lib/i386-linux-
gnu/i686/cmov/librt-2.13.so
04338000-04339000 rw-p 00007000 08:07 3238526    /lib/i386-linux-
gnu/i686/cmov/librt-2.13.so
04339000-04375000 r-xp 00000000 08:07 2911318    /usr/lib/i386-linux-
gnu/libgssapi_krb5.so.2.2
04375000-04376000 r--p 0003c000 08:07 2911318    /usr/lib/i386-linux-
gnu/libgssapi_krb5.so.2.2
04376000-04377000 rw-p 0003d000 08:07 2911318    /usr/lib/i386-linux-
gnu/libgssapi_krb5.so.2.2
04377000-043c0000 r-xp 00000000 08:07 2763915    /usr/lib/i386-linux-
gnu/i686/cmov/libssl.so.1.0.0
043c0000-043c4000 rw-p 00049000 08:07 2763915    /usr/lib/i386-linux-
gnu/i686/cmov/libssl.so.1.0.0
043c4000-0455a000 r-xp 00000000 08:07 2763912    /usr/lib/i386-linux-
gnu/i686/cmov/libcrypto.so.1.0.0
0455a000-0456f000 rw-p 00196000 08:07 2763912    /usr/lib/i386-linux-
gnu/i686/cmov/libcrypto.so.1.0.0
0456f000-04572000 rw-p 00000000 00:00 0 
04572000-0458b000 r-xp 00000000 08:07 3157444    /usr/lib/i386-linux-
gnu/librtmp.so.0
0458b000-0458c000 rw-p 00018000 08:07 3157444    /usr/lib/i386-linux-
gnu/librtmp.so.0
0458c000-0458d000 rw-p 00000000 00:00 0 
0458d000-045a3000 r-xp 00000000 08:07 3157026    /usr/lib/i386-linux-
gnu/libz.so.1.2.6
045a3000-045a4000 rw-p 00015000 08:07 3157026    /usr/lib/i386-linux-
gnu/libz.so.1.2.6
045a4000-04666000 r-xp 00000000 08:07 2910828    /usr/lib/i386-linux-
gnu/libgnutls.so.26.21.9
04666000-0466b000 rw-p 000c1000 08:07 2910828    /usr/lib/i386-linux-
gnu/libgnutls.so.26.21.9
0466b000-046ed000 r-xp 00000000 08:07 3238164    /lib/i386-linux-
gnu/libgcrypt.so.11.7.0
046ed000-046f0000 rw-p 00081000 08:07 3238164    /lib/i386-linux-
gnu/libgcrypt.so.11.7.0
046f0000-04700000 r-xp 00000000 08:07 3238149    /lib/i386-linux-
gnu/i686/cmov/libresolv-2.13.so
04700000-04701000 r--p 00010000 08:07 3238149    /lib/i386-linux-
gnu/i686/cmov/libresolv-2.13.so
04701000-04702000 rw-p 00011000 08:07 3238149    /lib/i386-linux-
gnu/i686/cmov/libresolv-2.13.so
04702000-04704000 rw-p 00000000 00:00 0 
04704000-0471e000 r-xp 00000000 08:07 3156463    /usr/lib/i386-linux-
gnu/libsasl2.so.2.0.25
0471e000-0471f000 r--p 00019000 08:07 3156463    /usr/lib/i386-linux-
gnu/libsasl2.so.2.0.25
0471f000-04720000 rw-p 0001a000 08:07 3156463    /usr/lib/i386-linux-
gnu/libsasl2.so.2.0.25
04720000-04721000 rw-p 00000000 00:00 0 
04721000-047ec000 r-xp 00000000 08:07 2911328    /usr/lib/i386-linux-
gnu/libkrb5.so.3.3
047ec000-047f2000 r--p 000ca000 08:07 2911328    /usr/lib/i386-linux-
gnu/libkrb5.so.3.3
047f2000-047f3000 rw-p 000d0000 08:07 2911328    /usr/lib/i386-linux-
gnu/libkrb5.so.3.3
047f3000-04819000 r-xp 00000000 08:07 2910891    /usr/lib/i386-linux-
gnu/libk5crypto.so.3.1
04819000-0481a000 ---p 00026000 08:07 2910891    /usr/lib/i386-linux-
gnu/libk5crypto.so.3.1
0481a000-0481b000 r--p 00026000 08:07 2910891    /usr/lib/i386-linux-
gnu/libk5crypto.so.3.1
0481b000-0481c000 rw-p 00027000 08:07 2910891    /usr/lib/i386-linux-
gnu/libk5crypto.so.3.1
0481c000-0481d000 rw-p 00000000 00:00 0 
0481d000-04820000 r-xp 00000000 08:07 2567273    /lib/i386-linux-
gnu/libcom_err.so.2.1
04820000-04821000 rw-p 00002000 08:07 2567273    /lib/i386-linux-
gnu/libcom_err.so.2.1
04821000-04828000 r-xp 00000000 08:07 2911350    /usr/lib/i386-linux-
gnu/libkrb5support.so.0.1
04828000-04829000 r--p 00006000 08:07 2911350    /usr/lib/i386-linux-
gnu/libkrb5support.so.0.1
04829000-0482a000 rw-p 00007000 08:07 2911350    /usr/lib/i386-linux-
gnu/libkrb5support.so.0.1
0482a000-0482c000 r-xp 00000000 08:07 3238112    /lib/i386-linux-
gnu/i686/cmov/libdl-2.13.so
0482c000-0482d000 r--p 00001000 08:07 3238112    /lib/i386-linux-
gnu/i686/cmov/libdl-2.13.so
0482d000-0482e000 rw-p 00002000 08:07 3238112    /lib/i386-linux-
gnu/i686/cmov/libdl-2.13.so
0482e000-0482f000 rw-p 00000000 00:00 0 
0482f000-04832000 r-xp 00000000 08:07 3237951    /lib/i386-linux-
gnu/libkeyutils.so.1.4
04832000-04833000 rw-p 00002000 08:07 3237951    /lib/i386-linux-
gnu/libkeyutils.so.1.4
04833000-04843000 r-xp 00000000 08:07 2910868    /usr/lib/i386-linux-
gnu/libtasn1.so.3.1.13
04843000-04844000 rw-p 0000f000 08:07 2910868    /usr/lib/i386-linux-
gnu/libtasn1.so.3.1.13
04844000-04854000 r-xp 00000000 08:07 3162369    /usr/lib/i386-linux-
gnu/libp11-kit.so.0.0.0
04854000-04855000 rw-p 00010000 08:07 3162369    /usr/lib/i386-linux-
gnu/libp11-kit.so.0.0.0
04855000-04858000 r-xp 00000000 08:07 3238542    /lib/i386-linux-gnu/libgpg-
error.so.0.8.0
04858000-04859000 rw-p 00002000 08:07 3238542    /lib/i386-linux-gnu/libgpg-
error.so.0.8.0
04859000-0485c000 rw-p 00000000 00:00 0 
0485c000-04c5c000 rwxp 00000000 00:00 0 
04c5c000-04c5d000 ---p 00000000 00:00 0 
04c5d000-0545d000 rw-p 00000000 00:00 0 
0545d000-0545e000 ---p 00000000 00:00 0 
0545e000-05c5e000 rw-p 00000000 00:00 0 
05c5e000-05c5f000 ---p 00000000 00:00 0 
05c5f000-0645f000 rw-p 00000000 00:00 0 
06488000-064a4000 r-xp 00000000 08:07 3239073    /lib/i386-linux-
gnu/libgcc_s.so.1
064a4000-064a5000 rw-p 0001b000 08:07 3239073    /lib/i386-linux-
gnu/libgcc_s.so.1
08048000-0805d000 r-xp 00000000 08:07 3124582    /usr/local/bin/vzlogger
0805d000-0805e000 rw-p 00014000 08:07 3124582    /usr/local/bin/vzlogger
0805e000-0805f000 rwxp 00000000 00:00 0 
38000000-38218000 r-xp 00001000 08:07 654346     /usr/lib/valgrind/memcheck-
x86-linux
38218000-3821a000 rw-p 00218000 08:07 654346     /usr/lib/valgrind/memcheck-
x86-linux
3821a000-38de6000 rw-p 00000000 00:00 0 
61c13000-625bb000 rwxp 00000000 00:00 0 
625bb000-625bd000 ---p 00000000 00:00 0 
625bd000-626bd000 rwxp 00000000 00:00 0 
626bd000-626bf000 ---p 00000000 00:00 0 
626bf000-64d43000 rwxp 00000000 00:00 0 
64d43000-64d45000 ---p 00000000 00:00 0 
64d45000-64e45000 rwxp 00000000 00:00 0 
64e45000-64e47000 ---p 00000000 00:00 0 
64e47000-64e4b000 rwxp 00000000 00:00 0 
64e4b000-64e4d000 ---p 00000000 00:00 0 
64e4d000-64f4d000 rwxp 00000000 00:00 0 
64f4d000-64f4f000 ---p 00000000 00:00 0 
64f4f000-64f53000 rwxp 00000000 00:00 0 
64f53000-64f55000 ---p 00000000 00:00 0 
64f55000-65055000 rwxp 00000000 00:00 0 
65055000-65057000 ---p 00000000 00:00 0 
65057000-651d3000 rwxp 00000000 00:00 0 
be821000-be824000 rwxp 00000000 00:00 0 
bf804000-bf825000 rw-p 00000000 00:00 0          [stack]==8205== 
==8205== HEAP SUMMARY:
==8205==     in use at exit: 124,595 bytes in 3,017 blocks
==8205==   total heap usage: 20,561 allocs, 17,544 frees, 1,016,955 bytes 
allocated
==8205== 
==8205== LEAK SUMMARY:
==8205==    definitely lost: 0 bytes in 0 blocks
==8205==    indirectly lost: 0 bytes in 0 blocks
==8205==      possibly lost: 77,078 bytes in 90 blocks
==8205==    still reachable: 47,517 bytes in 2,927 blocks
==8205==         suppressed: 0 bytes in 0 blocks
==8205== Rerun with --leak-check=full to see details of leaked memory
==8205== 
==8205== For counts of detected and suppressed errors, rerun with: -v
==8205== Use --track-origins=yes to see where uninitialised values come from
==8205== ERROR SUMMARY: 328 errors from 3 contexts (suppressed: 79 from 10)
Getötet
---< snap

Gruß Willi

More information about the volkszaehler-dev mailing list