Unexpected "Exiting normally" 2.1.8?

Craig Campbell craig at ccraft.ca
Thu Nov 26 20:34:54 CET 2009 

Ok, here is (I think) the debug you wanted.

-craig

[root at radius-a ~]# gdb radiusd
GNU gdb Fedora (6.8-27.el5)
Copyright (C) 2008 Free Software Foundation, Inc.
License GPLv3+: GNU GPL version 3 or later 
<http://gnu.org/licenses/gpl.html>
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law.  Type "show copying"
and "show warranty" for details.
This GDB was configured as "x86_64-redhat-linux-gnu"...
(gdb) break fr_event_loop
Function "fr_event_loop" not defined.
Make breakpoint pending on future shared library load? (y or [n]) y
Breakpoint 1 (fr_event_loop) pending.
(gdb) run -f
Starting program: /usr/local/sbin/radiusd -f
[Thread debugging using libthread_db enabled]
[New Thread 0x2b5c60c5ee10 (LWP 23494)]
[New Thread 0x4253c940 (LWP 23502)]
[New Thread 0x42f3d940 (LWP 23503)]
[New Thread 0x4393e940 (LWP 23504)]
[New Thread 0x4433f940 (LWP 23505)]
[New Thread 0x44d40940 (LWP 23506)]

Breakpoint 1, fr_event_loop (el=0x1d94e7f0) at event.c:321
321             el->exit = 0;
(gdb) watch el->exit
Hardware watchpoint 2: el->exit
(gdb) del 1
(gdb) cont
Continuing.

Watchpoint 2 deleted because the program has left the block in
which its expression is valid.
[Switching to Thread 0x4433f940 (LWP 23505)]
0x0000003acf499845 in fork () from /lib64/libc.so.6
(gdb) bt
#0  0x0000003acf499845 in fork () from /lib64/libc.so.6
#1  0x000000000041104c in radius_exec_program (cmd=0x1d988a60 
"/usr/local/sbin/acctstop.sh", request=0x1d9732f0, exec_wait=0,
    user_msg=0x0, msg_len=254, input_pairs=0x1d985fe0, output_pairs=0x0, 
shell_escape=1) at exec.c:274
#2  0x00002b5c60e6cf58 in exec_xlat (instance=0x1d8e90b0, 
request=0x1d9732f0, fmt=0x1d988a60 "/usr/local/sbin/acctstop.sh",
    out=0x4433df60 "", outlen=254, func=0x42bd95 <xlat_copy>) at 
rlm_exec.c:138
#3  0x000000000042bbd0 in decode_attribute (from=0x4433def0, to=0x4433dee8, 
freespace=254, open_p=0x4433de7c, request=0x1d9732f0,
    func=0x42bd95 <xlat_copy>) at xlat.c:911
#4  0x000000000042c0a1 in radius_xlat (out=0x4433df60 "", outlen=254, 
fmt=0x1d988818 "%{exec:/usr/local/sbin/acctstop.sh}",
    request=0x1d9732f0, func=0x42bd95 <xlat_copy>) at xlat.c:1086
#5  0x0000000000429613 in pairxlatmove (req=0x1d9732f0, to=0x1d9734a8, 
from=0x4433e238) at valuepair.c:587
#6  0x00002b5c632b993f in file_common (inst=0x1d90bb20, request=0x1d9732f0, 
filename=0x2b5c632b9e8e "acct_users", ht=0x1d90bdb0,
    request_pairs=0x1d985fe0, reply_pairs=0x1d9734a8) at rlm_files.c:472
#7  0x00002b5c632b9a66 in file_preacct (instance=0x1d90bb20, 
request=0x1d9732f0) at rlm_files.c:525
#8  0x0000000000420443 in call_modsingle (component=2, sp=0x1d94c8d0, 
request=0x1d9732f0) at modcall.c:297
#9  0x000000000042126b in modcall (component=2, c=0x1d94bcf0, 
request=0x1d9732f0) at modcall.c:669
#10 0x000000000041ea4f in indexed_modcall (comp=2, idx=0, 
request=0x1d9732f0) at modules.c:691
#11 0x000000000041fdb6 in module_preacct (request=0x1d9732f0) at 
modules.c:1470
#12 0x000000000040813c in rad_accounting (request=0x1d9732f0) at acct.c:57
#13 0x00000000004356b5 in radius_handle_request (request=0x1d9732f0, 
fun=0x408108 <rad_accounting>) at event.c:4086
#14 0x0000000000426bd6 in request_handler_thread (arg=0x1d966a50) at 
threads.c:492
#15 0x0000003ad0006367 in start_thread () from /lib64/libpthread.so.0
#16 0x0000003acf4d30ad in clone () from /lib64/libc.so.6
(gdb) thread apply all bt full

