Зарегистрирован: 31 янв 2014 11:59 Сообщения: 54
|
Код: mysql> select radacctid, acctstarttime, acctstoptime, acctsessiontime from radius.radacct order by radacctid desc limit 5; +-----------+---------------------+---------------------+-----------------+ | radacctid | acctstarttime | acctstoptime | acctsessiontime | +-----------+---------------------+---------------------+-----------------+ | 28 | 2014-06-23 15:41:51 | 2014-06-23 15:42:03 | 12 | | 27 | 2014-06-23 15:41:51 | 2014-06-23 15:42:03 | 12 | | 26 | 2014-06-23 15:18:09 | 2014-06-23 15:18:17 | 6 | | 25 | 2014-06-23 15:18:09 | 2014-06-23 15:18:17 | 6 | | 24 | 2014-06-23 14:42:46 | 2014-06-23 14:42:50 | 3 | +-----------+---------------------+---------------------+-----------------+
Тут дебаг Listening on authentication address * port 1812 Listening on accounting address * port 1813 Listening on command file /var/run/radiusd/radiusd.sock Ready to process requests. rad_recv: Accounting-Request packet from host 127.0.0.1 port 44052, id=200, length=243 Acct-Status-Type = Start Acct-Session-Id = "5dd65372-facb-11e3-9a54-d756c0572d8c" User-Name = "1000" Freeswitch-Src = "1000" Freeswitch-CLID = "1000" Freeswitch-Dst = "набранный_номер" Freeswitch-Dialplan = "XML" Framed-IP-Address = мой_ип Freeswitch-Context = "outgoing" Freeswitch-Ani = "1000" Freeswitch-Source = "mod_sofia" Freeswitch-Callstartdate = "2014-06-23T15:41:51.086808+0400" NAS-Port = 0 Acct-Delay-Time = 0 NAS-IP-Address = 127.0.0.1 # Executing section preacct from file /etc/raddb/sites-enabled/default +- entering group preacct {...} ++[preprocess] returns ok [acct_unique] Hashing 'NAS-Port = 0,Client-IP-Address = 127.0.0.1,NAS-IP-Address = 127.0.0.1,Acct-Session-Id = "5dd65372-facb-11e3-9a54-d756c0572d8c",User-Name = "1000"' [acct_unique] Acct-Unique-Session-ID = "fb59b0598f60f96c". ++[acct_unique] returns ok [suffix] No '@' in User-Name = "1000", looking up realm NULL [suffix] No such realm "NULL" ++[suffix] returns noop ++[files] returns noop # Executing section accounting from file /etc/raddb/sites-enabled/default +- entering group accounting {...} [detail] expand: %{Packet-Src-IP-Address} -> 127.0.0.1 [detail] expand: /var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d -> /var/log/radius/radacct/127.0.0.1/detail-20140623 [detail] /var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d expands to /var/log/radius/radacct/127.0.0.1/detail-20140623 [detail] expand: %t -> Mon Jun 23 15:41:51 2014 ++[detail] returns ok ++[unix] returns ok [radutmp] expand: /var/log/radius/radutmp -> /var/log/radius/radutmp [radutmp] expand: %{User-Name} -> 1000 ++[radutmp] returns ok [sql] expand: %{User-Name} -> 1000 [sql] sql_set_user escaped user --> '1000' [sql] expand: %{Acct-Delay-Time} -> 0 [sql] expand: INSERT INTO radacct (acctsessionid, acctuniqueid, username, realm, nasipaddress, nasportid, nasporttype, acctstarttime, acctstoptime, acctsessiontime, acctauthentic, connectinfo_start, connectinfo_stop, acctinputoctets, acctoutputoctets, calledstationid, callingstationid, acctterminatecause, servicetype, framedprotocol, framedipaddress, acctstartdelay, acctstopdelay, xascendsessionsvrkey) VALUES ('%{Acct-Session-Id}', '%{Acct-Unique-Session-Id}', '%{SQL-User-Name}', '%{Realm}', '%{NAS-IP-Address}', '%{NAS-Port}', '%{NAS-Port-Type}', '%S', NULL, '0', '%{Acct-Authentic}', '%{Connect-Info}', '', '0', '0', '%{Called-Station-Id}', '%{Calling-Station-Id}', '', '%{Service-Type}', '%{Framed-Protocol}', '%{Framed-IP-Address}', [sql] expand: /var/log/radius/sqltrace.sql -> /var/log/radius/sqltrace.sql rlm_sql (sql): Reserving sql socket id: 14 rlm_sql_mysql: query: INSERT INTO radacct (acctsessionid, acctuniqueid, username, realm, nasipaddress, nasportid, nasporttype, acctstarttime, acctstoptime, acctsessiontime, acctauthentic, connectinfo_start, connectinfo_stop, acctinputoctets, acctoutputoctets, calledstationid, callingstationid, acctterminatecause, servicetype, framedprotocol, framedipaddress, acctstartdelay, acctstopdelay, xascendsessionsvrkey) VALUES ('5dd65372-facb-11e3-9a54-d756c0572d8c', 'fb59b0598f60f96c', '1000', '', '127.0.0.1', '0', '', '2014-06-23 15:41:51', NULL, '0', '', '', '', '0', '0', '', '', '', '', '', 'мой_ип', '0', '0', '') rlm_sql (sql): Released sql socket id: 14 ++[sql] returns ok ++[exec] returns noop [attr_filter.accounting_response] expand: %{User-Name} -> 1000 attr_filter: Matched entry DEFAULT at line 12 ++[attr_filter.accounting_response] returns updated Sending Accounting-Response of id 200 to 127.0.0.1 port 44052 Finished request 0. Cleaning up request 0 ID 200 with timestamp +178 Going to the next request Ready to process requests. rad_recv: Accounting-Request packet from host 127.0.0.1 port 46014, id=200, length=289 Acct-Status-Type = Start Acct-Session-Id = "5dd8e592-facb-11e3-9a5b-d756c0572d8c" Freeswitch-Attr-25 = 0x35646436353337322d666163622d313165332d396135342d643735366330353732643863 User-Name = "1000" Freeswitch-Src = "моя_учетка_у_провайдера" Freeswitch-CLID = "1000" Freeswitch-Dst = "набранный_номер" Freeswitch-Dialplan = "XML" Framed-IP-Address = мой_ип Freeswitch-Context = "outgoing" Freeswitch-Ani = "1000" Freeswitch-Source = "mod_sofia" Freeswitch-Callstartdate = "2014-06-23T15:41:51.086808+0400" NAS-Port = 0 Acct-Delay-Time = 0 NAS-IP-Address = 127.0.0.1 # Executing section preacct from file /etc/raddb/sites-enabled/default +- entering group preacct {...} ++[preprocess] returns ok [acct_unique] Hashing 'NAS-Port = 0,Client-IP-Address = 127.0.0.1,NAS-IP-Address = 127.0.0.1,Acct-Session-Id = "5dd8e592-facb-11e3-9a5b-d756c0572d8c",User-Name = "1000"' [acct_unique] Acct-Unique-Session-ID = "745dd80c98a707e2". ++[acct_unique] returns ok [suffix] No '@' in User-Name = "1000", looking up realm NULL [suffix] No such realm "NULL" ++[suffix] returns noop ++[files] returns noop # Executing section accounting from file /etc/raddb/sites-enabled/default +- entering group accounting {...} [detail] expand: %{Packet-Src-IP-Address} -> 127.0.0.1 [detail] expand: /var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d -> /var/log/radius/radacct/127.0.0.1/detail-20140623 [detail] /var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d expands to /var/log/radius/radacct/127.0.0.1/detail-20140623 [detail] expand: %t -> Mon Jun 23 15:41:51 2014 ++[detail] returns ok ++[unix] returns ok [radutmp] expand: /var/log/radius/radutmp -> /var/log/radius/radutmp [radutmp] expand: %{User-Name} -> 1000 rlm_radutmp: Login entry for NAS fs port 0 duplicate ++[radutmp] returns ok [sql] expand: %{User-Name} -> 1000 [sql] sql_set_user escaped user --> '1000' [sql] expand: %{Acct-Delay-Time} -> 0 [sql] expand: INSERT INTO radacct (acctsessionid, acctuniqueid, username, realm, nasipaddress, nasportid, nasporttype, acctstarttime, acctstoptime, acctsessiontime, acctauthentic, connectinfo_start, connectinfo_stop, acctinputoctets, acctoutputoctets, calledstationid, callingstationid, acctterminatecause, servicetype, framedprotocol, framedipaddress, acctstartdelay, acctstopdelay, xascendsessionsvrkey) VALUES ('%{Acct-Session-Id}', '%{Acct-Unique-Session-Id}', '%{SQL-User-Name}', '%{Realm}', '%{NAS-IP-Address}', '%{NAS-Port}', '%{NAS-Port-Type}', '%S', NULL, '0', '%{Acct-Authentic}', '%{Connect-Info}', '', '0', '0', '%{Called-Station-Id}', '%{Calling-Station-Id}', '', '%{Service-Type}', '%{Framed-Protocol}', '%{Framed-IP-Address}', [sql] expand: /var/log/radius/sqltrace.sql -> /var/log/radius/sqltrace.sql rlm_sql (sql): Reserving sql socket id: 13 rlm_sql_mysql: query: INSERT INTO radacct (acctsessionid, acctuniqueid, username, realm, nasipaddress, nasportid, nasporttype, acctstarttime, acctstoptime, acctsessiontime, acctauthentic, connectinfo_start, connectinfo_stop, acctinputoctets, acctoutputoctets, calledstationid, callingstationid, acctterminatecause, servicetype, framedprotocol, framedipaddress, acctstartdelay, acctstopdelay, xascendsessionsvrkey) VALUES ('5dd8e592-facb-11e3-9a5b-d756c0572d8c', '745dd80c98a707e2', '1000', '', '127.0.0.1', '0', '', '2014-06-23 15:41:51', NULL, '0', '', '', '', '0', '0', '', '', '', '', '', 'мой_ип', '0', '0', '') rlm_sql (sql): Released sql socket id: 13 ++[sql] returns ok ++[exec] returns noop [attr_filter.accounting_response] expand: %{User-Name} -> 1000 attr_filter: Matched entry DEFAULT at line 12 ++[attr_filter.accounting_response] returns updated Sending Accounting-Response of id 200 to 127.0.0.1 port 46014 Finished request 1. Cleaning up request 1 ID 200 with timestamp +178 Going to the next request Ready to process requests. rad_recv: Accounting-Request packet from host 127.0.0.1 port 32912, id=10, length=369 Acct-Status-Type = Stop Acct-Session-Id = "5dd8e592-facb-11e3-9a5b-d756c0572d8c" Freeswitch-Hangupcause = Normal-Clearing User-Name = "1000" Freeswitch-Src = "моя_учетка_у_провайдера" Freeswitch-CLID = "1000" Freeswitch-Dst = "набранный_номер" Freeswitch-Dialplan = "XML" Framed-IP-Address = provider_ip Freeswitch-Context = "outgoing" Freeswitch-Ani = "1000" Freeswitch-Source = "mod_sofia" Freeswitch-Billusec = 12159910 Freeswitch-Callstartdate = "2014-06-23T15:41:51.086808+0400" Freeswitch-Callanswerdate = "2014-06-23T15:41:51.367086+0400" Freeswitch-Callenddate = "2014-06-23T15:42:03.526996+0400" Acct-Session-Time = 12 Freeswitch-Signalbond = "outbound" NAS-Port = 0 Acct-Delay-Time = 0 NAS-IP-Address = 127.0.0.1 # Executing section preacct from file /etc/raddb/sites-enabled/default +- entering group preacct {...} ++[preprocess] returns ok [acct_unique] Hashing 'NAS-Port = 0,Client-IP-Address = 127.0.0.1,NAS-IP-Address = 127.0.0.1,Acct-Session-Id = "5dd8e592-facb-11e3-9a5b-d756c0572d8c",User-Name = "1000"' [acct_unique] Acct-Unique-Session-ID = "745dd80c98a707e2". ++[acct_unique] returns ok [suffix] No '@' in User-Name = "1000", looking up realm NULL [suffix] No such realm "NULL" ++[suffix] returns noop ++[files] returns noop # Executing section accounting from file /etc/raddb/sites-enabled/default +- entering group accounting {...} [detail] expand: %{Packet-Src-IP-Address} -> 127.0.0.1 [detail] expand: /var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d -> /var/log/radius/radacct/127.0.0.1/detail-20140623 [detail] /var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d expands to /var/log/radius/radacct/127.0.0.1/detail-20140623 [detail] expand: %t -> Mon Jun 23 15:42:03 2014 ++[detail] returns ok ++[unix] returns ok [radutmp] expand: /var/log/radius/radutmp -> /var/log/radius/radutmp [radutmp] expand: %{User-Name} -> 1000 ++[radutmp] returns ok [sql] expand: %{User-Name} -> 1000 [sql] sql_set_user escaped user --> '1000' [sql] expand: %{Acct-Input-Gigawords} -> [sql] ... expanding second conditional [sql] expand: %{Acct-Input-Octets} -> [sql] ... expanding second conditional [sql] expand: %{Acct-Output-Gigawords} -> [sql] ... expanding second conditional [sql] expand: %{Acct-Output-Octets} -> [sql] ... expanding second conditional [sql] expand: %{Acct-Delay-Time} -> 0 [sql] expand: UPDATE radacct SET acctstoptime = '%S', acctsessiontime = '%{Acct-Session-Time}', acctinputoctets = '%{%{Acct-Input-Gigawords}:-0}' << 32 | '%{%{Acct-Input-Octets}:-0}', acctoutputoctets = '%{%{Acct-Output-Gigawords}:-0}' << 32 | '%{%{Acct-Output-Octets}:-0}', acctterminatecause = '%{Acct-Terminate-Cause}', acctstopdelay = '%{%{Acct-Delay-Time}:-0}', connectinfo_stop = '%{Connect-Info}' WHERE acctsessionid = '%{Acct-Session-Id}' AND username = '%{SQL-User-Name}' AND nasipaddress = '%{NAS-IP-Address}' -> UPDATE radacct SET acctstoptime = '2014-06-23 15:42:03', acctsessiontime = '12', acctinputoctets = '0' << 32 | '0', acctoutputoctets = '0' << 32 | [sql] expand: /var/log/radius/sqltrace.sql -> /var/log/radius/sqltrace.sql rlm_sql (sql): Reserving sql socket id: 12 rlm_sql_mysql: query: UPDATE radacct SET acctstoptime = '2014-06-23 15:42:03', acctsessiontime = '12', acctinputoctets = '0' << 32 | '0', acctoutputoctets = '0' << 32 | '0', acctterminatecause = '', acctstopdelay = '0', connectinfo_stop = '' WHERE acctsessionid = '5dd8e592-facb-11e3-9a5b-d756c0572d8c' AND username = '1000' AND nasipaddress = '127.0.0.1' rlm_sql (sql): Released sql socket id: 12 ++[sql] returns ok ++[exec] returns noop [attr_filter.accounting_response] expand: %{User-Name} -> 1000 attr_filter: Matched entry DEFAULT at line 12 ++[attr_filter.accounting_response] returns updated Sending Accounting-Response of id 10 to 127.0.0.1 port 32912 Finished request 2. Cleaning up request 2 ID 10 with timestamp +190 Going to the next request Ready to process requests. rad_recv: Accounting-Request packet from host 127.0.0.1 port 49201, id=10, length=380 Acct-Status-Type = Stop Acct-Session-Id = "5dd65372-facb-11e3-9a54-d756c0572d8c" Freeswitch-Hangupcause = Normal-Clearing User-Name = "1000" Freeswitch-Src = "1000" Freeswitch-CLID = "1000" Freeswitch-Dst = "набранный_номер" Freeswitch-Dialplan = "XML" Framed-IP-Address = мой_ип Freeswitch-Context = "outgoing" Freeswitch-Ani = "1000" Freeswitch-Source = "mod_sofia" Freeswitch-Lastapp = "bridge" Freeswitch-Billusec = 12140142 Freeswitch-Callstartdate = "2014-06-23T15:41:51.086808+0400" Freeswitch-Callanswerdate = "2014-06-23T15:41:51.386854+0400" Freeswitch-Callenddate = "2014-06-23T15:42:03.526996+0400" Acct-Session-Time = 12 Freeswitch-Signalbond = "inbound" NAS-Port = 0 Acct-Delay-Time = 0 NAS-IP-Address = 127.0.0.1 # Executing section preacct from file /etc/raddb/sites-enabled/default +- entering group preacct {...} ++[preprocess] returns ok [acct_unique] Hashing 'NAS-Port = 0,Client-IP-Address = 127.0.0.1,NAS-IP-Address = 127.0.0.1,Acct-Session-Id = "5dd65372-facb-11e3-9a54-d756c0572d8c",User-Name = "1000"' [acct_unique] Acct-Unique-Session-ID = "fb59b0598f60f96c". ++[acct_unique] returns ok [suffix] No '@' in User-Name = "1000", looking up realm NULL [suffix] No such realm "NULL" ++[suffix] returns noop ++[files] returns noop # Executing section accounting from file /etc/raddb/sites-enabled/default +- entering group accounting {...} [detail] expand: %{Packet-Src-IP-Address} -> 127.0.0.1 [detail] expand: /var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d -> /var/log/radius/radacct/127.0.0.1/detail-20140623 [detail] /var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d expands to /var/log/radius/radacct/127.0.0.1/detail-20140623 [detail] expand: %t -> Mon Jun 23 15:42:03 2014 ++[detail] returns ok ++[unix] returns ok [radutmp] expand: /var/log/radius/radutmp -> /var/log/radius/radutmp [radutmp] expand: %{User-Name} -> 1000 rlm_radutmp: Logout for NAS fs port 0, but no Login record ++[radutmp] returns ok [sql] expand: %{User-Name} -> 1000 [sql] sql_set_user escaped user --> '1000' [sql] expand: %{Acct-Input-Gigawords} -> [sql] ... expanding second conditional [sql] expand: %{Acct-Input-Octets} -> [sql] ... expanding second conditional [sql] expand: %{Acct-Output-Gigawords} -> [sql] ... expanding second conditional [sql] expand: %{Acct-Output-Octets} -> [sql] ... expanding second conditional [sql] expand: %{Acct-Delay-Time} -> 0 [sql] expand: UPDATE radacct SET acctstoptime = '%S', acctsessiontime = '%{Acct-Session-Time}', acctinputoctets = '%{%{Acct-Input-Gigawords}:-0}' << 32 | '%{%{Acct-Input-Octets}:-0}', acctoutputoctets = '%{%{Acct-Output-Gigawords}:-0}' << 32 | '%{%{Acct-Output-Octets}:-0}', acctterminatecause = '%{Acct-Terminate-Cause}', acctstopdelay = '%{%{Acct-Delay-Time}:-0}', connectinfo_stop = '%{Connect-Info}' WHERE acctsessionid = '%{Acct-Session-Id}' AND username = '%{SQL-User-Name}' AND nasipaddress = '%{NAS-IP-Address}' -> UPDATE radacct SET acctstoptime = '2014-06-23 15:42:03', acctsessiontime = '12', acctinputoctets = '0' << 32 | '0', acctoutputoctets = '0' << 32 | [sql] expand: /var/log/radius/sqltrace.sql -> /var/log/radius/sqltrace.sql rlm_sql (sql): Reserving sql socket id: 11 rlm_sql_mysql: query: UPDATE radacct SET acctstoptime = '2014-06-23 15:42:03', acctsessiontime = '12', acctinputoctets = '0' << 32 | '0', acctoutputoctets = '0' << 32 | '0', acctterminatecause = '', acctstopdelay = '0', connectinfo_stop = '' WHERE acctsessionid = '5dd65372-facb-11e3-9a54-d756c0572d8c' AND username = '1000' AND nasipaddress = '127.0.0.1' rlm_sql (sql): Released sql socket id: 11 ++[sql] returns ok ++[exec] returns noop [attr_filter.accounting_response] expand: %{User-Name} -> 1000 attr_filter: Matched entry DEFAULT at line 12 ++[attr_filter.accounting_response] returns updated Sending Accounting-Response of id 10 to 127.0.0.1 port 49201 Finished request 3. Cleaning up request 3 ID 10 with timestamp +190 Going to the next request
|
|