buffered-sql problem

Jouni Soini soini.jouni at yahoo.com
Thu Jan 26 08:23:56 CET 2017


I was using radmin to log debug to a file and it seems the lines you mentioned is still written to radius.log
if running freeradius -X gives more info I can try that too.
these are the lines in radius.log:

Wed Jan 25 12:04:10 2017 : Debug: Waking up in 0.3 seconds. 
Wed Jan 25 12:04:10 2017 : Debug: Thread 1 got semaphore 
Wed Jan 25 12:04:10 2017 : Debug: Thread 1 handling request 494090, (69384 handled so far) 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
(duplicate lines) 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/radacct/detail-%Y%m%d 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/radacct/detail- 
Wed Jan 25 12:04:10 2017 : Debug: percent --> Y 
Wed Jan 25 12:04:10 2017 : Debug: percent --> m 
Wed Jan 25 12:04:10 2017 : Debug: percent --> d 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: detail (/var/log/freeradius/radacct/detail-*): Polling for detail file 
Wed Jan 25 12:04:10 2017 : Debug: detail (/var/log/freeradius/radacct/detail-*): Renaming /var/log/freeradius/radacct/detail-20170125 -> /var/log/freeradius/radacct/detail.work 
Wed Jan 25 12:04:10 2017 : Debug: detail (/var/log/freeradius/radacct/detail-*): Unlinking /var/log/freeradius/radacct/detail.work 
Wed Jan 25 12:04:10 2017 : Debug: detail (/var/log/freeradius/radacct/detail-*): Detail listener state unopened waiting 1.223150 sec 
Wed Jan 25 12:04:10 2017 : Debug: %t 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: percent --> t 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/radacct/debug/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/radacct/debug/ 
Wed Jan 25 12:04:10 2017 : Debug: if { 
Wed Jan 25 12:04:10 2017 : Debug:       attribute --> Packet-Src-IP-Address 
Wed Jan 25 12:04:10 2017 : Debug: } 
Wed Jan 25 12:04:10 2017 : Debug: else { 
Wed Jan 25 12:04:10 2017 : Debug:       attribute --> Packet-Src-IPv6-Address 
Wed Jan 25 12:04:10 2017 : Debug: } 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /detail- 
Wed Jan 25 12:04:10 2017 : Debug: percent --> Y 
Wed Jan 25 12:04:10 2017 : Debug: percent --> m 
Wed Jan 25 12:04:10 2017 : Debug: percent --> d 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: %t 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: percent --> t 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: %{User-Name} 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: attribute --> User-Name 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Thread 1 waiting to be assigned a request 
Wed Jan 25 12:04:10 2017 : Debug: Waking up in 0.3 seconds. 
Wed Jan 25 12:04:10 2017 : Debug: Thread 8 got semaphore 
Wed Jan 25 12:04:10 2017 : Debug: Thread 8 handling request 494091, (49057 handled so far) 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
(duplicate) 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/radacct/detail-%Y%m%d 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/radacct/detail- 
Wed Jan 25 12:04:10 2017 : Debug: percent --> Y 
Wed Jan 25 12:04:10 2017 : Debug: percent --> m 
Wed Jan 25 12:04:10 2017 : Debug: percent --> d 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: %t 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: percent --> t 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/radacct/debug/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/radacct/debug/ 
Wed Jan 25 12:04:10 2017 : Debug: if { 
Wed Jan 25 12:04:10 2017 : Debug:       attribute --> Packet-Src-IP-Address 
Wed Jan 25 12:04:10 2017 : Debug: } 
Wed Jan 25 12:04:10 2017 : Debug: else { 
Wed Jan 25 12:04:10 2017 : Debug:       attribute --> Packet-Src-IPv6-Address 
Wed Jan 25 12:04:10 2017 : Debug: } 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /detail- 
Wed Jan 25 12:04:10 2017 : Debug: percent --> Y 
Wed Jan 25 12:04:10 2017 : Debug: percent --> m 
Wed Jan 25 12:04:10 2017 : Debug: percent --> d 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: %t 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: percent --> t 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: %{User-Name} 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: attribute --> User-Name 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Thread 8 waiting to be assigned a request 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:10 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:10 2017 : Info: Ready to process requests 
Wed Jan 25 12:04:11 2017 : Debug: detail (/var/log/freeradius/radacct/detail-*): Polling for detail file 
Wed Jan 25 12:04:11 2017 : Debug: detail (/var/log/freeradius/radacct/detail-*): Renaming /var/log/freeradius/radacct/detail-20170125 -> /var/log/freeradius/radacct/detail.work 
Wed Jan 25 12:04:11 2017 : Debug: detail (/var/log/freeradius/radacct/detail-*): Read packet from /var/log/freeradius/radacct/detail.work 
Wed Jan 25 12:04:11 2017 : Debug: Waking up in 0.3 seconds. 
Wed Jan 25 12:04:11 2017 : Debug: Thread 6 got semaphore 
Wed Jan 25 12:04:11 2017 : Debug: Thread 6 handling request 494092, (48855 handled so far) 
Wed Jan 25 12:04:11 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:11 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:11 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:11 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:11 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: %{tolower:type.%{Acct-Status-Type}.query} 
Wed Jan 25 12:04:11 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:11 2017 : Debug: xlat --> tolower 
Wed Jan 25 12:04:11 2017 : Debug: { 
Wed Jan 25 12:04:11 2017 : Debug:       literal --> type. 
Wed Jan 25 12:04:11 2017 : Debug:       attribute --> Acct-Status-Type 
Wed Jan 25 12:04:11 2017 : Debug:       literal --> .query 
Wed Jan 25 12:04:11 2017 : Debug: } 
Wed Jan 25 12:04:11 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:11 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:11 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:11 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: rlm_sql (sql): Reserved connection (12) 
Wed Jan 25 12:04:11 2017 : Debug: %{User-Name} 
Wed Jan 25 12:04:11 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:11 2017 : Debug: attribute --> User-Name 
Wed Jan 25 12:04:11 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:11 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:11 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:11 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: INSERT INTO radcalls (acctsessionid,          acctuniqueid,       acctstatus,         username, nasipaddress,         nasportid,          calltime,           acctinputoctets, acctoutputoctets,   calledstationid,        callingstationid,   acctterminatecause, framedipaddress) VALUES ('%{Acct-Session-Id}', '%{Acct-Unique-Session-Id}', %{integer:Acct-Status-Type}, lower(trim('%{SQL-User-Name}')), '%{%{Called-Station-Id}:-%{NAS-IP-Address}}', '%{%{NAS-Port-ID}:-%{NAS-Port}}', NOW(), '0', '0', '%{Called-Station-Id}', '%{Calling-Station-Id}', '', '%{Framed-IP-Address}') 
Wed Jan 25 12:04:11 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:11 2017 : Debug: literal --> INSERT INTO radcalls (acctsessionid,              acctuniqueid,       acctstatus,         username, nasipaddress,              nasportid,          calltime,           acctinputoctets, acctoutputoctets,      calledstationid,        callingstationid,   acctterminatecause, framedipaddress) VALUES (' 
Wed Jan 25 12:04:11 2017 : Debug: attribute --> Acct-Session-Id 
Wed Jan 25 12:04:11 2017 : Debug: literal --> ', ' 
Wed Jan 25 12:04:11 2017 : Debug: attribute --> Acct-Unique-Session-Id 
Wed Jan 25 12:04:11 2017 : Debug: literal --> ', 
Wed Jan 25 12:04:11 2017 : Debug: xlat --> integer 
Wed Jan 25 12:04:11 2017 : Debug: { 
Wed Jan 25 12:04:11 2017 : Debug:       literal --> Acct-Status-Type 
Wed Jan 25 12:04:11 2017 : Debug: } 
Wed Jan 25 12:04:11 2017 : Debug: literal --> , lower(trim(' 
Wed Jan 25 12:04:11 2017 : Debug: attribute --> SQL-User-Name 
Wed Jan 25 12:04:11 2017 : Debug: literal --> ')), ' 
Wed Jan 25 12:04:11 2017 : Debug: if { 
Wed Jan 25 12:04:11 2017 : Debug:       attribute --> Called-Station-Id 
Wed Jan 25 12:04:11 2017 : Debug: } 
Wed Jan 25 12:04:11 2017 : Debug: else { 
Wed Jan 25 12:04:11 2017 : Debug:       attribute --> NAS-IP-Address 
Wed Jan 25 12:04:11 2017 : Debug: } 
Wed Jan 25 12:04:11 2017 : Debug: literal --> ', ' 
Wed Jan 25 12:04:11 2017 : Debug: if { 
Wed Jan 25 12:04:11 2017 : Debug:       attribute --> NAS-Port-Id 
Wed Jan 25 12:04:11 2017 : Debug: } 
Wed Jan 25 12:04:11 2017 : Debug: else { 
Wed Jan 25 12:04:11 2017 : Debug:       attribute --> NAS-Port 
Wed Jan 25 12:04:11 2017 : Debug: } 
Wed Jan 25 12:04:11 2017 : Debug: literal --> ', NOW(), '0', '0', ' 
Wed Jan 25 12:04:11 2017 : Debug: attribute --> Called-Station-Id 
Wed Jan 25 12:04:11 2017 : Debug: literal --> ', ' 
Wed Jan 25 12:04:11 2017 : Debug: attribute --> Calling-Station-Id 
Wed Jan 25 12:04:11 2017 : Debug: literal --> ', '', ' 
Wed Jan 25 12:04:11 2017 : Debug: attribute --> Framed-IP-Address 
Wed Jan 25 12:04:11 2017 : Debug: literal --> ') 
Wed Jan 25 12:04:11 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:11 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:11 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:11 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:11 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:11 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: rlm_sql (sql): Released connection (12) 
Wed Jan 25 12:04:11 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:11 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:11 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:11 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:11 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:11 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:11 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: Thread 6 waiting to be assigned a request 
Wed Jan 25 12:04:11 2017 : Debug: detail (/var/log/freeradius/radacct/detail-*): Unlinking /var/log/freeradius/radacct/detail.work 
Wed Jan 25 12:04:11 2017 : Debug: detail (/var/log/freeradius/radacct/detail-*): Polling for detail file 
Wed Jan 25 12:04:11 2017 : Debug: detail (/var/log/freeradius/radacct/detail-*): Detail listener state unopened waiting 1.169948 sec 
Wed Jan 25 12:04:11 2017 : Debug: /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Debug: Parsed xlat tree: 
Wed Jan 25 12:04:11 2017 : Debug: literal --> /var/log/freeradius/debug.log 
Wed Jan 25 12:04:11 2017 : Info: Ready to process requests 
Wed Jan 25 12:04:12 2017 : Debug: detail (/var/log/freeradius/radacct/detail-*): Polling for detail file 
Wed Jan 25 12:04:12 2017 : Debug: detail (/var/log/freeradius/radacct/detail-*): Detail listener state unopened waiting 0.780303 sec 


More information about the Freeradius-Users mailing list