Thread 6 (Thread 0x44d40940 (LWP 23506)):
#0  0x0000003acf4dee6e in __lll_lock_wait_private () from /lib64/libc.so.6
No symbol table info available.
#1  0x0000003acf476668 in _L_lock_12629 () from /lib64/libc.so.6
No symbol table info available.
#2  0x0000003acf47477f in malloc_atfork () from /lib64/libc.so.6
No symbol table info available.
#3  0x00002b5c60823dab in pairalloc (da=0x1d8d4df8) at valuepair.c:72
        name_len = 0
        vp = (VALUE_PAIR *) 0x44d3df90
#4  0x00002b5c60826302 in pairmake (attribute=0x2b5c640d42df 
"Acct-Unique-Session-Id", value=0x44d3e280 "2d5f2bbb0937b3b9",
    operator=0) at valuepair.c:1462
        da = (DICT_ATTR *) 0x1d8d4df8
        vp = (VALUE_PAIR *) 0x0
        tc = 0x0
        ts = 0x0
        tag = 0 '\0'
        found_tag = 0
        buffer = "\200âÓD\000\000\000\000pâÓD", '\0' <repeats 51 times>
        attrname = 0x2b5c640d42df "Acct-Unique-Session-Id"
#5  0x00002b5c640d40ad in add_unique_id (instance=0x1d94aec0, 
request=0x1d972e90) at rlm_acct_unique.c:241
        buffer = "2d5f2bbb0937b3b9\0009365,Client-IP-Address = 
192.168.1.101,NAS-IP-Address = 192.168.1.101,Acct-Session-Id = 
\"0360078311\",User-Name = \"jpoduber at comfort\"", '\0' <repeats 1988 times>, 
"\030\a\aa\\+\000\000\000\000\000\000\000\000\000\000øE\230\035\000\000\000\000x\210\224\035\000\000\000\000\001\000\000\000ì\003\000\000\000\000"...
        md5_buf = "-_+»\t7³¹ÓôÏ\001bà>!"
        vp = (VALUE_PAIR *) 0x1d9845c0
        p = 0x44d3e315 ""
        length = 30
        left = 3947
        inst = (rlm_acct_unique_t *) 0x1d94aec0
        cur = (rlm_acct_unique_list_t *) 0x0
#6  0x0000000000420443 in call_modsingle (component=2, sp=0x1d94c7b0, 
request=0x1d972e90) at modcall.c:297
        myresult = 0
#7  0x000000000042126b in modcall (component=2, c=0x1d94bcf0, 
request=0x1d972e90) at modcall.c:669
        myresult = 2
        stack = {pointer = 1, priority = {0, 2, 0, 1619038256, 11100, 
1154742640, 0, 1619037392, 11100, 1619051949, 11100, 0, 0,
    -822046142, 58, 0, 0, 0, 0, 5, 5, -814409280, 0, 494780720, 0, 
1154742704, 0, 0, 0, -814409184, 0, 1154742704}, result = {7,
    2, 0, 1154742544, 0, 1619086899, 11100, 1154742712, 0, 494819072, 0, 
1154742704, 0, 1619068620, -1966049091, 494819072, 0,
    494773456, 0, 494819072, 0, 1154742704, 0, 1154742608, 0, 1619088694, 
11100, 1154742640, 0, 494819072, 0, 1154742704},
  children = {0x1d94bcf0, 0x1d94c7b0, 0x8ad078bd00000b51, 0x44d3f990, 
0x2b5c608155e5, 0x44d3f9a0, 0x1d7dc130, 0x44d3f9b0,
    0x1d7da4d0, 0x44d3fa00, 0x1d7e5700, 0x44d3f9d0, 0xfe, 0x1d7dc138, 
0x1d985c78, 0x10000002d, 0x1d985c7f, 0x1d7dc13f, 0xf7,
    0x44d3fa60, 0x2b5c6081e050, 0xa00000, 0x2b5c60823dd9, 0x100000000, 
0x1d985c40, 0x1d972e80, 0x4, 0x2d00000000, 0x1d8e6180,
    0x0, 0x1d972d00, 0x1d985c40}, start = {0x2d00000005, 0x1d94bc60, 
0x1d7dc130, 0x1d7dbf58, 0x139e0ca400000000, 0x14,
    0x1d972d90, 0x1d972da4, 0x1d972da4, 0x44d3fac0, 0x2b5c6082009a, 0x14, 
0x1d972d90, 0x0, 0x139e0ca4, 0x1d972da6, 0x1d985c40,
    0x44d3fc30, 0x2b5c6081f143, 0x44d3fb70, 0x2b5c6081cce1, 0x1d8e6180, 
0x404f5f, 0x11d8e6180, 0x100000001, 0x1, 0x1d8e6180, 0x0,
    0x1d972d00, 0x0, 0x0, 0x0}}
        parent = (modcallable *) 0x1d94bcf0
---Type <return> to continue, or q <return> to quit---
        child = (modcallable *) 0x1d94c7b0
        sp = (modsingle *) 0x1d94c7b0
        if_taken = 0
        was_if = 0
#8  0x000000000041ea4f in indexed_modcall (comp=2, idx=0, 
request=0x1d972e90) at modules.c:691
        rcode = 0
        list = (modcallable *) 0x1d94bcf0
        server = (virtual_server_t *) 0x1d94a550
#9  0x000000000041fdb6 in module_preacct (request=0x1d972e90) at 
modules.c:1470
No locals.
#10 0x000000000040813c in rad_accounting (request=0x1d972e90) at acct.c:57
        vp = (VALUE_PAIR *) 0x1d972e90
        acct_type = 0
        result = 2
#11 0x00000000004356b5 in radius_handle_request (request=0x1d972e90, 
fun=0x408108 <rad_accounting>) at event.c:4086
No locals.
#12 0x0000000000426bd6 in request_handler_thread (arg=0x1d966bd0) at 
threads.c:492
        fun = (RAD_REQUEST_FUNP) 0x408108 <rad_accounting>
        self = (THREAD_HANDLE *) 0x1d966bd0
#13 0x0000003ad0006367 in start_thread () from /lib64/libpthread.so.0
No symbol table info available.
#14 0x0000003acf4d30ad in clone () from /lib64/libc.so.6
No symbol table info available.

Thread 5 (Thread 0x4433f940 (LWP 23505)):
#0  0x0000003acf499845 in fork () from /lib64/libc.so.6
No symbol table info available.
#1  0x000000000041104c in radius_exec_program (cmd=0x1d988a60 
"/usr/local/sbin/acctstop.sh", request=0x1d9732f0, exec_wait=0,
    user_msg=0x0, msg_len=254, input_pairs=0x1d985fe0, output_pairs=0x0, 
shell_escape=1) at exec.c:274
        vp = (VALUE_PAIR *) 0x0
        mycmd = "/usr/local/sbin/acctstop.sh", '\0' <repeats 45 times>, 
"À\031uÏ:\000\000\000\b\032uÏ:\000\000\000\b\032uÏ:", '\0' <repeats 11 
times>, " \032uÏ:", '\0' <repeats 11 times>, "\214ÄJÏ:", '\0' <repeats 11 
times>, 
"àØ3D\000\000\000\000\220\212\230\035\000\000\000\000°\207\230\035\000\000\000\000È\003\000\000\000\000\000\000 
\032\000\000\003\000\000\000`§3D\000\000\000\000x§3D\000\000\000\000\220§3D\000\000\000\000À·3D\000\000\000\000À§3D\000\000\000\000P\224\230\035\000\000\000\000\230\212\230\035\000\000\000\000\004\000\000\000\000\000"...
        from = 0x1d988a7b ""
        p = 0x44338b26 "=\"b59b7e5cef8e3cf2\""
        to = 0x4433af30 ""
        pd = {0, 0}
        pid = 0
        child_pid = 0
        argc = 1
        comma = 0
        status = 0
        i = 1
        n = 23
        left = 4096
        done = 0
---Type <return> to continue, or q <return> to quit---
        argv = {0x4433d750 "/usr/local/sbin/acctstop.sh", 0x0, 0x100000138 
<Address 0x100000138 out of bounds>, 0x0,
  0x1d94c3f0 "¸\202\200`\\+", 0x4433d080 "h³\200`\\+", 0x1d94c090 "", 
0x2b5c640d34b8 "pairadd", 0x4433d030 "",
  0x28608131b8 <Address 0x28608131b8 out of bounds>, 0x1d8d4df8 "\033\004", 
0x2b5c640d42df "Acct-Unique-Session-Id",
  0x6465636e61766461 <Address 0x6465636e61766461 out of bounds>, 0x0,
  0x696e552d74636341 <Address 0x696e552d74636341 out of bounds>, 
0x3acf7519c0 "\001", 0x138 <Address 0x138 out of bounds>,
  0xa00000 <Address 0xa00000 out of bounds>, 0x4433f940 "@ù3D", 0x1d9885a8 
"", 0x0, 0x4433d290 "",
  0x7e <Address 0x7e out of bounds>, 0x10 <Address 0x10 out of bounds>, 
0xa00000 <Address 0xa00000 out of bounds>,
  0x32002b5c60823dd9 <Address 0x32002b5c60823dd9 out of bounds>, 
0x2b5c6080b368 "n\b", 0x2b5c60808cd0 "",
  0x30 <Address 0x30 out of bounds>, 0xffffffff <Address 0xffffffff out of 
bounds>, 0x0,
  0x2016f0 <Address 0x2016f0 out of bounds>, 0xa00000 <Address 0xa00000 out 
of bounds>, 0x4433f940 "@ù3D", 0x44340000 "",
  0x1000 <Address 0x1000 out of bounds>, 0x2b5c640d3000 
"\177ELF\002\001\001", 0x3acf00cd35 "I\211Àd\213\004%\030",
  0x5 <Address 0x5 out of bounds>, 0x0, 0x4433d280 "b59b7e5cef8e3cf2", 
0x4433d270 "µ\233~\\ï\216<ò_/qÞ¹/ähb59b7e5cef8e3cf2",
  0x2b5c6080b368 "n\b", 0x7e <Address 0x7e out of bounds>, 0x4433e2c0 
"\020ã3D",
  0x3acf0128b2 "I\211ÃL\213L$0L\213D$(H\213|$ 
H\213t$\030H\213T$\020H\213L$\bH\213\004$H\203ÄHAÿãf\220H\203ìPH\211\004$H\211T$\bL\211D$\020L\211L$\030H\211L$ 
H\211t$(H\211|$0H\211l$8H\215D$`H\211D$@H\215L$\bH\213T$`H\213t$XI\211óL\001ÞL\001ÞHÁæ\003H\213|$PL\215D$HèÀ\235ÿÿI\211ÃH\213T$\bL\213D$\020L\213L$\030H\213\004$L\213T$HM\205Òy\026H\213L$ 
H\213t$(H\213|$0H\203Ä`AÿãH\211\\$"...,
  0x1d973110 "\016", 0xffffffffffffffee <Address 0xffffffffffffffee out of 
bounds>, 0x1d988560 "\bN\215\035",
  0x1d988560 "\bN\215\035", 0x1d988560 "\bN\215\035", 0x1d973178 
"à_\230\035", 0x600000 <Address 0x600000 out of bounds>,
  0x1d988420 "\bÀ}\035", 0x4433e2c0 "\020ã3D", 0x2b5c640d40fa 
"Ç\205\\îÿÿ\002", 0xef <Address 0xef out of bounds>,
  0x8e <Address 0x8e out of bounds>, 0x3c <Address 0x3c out of bounds>, 0xf2 
<Address 0xf2 out of bounds>, 0x0,
  0x200000000 <Address 0x200000000 out of bounds>, 0x1d9732f0 "ï¾­Þ", 
0x1d94aec0 "@Å\224\035", 0x1d8d4e38 "Client-IP-Address",
  0x41c <Address 0x41c out of bounds>, 0x2 <Address 0x2 out of bounds>, 0x4 
<Address 0x4 out of bounds>,
  0xb <Address 0xb out of bounds>, 0x0, 0x6501a8c0 <Address 0x6501a8c0 out 
of bounds>, 0x0 <repeats 33 times>,
  0xf23c8eef5c7e9bb5 <Address 0xf23c8eef5c7e9bb5 out of bounds>, 
0x68e42fb9de712f5f <Address 0x68e42fb9de712f5f out of bounds>,
  0x6335653762393562 <Address 0x6335653762393562 out of bounds>, 
0x3266633365386665 <Address 0x3266633365386665 out of bounds>,
  0x6c432c3536333900 <Address 0x6c432c3536333900 out of bounds>, 
0x2d50492d746e6569 <Address 0x2d50492d746e6569 out of bounds>,
  0x2073736572646441 <Address 0x2073736572646441 out of bounds>, 
0x36312e323931203d <Address 0x36312e323931203d out of bounds>,
  0x2c3130312e312e38 <Address 0x2c3130312e312e38 out of bounds>, 
0x412d50492d53414e <Address 0x412d50492d53414e out of bounds>,
  0x3d20737365726464 <Address 0x3d20737365726464 out of bounds>, 
0x3836312e32393120 <Address 0x3836312e32393120 out of bounds>,
  0x412c3130312e312e <Address 0x412c3130312e312e out of bounds>, 
0x737365532d746363 <Address 0x737365532d746363 out of bounds>,
  0x3d2064492d6e6f69 <Address 0x3d2064492d6e6f69 out of bounds>, 
0x3334393533302220 <Address 0x3334393533302220 out of bounds>,
  0x73552c2235383331 <Address 0x73552c2235383331 out of bounds>, 
0x20656d614e2d7265 <Address 0x20656d614e2d7265 out of bounds>,
  0x6f626c617622203d <Address 0x6f626c617622203d out of bounds>, 
0x4064726176656c75 <Address 0x4064726176656c75 out of bounds>,
  0x6465636e61766461 <Address 0x6465636e61766461 out of bounds>, 0x22 
<Address 0x22 out of bounds>, 0x0 <repeats 62 times>,
  0x100000000 <Address 0x100000000 out of bounds>, 0x1d985fe0 " ¾}\035", 
0x1d910ea0 " ¾}\035", 0x1d9732f0 "ï¾­Þ",
  0x0 <repeats 64 times>}
        answer = '\0' <repeats 521 times>, 
"È3D\000\000\000\000¢üQÏ:\000\000\000¢üQÏ:", '\0' <repeats 11 times>, 
"ï4DÏ:\000\000\000ÀÇ3D", '\0' <repeats 12 times>, "àÂ3D", '\0' <repeats 28 
times>, "0É3D\000\000\000\000\227üQÏ:\000\000\000\020È3D", '\0' <repeats 36 
times>, "ÿÿÿÿÿÿÿÿ¡üQÏ:\000\000\000\227üQÏ:", '\0' <repeats 11 times>, 
"ÈÆ3D\000\000\000\000ÐÖ\202`\003\000\000\000\n", '\0' <repeats 11 times>, 
"\n", '\0' <repeats 43 times>, " ", '\0' <repeats 15 times>, " 
Ê3D\000\000\000\000ÎÖ\202u\\+"...
        argv_buf = '\0' <repeats 2200 times>, "\001", '\0' <repeats 35 
times>, "@", '\0' <repeats 19 times>, "þÿÿÿÿÿÿÿþÿÿÿ¿", 'ÿ' <repeats 19 
times>, '\0' <repeats 1807 times>
        envp = {0x1d989ba0 "ACCT_STATUS_TYPE=Stop", 0x1d988a90 
"USER_NAME=\"valboulevard at advanced\"",
  0x1d988ac0 "EVENT_TIMESTAMP=\"Nov 26 2009 15:25:20 AST\"", 0x1d9687f0 
"ACCT_DELAY_TIME=30",
  0x1d988c50 "NAS_IDENTIFIER=\"ERX-2\"", 0x1d988b00 
"ACCT_SESSION_ID=\"0359431385\"", 0x1d988b30 "NAS_IP_ADDRESS=192.168.1.101",
  0x1d988b60 "SERVICE_TYPE=Framed-User", 0x1d989b20 "FRAMED_PROTOCOL=PPP", 
0x1d989b40 "FRAMED_COMPRESSION=None",
  0x1d988b90 "ERX_PPPOE_DESCRIPTION=\"pppoe 00:90:d0:63:df:6d\"", 0x1d988bd0 
"FRAMED_IP_ADDRESS=199.2.118.232",
  0x1d968810 "FRAMED_IP_NETMASK=255.255.255.255", 0x1d988c00 
"ERX_INGRESS_POLICY_NAME=\"ADVANCED_UP\"",
---Type <return> to continue, or q <return> to quit---
  0x1d968790 "ERX_EGRESS_POLICY_NAME=\"ADVANCED_DOWN\"", 0x1d9687c0 
"CALLING_STATION_ID=\"ERX-09000000261\"",
  0x1d989b60 "ACCT_INPUT_GIGAWORDS=0", 0x1d989ac0 
"ACCT_INPUT_OCTETS=43839839", 0x1d989b80 "ACCT_OUTPUT_GIGAWORDS=0",
  0x1d989af0 "ACCT_OUTPUT_OCTETS=15343206", 0x1d989aa0 
"ERX_INPUT_GIGAPKTS=0", 0x1d988c70 "ACCT_INPUT_PACKETS=71072",
  0x1d973530 "ERX_OUTPUT_GIGAPKTS=0", 0x1d988ca0 
"ACCT_OUTPUT_PACKETS=56798", 0x1d968840 "NAS_PORT_TYPE=Ethernet",
  0x1d988c30 "NAS_PORT=2415919365", 0x1d988cd0 
"NAS_PORT_ID=\"GigabitEthernet 9/0.261:261\"", 0x1d988d10 
"ACCT_AUTHENTIC=RADIUS",
  0x1d988d30 "ACCT_SESSION_TIME=86400", 0x1d988d50 
"ACCT_TERMINATE_CAUSE=Session-Timeout",
  0x1d988d80 "ACCT_UNIQUE_SESSION_ID=\"b59b7e5cef8e3cf2\"", 0x0 <repeats 687 
times>, 0x4433a5f0 "@¦3D", 0x0,
  0x10 <Address 0x10 out of bounds>, 0x0, 0x31 <Address 0x31 out of bounds>, 
0x0, 0x0, 0x3acf7519c0 "\001", 0x3acf751a08 "",
  0x3acf751a08 "", 0x4433a640 "À\031uÏ:", 0x3acf751a20 "°\233\230\035", 0x10 
<Address 0x10 out of bounds>, 0x3acf751a08 "",
  0x4433a660 "À\031uÏ:", 0x3acf751a20 "°\233\230\035", 0x58 <Address 0x58 
out of bounds>, 0x3acf7519c0 "\001", 0x4433d960 " 7@",
  0x3acf751a20 "°\233\230\035", 0x3acf7519c0 "\001", 0x800 <Address 0x800 
out of bounds>, 0x810 <Address 0x810 out of bounds>,
  0x3acf4723fd "éÇûÿÿL\211øHÁè\fH\203ø\n\017\206\016\001", 0x3acf7519c0 
"\001", 0x3acf7519c0 "\001",
  0x4433a6c0 "ø\213\230\035\017", 0x4433d920 "\b5\216\037", 0x800 <Address 
0x800 out of bounds>,
  0x830 <Address 0x830 out of bounds>, 0x1d9887b0 "", 0x3acf47402a 
"H\205ÀI\211ÄtJ\203=¯\016.",
  0x1d988c08 "ESS_POLICY_NAME=\"ADVANCED_UP\"", 0x1d988bf0 "\017", 
0x4433d920 "\b5\216\037",
  0x58cf4a5615 <Address 0x58cf4a5615 out of bounds>, 0xf1d988bf8 <Address 
0xf1d988bf8 out of bounds>, 0x1d988bf0 "\017", 0x0,
  0x4433d920 "\b5\216\037", 0x1d988bf8 "1", 0x3acf7519c0 "\001", 0x4433d960 
" 7@", 0x3 <Address 0x3 out of bounds>,
  0x1 <Address 0x1 out of bounds>, 0x18 <Address 0x18 out of bounds>, 0x0, 
0x3acf47590c "\203=Õõ-",
  0x10 <Address 0x10 out of bounds>, 0x4433d900 "\b5\216\037", 0x4433d960 " 
7@", 0x3 <Address 0x3 out of bounds>,
  0x1 <Address 0x1 out of bounds>, 0x4433a7f8 "", 0x4433d960 " 7@", 
0x3acf4ad136 "D;¥\234þÿÿuç\200½\232þÿÿ",
  0x1d988a90 "USER_NAME=\"valboulevard at advanced\"", 0x1d988bf0 "\017", 
0x1d988b30 "NAS_IP_ADDRESS=192.168.1.101",
  0x1d988a90 "USER_NAME=\"valboulevard at advanced\"", 0x1d988bf0 "\017", 
0x1d988b30 "NAS_IP_ADDRESS=192.168.1.101",
  0x1d988a90 "USER_NAME=\"valboulevard at advanced\"", 0x1d988bf0 "\017", 
0x1d988b30 "NAS_IP_ADDRESS=192.168.1.101",
  0x4433d960 " 7@", 0x4433a7e0 "\001",
  0x3acf4ad5ca "\205À\017\205Q÷ÿÿH\211ßèF\001÷ÿH\205ÀH\211\205 
þÿÿÆ\205\233þÿÿ\001\017\205T÷ÿÿéÝûÿÿH\215\004Í",
  0x200000002 <Address 0x200000002 out of bounds>, 0x1d9899a0 "", 
0x200000002 <Address 0x200000002 out of bounds>, 0x1d988910 "",
  0x100000001 <Address 0x100000001 out of bounds>, 0x1d9687d0 
"ID=\"ERX-09000000261\"", 0x0 <repeats 232 times>}
#2  0x00002b5c60e6cf58 in exec_xlat (instance=0x1d8e90b0, 
request=0x1d9732f0, fmt=0x1d988a60 "/usr/local/sbin/acctstop.sh",
    out=0x4433df60 "", outlen=254, func=0x42bd95 <xlat_copy>) at 
rlm_exec.c:138
        result = 0
        inst = (rlm_exec_t *) 0x1d8e90b0
        input_pairs = (VALUE_PAIR **) 0x1d973178
        p = 0x1d988a60 "/usr/local/sbin/acctstop.sh"
#3  0x000000000042bbd0 in decode_attribute (from=0x4433def0, to=0x4433dee8, 
freespace=254, open_p=0x4433de7c, request=0x1d9732f0,
    func=0x42bd95 <xlat_copy>) at xlat.c:911
        stop = 1
        delimitbrace = 0
        do_length = 0
        xlat_name = 
"exec\000\000\000\000ì\003\000\000ÿÿÿÿ\000\000\000\000\000\000\000\000@\210\224\035\000\000\000\000à_\230\035\000\000\000\000ð2\227\035\000\000\000\000à_\230\035\000\000\000\000\004\000\000\000\000\000\000\000ß2\227\035\006\000\000\000 
h\230\035\000\000\000\000pÞ3D\000\000\000\000eìc\\+", '\0' <repeats 18 
times>, "Ð5@\000\000\000\000\000\000\200\200`\\+\000"
        xlat_string = 0x1d988a60 "/usr/local/sbin/acctstop.sh"
        free_xlat_string = 1
        p = 0x1d98883b ""
        q = 0x4433df60 ""
        pa = 0x1d988a7b ""
        found = 0
        retlen = 0
---Type <return> to continue, or q <return> to quit---
        openbraces = 0
        c = (const xlat_t *) 0x1d8e9960
        spaces = 0
#4  0x000000000042c0a1 in radius_xlat (out=0x4433df60 "", outlen=254, 
fmt=0x1d988818 "%{exec:/usr/local/sbin/acctstop.sh}",
    request=0x1d9732f0, func=0x42bd95 <xlat_copy>) at xlat.c:1086
        c = 37
        len = 496021568
        freespace = 254
        p = 0x1d988819 "{exec:/usr/local/sbin/acctstop.sh}"
        q = 0x4433df60 ""
        nl = 0x0
        tmp = (VALUE_PAIR *) 0x1d90c1c0
        TM = (struct tm *) 0x4433e040
        s_TM = {tm_sec = 0, tm_min = 0, tm_hour = 0, tm_mday = 0, tm_mon = 
5, tm_year = 0, tm_wday = 0, tm_yday = 0,
  tm_isdst = 1, tm_gmtoff = 8589934592, tm_zone = 0x4433df20 "`¾\220\035"}
        tmpdt = 
"\020à3D\000\000\000\000Àß3D\000\000\000\000\001½\036ö\000\000\000\000Øß3D", 
'\0' <repeats 11 times>
        openbraces = 0
#5  0x0000000000429613 in pairxlatmove (req=0x1d9732f0, to=0x1d9734a8, 
from=0x4433e238) at valuepair.c:587
        rcode = 0
        buffer = "\0004\227\035\000\000\000\000 
\016\221\035\000\000\000\000à_\230\035\000\000\000\000ð2\227\035\000\000\000\000\000\000\000\000\006\000\000\000\220\f\221\035(\000\000\000ؽ\220\035\000\000\000\000\006\000\000\000\036\000\000\000àß3D\000\000\000\000­Q\201`\\+\000\000ðß3D\036\000\000\000À\031uÏ:\000\000\000x3@\000\000\000\000\000\000\200\200`\\+\000\000@ù3D\000\000\000\000ÿÿÿÿ\000\000\000\000\000\020\000\000\000\000\000\000ð$ 
\000\000\000\000\000\000\000 
\000\000\000\000\000@ù3D\000\000\000\000\000\0004D\000\000\000\000\000\020\000\000\000\000\000\000\000\200+c\\+\000\0005Í\000Ï:\000\000\000\005", 
'\0' <repeats 15 times>...
        tailto = (VALUE_PAIR **) 0x1d9734a8
        i = (VALUE_PAIR *) 0x1d9887e0
        j = (VALUE_PAIR *) 0x4433e238
        next = (VALUE_PAIR *) 0x1d988920
        tailfrom = (VALUE_PAIR *) 0x0
        found = (VALUE_PAIR *) 0x2
#6  0x00002b5c632b993f in file_common (inst=0x1d90bb20, request=0x1d9732f0, 
filename=0x2b5c632b9e8e "acct_users", ht=0x1d90bdb0,
    request_pairs=0x1d985fe0, reply_pairs=0x1d9734a8) at rlm_files.c:472
        pl = (const PAIR_LIST *) 0x1d90bd70
        name = 0x1d986158 "valboulevard at advanced"
        match = 0x2b5c632b9e5e "DEFAULT"
        config_pairs = (VALUE_PAIR **) 0x1d973318
        check_tmp = (VALUE_PAIR *) 0x1d9886a0
        reply_tmp = (VALUE_PAIR *) 0x1d9887e0
        user_pl = (const PAIR_LIST *) 0x0
        default_pl = (const PAIR_LIST *) 0x0
        found = 1
        my_pl = {name = 0x2b5c632b9e5e "DEFAULT", check = 0x0, reply = 0xe0, 
lineno = 242428, order = 0, next = 0x0,
  lastdefault = 0x4433e120}
        buffer = '\0' <repeats 32 times>, "valboulevard\000advanced", '\0' 
<repeats 202 times>
#7  0x00002b5c632b9a66 in file_preacct (instance=0x1d90bb20, 
request=0x1d9732f0) at rlm_files.c:525
        inst = (struct file_instance *) 0x1d90bb20
#8  0x0000000000420443 in call_modsingle (component=2, sp=0x1d94c8d0, 
request=0x1d9732f0) at modcall.c:297
        myresult = 0
---Type <return> to continue, or q <return> to quit---
#9  0x000000000042126b in modcall (component=2, c=0x1d94bcf0, 
request=0x1d9732f0) at modcall.c:669
        myresult = 7
        stack = {pointer = 1, priority = {0, 2, 0 <repeats 14 times>, 
4, -805247808, 58, 0, 0, 0, 0, 494780912, 0, 1144252848, 0,
    0, 0, 0, 0, 1144252848}, result = {7, 2, 0, 1144252688, 0, 1619086899, 
11100, 1144252856, 0, 494819584, 0, 1144252848, 0,
    1619068620, -1672236017, 494849120, 0, 494773456, 0, 494819584, 0, 
1144252848, 0, 1144252752, 0, 1619088694, 11100,
    1144252784, 0, 494819584, 0, 1144252848}, children = {0x1d94bcf0, 
0x1d94c8d0, 0x9c53b40f00000a39, 0x4433e990, 0x2b5c608155e5,
    0x4433e9a0, 0x1d7dc1f0, 0x4433e9b0, 0x1d7da4d0, 0x4433ea00, 0x1d7e5900, 
0x4433e9d0, 0xfe, 0x1d7dc1f8, 0x1d988458,
    0x500000031, 0x1d988468, 0x1d7dc208, 0xee, 0x4433ea60, 0x2b5c6081e050, 
0xa00000, 0x2b5c60823dd9, 0x100000000, 0x1d988420,
    0x1d9732df, 0x4, 0x3100000000, 0x1d8e6180, 0x0, 0x1d973110, 0x1d988420}, 
start = {0x3100000005, 0x1d94bc60, 0x1d7dc1f0,
    0x1d7dbff8, 0x300ac31e00000000, 0x14, 0x1d9731a0, 0x1d9731b4, 
0x1d9731b4, 0x4433eac0, 0x2b5c6082009a, 0x14, 0x1d9731a0, 0x0,
    0x300ac31e, 0x1d97314c, 0x1d988420, 0x4433ec30, 0x2b5c6081f143, 
0x4433eb70, 0x2b5c6081cce1, 0x1d8e6180, 0x0, 0x11d8e6180,
    0x100000001, 0x1, 0x1d8e6180, 0x0, 0x1d973110, 0x0, 0x0, 0x0}}
        parent = (modcallable *) 0x1d94bcf0
        child = (modcallable *) 0x1d94c8d0
        sp = (modsingle *) 0x1d94c8d0
        if_taken = 0
        was_if = 0
#10 0x000000000041ea4f in indexed_modcall (comp=2, idx=0, 
request=0x1d9732f0) at modules.c:691
        rcode = 0
        list = (modcallable *) 0x1d94bcf0
        server = (virtual_server_t *) 0x1d94a550
#11 0x000000000041fdb6 in module_preacct (request=0x1d9732f0) at 
modules.c:1470
No locals.
#12 0x000000000040813c in rad_accounting (request=0x1d9732f0) at acct.c:57
        vp = (VALUE_PAIR *) 0x1d9732f0
        acct_type = 0
        result = 2
#13 0x00000000004356b5 in radius_handle_request (request=0x1d9732f0, 
fun=0x408108 <rad_accounting>) at event.c:4086
No locals.
#14 0x0000000000426bd6 in request_handler_thread (arg=0x1d966a50) at 
threads.c:492
        fun = (RAD_REQUEST_FUNP) 0x408108 <rad_accounting>
        self = (THREAD_HANDLE *) 0x1d966a50
#15 0x0000003ad0006367 in start_thread () from /lib64/libpthread.so.0
No symbol table info available.
#16 0x0000003acf4d30ad in clone () from /lib64/libc.so.6
No symbol table info available.

Thread 4 (Thread 0x4393e940 (LWP 23504)):
#0  0x0000003acf4dee6e in __lll_lock_wait_private () from /lib64/libc.so.6
No symbol table info available.
#1  0x0000003acf476668 in _L_lock_12629 () from /lib64/libc.so.6
No symbol table info available.
#2  0x0000003acf47477f in malloc_atfork () from /lib64/libc.so.6
No symbol table info available.
#3  0x0000003ad2cdab52 in CRYPTO_malloc () from /lib64/libcrypto.so.6
No symbol table info available.
#4  0x0000003ad2c7fdbc in ?? () from /lib64/libcrypto.so.6
No symbol table info available.
---Type <return> to continue, or q <return> to quit---
#5  0x0000003ad2cd82bd in ERR_clear_error () from /lib64/libcrypto.so.6
No symbol table info available.
#6  0x0000000000426b4f in request_handler_thread (arg=0x1d9668d0) at 
threads.c:474
        fun = (RAD_REQUEST_FUNP) 0
        self = (THREAD_HANDLE *) 0x1d9668d0
#7  0x0000003ad0006367 in start_thread () from /lib64/libpthread.so.0
No symbol table info available.
#8  0x0000003acf4d30ad in clone () from /lib64/libc.so.6
No symbol table info available.

Thread 3 (Thread 0x42f3d940 (LWP 23503)):
#0  0x0000003acf4dee6e in __lll_lock_wait_private () from /lib64/libc.so.6
No symbol table info available.
#1  0x0000003acf476668 in _L_lock_12629 () from /lib64/libc.so.6
No symbol table info available.
#2  0x0000003acf47477f in malloc_atfork () from /lib64/libc.so.6
No symbol table info available.
#3  0x0000003ad2cdab52 in CRYPTO_malloc () from /lib64/libcrypto.so.6
No symbol table info available.
#4  0x0000003ad2c7fdbc in ?? () from /lib64/libcrypto.so.6
No symbol table info available.
#5  0x0000003ad2cd82bd in ERR_clear_error () from /lib64/libcrypto.so.6
No symbol table info available.
#6  0x0000000000426b4f in request_handler_thread (arg=0x1d966750) at 
threads.c:474
        fun = (RAD_REQUEST_FUNP) 0



----- Original Message ----- 
From: "Alan DeKok" <aland at deployingradius.com>
To: "FreeRadius users mailing list" <freeradius-users at lists.freeradius.org>
Sent: Thursday, November 26, 2009 2:19 PM
Subject: Re: Unexpected "Exiting normally" 2.1.8?


> Bjørn Mork wrote:
>> However, I think I found one other possibility.  This code in
>> fr_event_loop() will exit if the select() fails:
>>
>>                 rcode = select(el->maxfd + 1, &read_fds, NULL, NULL, 
>> wake);
>>                 if ((rcode < 0) && (errno != EINTR)) {
>>                         el->dispatch = 0;
>>                         return 0;
>>                 }
>>
>>
>> Might this happen due to a dead home server fd in the &read_fds?
>
>  It shouldn't.  The only fail in select() is that one of the file
> descriptors has been closed, without updating the read_fds array.  And
> that shouldn't happen, either.
>
>  What error is select() returning?
>
>  Alan DeKok.
> -
> List info/subscribe/unsubscribe? See 
> http://www.freeradius.org/list/users.html 


__________ Information from ESET Smart Security, version of virus signature database 4640 (20091126) __________

The message was checked by ESET Smart Security.

http://www.eset.com

More information about the Freeradius-Users mailing list