Hi,
I think there might be a bug in pfsetvlan first preventing legit local traps
from being parsed, second crashing pfsetvlan with segfault.
I noticed that $TRAP_PATTERN does not parse traps properly ignoring a valid
local trap such as the below:
Apr 23 11:43:50 pfsetvlan(21) INFO: ignoring non trap line:
2014-04-23|17:43:47|UDP: [127.0.0.1]:33824->[127.0.0.1]:162|10.8.254.12|BEGIN
TYPE 6 END TYPE BEGIN SUBTYPE .0 END SUBTYPE BEGIN VARIABLEBINDINGS
.1.3.6.1.6.3.1.1.4.1.0 = OID: .1.3.6.1.4.1.29464.1.2|.1.3.6.1.4.1.29464.1.3 =
STRING: "78:e4:00:f0:df:78"|.1.3.6.1.4.1.29464.1.4 = INTEGER: 258 END
VARIABLEBINDINGS (main::parseTrap)
So I changed the pattern to meet the expected lexical structure specifically
that ":162" piece that caused the above message.
my $TRAP_PATTERN = qr/
^\d{4}-\d{2}-\d{2}\|\d{2}:\d{2}:\d{2}\| # date|time
(?:UDP:\ \[)? # Optional "UDP: ["
(since v2 traps I think)
(\d{1,3}\.\d{1,3}\.\d{1,3}\.\d{1,3}) # network device ip
address
(?:\]:\d+)? # Optional "]:port"
(since v2 traps I think)
(?:\-\>\[\d{1,3}\.\d{1,3}\.\d{1,3}\.\d{1,3}\])? # Optional "->[ip
address]" (since net-snmp 5.4)
(?::\d+)? # ->>NEW Optional ":port"
(since v2 traps I think)
\|([^|]*)\| # Used to carry network
device ip if it's a local trap
(.+)$ # Trap message
/sx; # s for multiline support (if we encounter an Hex 0a which is encoded as a
newline in STRING)
After this change the trap seems to be parsed ok but now I have a segfault issue
Apr 23 13:24:55 packetfence kernel: [ 7586.167020] pfsetvlan[6934]: segfault at
b5eb6ffc ip b6f89073 sp b5eb7000 error 6 in Classify.so[b6f88000+4000]
Here's the log
root@packetfence:/usr/local/pf# tail -f logs/packetfence.log | grep -v
"pfdhcplistener"
Apr 23 13:24:52 pfcmd_vlan(6961) INFO: verbosity flag passed. Messages now
logged to stdout and logs but logged message priority will change for this
pfcmd_vlan run. (main::)
Apr 23 13:24:52 pfcmd_vlan(6961) INFO: New loglevel: TRACE (main::)
Apr 23 13:24:52 pfcmd_vlan(6961) DEBUG: instantiating new SwitchFactory object
(pf::SwitchFactory::new)
Apr 23 13:24:52 pfcmd_vlan(6961) INFO: re-evaluating access for node
78:e4:00:f0:df:78 (pfcmd_vlan called) (pf::enforcement::reevaluate_access)
Apr 23 13:24:52 pfcmd_vlan(6961) TRACE: attempt #0 to run query
locationlog_view_open_mac_sql from module locationlog (pf::db::db_query_execute)
Apr 23 13:24:52 pfcmd_vlan(6961) DEBUG: Database statements not prepared,
preparing... (pf::db::db_query_execute)
Apr 23 13:24:52 pfcmd_vlan(6961) DEBUG: Preparing pf::locationlog database
queries (pf::locationlog::locationlog_db_prepare)
Apr 23 13:24:52 pfcmd_vlan(6961) DEBUG: function pf::db::get_db_handle is
calling db_connect (pf::db::db_connect)
Apr 23 13:24:52 pfcmd_vlan(6961) DEBUG: checking handle (pf::db::db_connect)
Apr 23 13:24:52 pfcmd_vlan(6961) DEBUG: (Re)Connecting to MySQL (thread id: 0)
(pf::db::db_connect)
Apr 23 13:24:52 pfcmd_vlan(6961) DEBUG: connected (pf::db::db_connect)
Apr 23 13:24:52 pfcmd_vlan(6961) INFO: 78:e4:00:f0:df:78 is currentlog
connected at 10.8.254.12 ifIndex 30769 in VLAN 305
(pf::enforcement::_should_we_reassign_vlan)
Apr 23 13:24:52 pfcmd_vlan(6961) DEBUG: instantiating new pf::vlan object
(pf::vlan::new)
Apr 23 13:24:52 pfcmd_vlan(6961) DEBUG: creating new
pf::SNMP::Cisco::Aironet_1250 object (pf::SwitchFactory::instantiate)
Apr 23 13:24:52 pfcmd_vlan(6961) TRACE: attempt #0 to run query
node_attributes_sql from module node (pf::db::db_query_execute)
Apr 23 13:24:52 pfcmd_vlan(6961) DEBUG: Database statements not prepared,
preparing... (pf::db::db_query_execute)
Apr 23 13:24:52 pfcmd_vlan(6961) DEBUG: Preparing pf::node database queries
(pf::node::node_db_prepare)
Apr 23 13:24:52 pfcmd_vlan(6961) TRACE: attempt #0 to run query
violation_count_trap_sql from module violation (pf::db::db_query_execute)
Apr 23 13:24:52 pfcmd_vlan(6961) DEBUG: Database statements not prepared,
preparing... (pf::db::db_query_execute)
Apr 23 13:24:52 pfcmd_vlan(6961) DEBUG: Preparing pf::violation database
queries (pf::violation::violation_db_prepare)
Apr 23 13:24:52 pfcmd_vlan(6961) DEBUG: Trying to determine VLAN from role.
(pf::vlan::getNormalVlan)
Apr 23 13:24:52 pfcmd_vlan(6961) INFO: Username was NOT defined or unable to
match a role - returning node based role 'guest' (pf::vlan::getNormalVlan)
Apr 23 13:24:52 pfcmd_vlan(6961) INFO: MAC: 78:e4:00:f0:df:78, PID:
[email protected], Status: reg. Returned VLAN: 306 (pf::vlan::fetchVlanForNode)
Apr 23 13:24:52 pfcmd_vlan(6961) INFO: VLAN reassignment required for
78:e4:00:f0:df:78 (current VLAN = 305 but should be in VLAN 306)
(pf::enforcement::_should_we_reassign_vlan)
Apr 23 13:24:52 pfcmd_vlan(6961) INFO: switch port for 78:e4:00:f0:df:78 is
10.8.254.12 ifIndex 30769 connection type: WiFi MAC Auth
(pf::enforcement::_vlan_reevaluation)
Apr 23 13:24:52 pfcmd_vlan(6961) DEBUG: creating new pf::SNMP::PacketFence
object (pf::SwitchFactory::instantiate)
Apr 23 13:24:52 pfcmd_vlan(6961) DEBUG: sending a local desAssociate trap to
force deassociation (client will reconnect getting a new VLAN)
(pf::enforcement::_vlan_reevaluation)
Apr 23 13:24:52 pfcmd_vlan(6961) DEBUG: opening SNMP v1 connection to 127.0.0.1
(pf::SNMP::PacketFence::connectWrite)
Apr 23 13:24:54 pfsetvlan(0) TRACE: locking - trying to lock trapList_queued
(main::addTrapLineToQueue)
Apr 23 13:24:54 pfsetvlan(0) DEBUG: adding trapline 2014-04-23|19:24:52|UDP:
[127.0.0.1]:58311->[127.0.0.1]:162|10.8.254.12|BEGIN TYPE 6 END TYPE BEGIN
SUBTYPE .0 END SUBTYPE BEGIN VARIABLEBINDINGS .1.3.6.1.6.3.1.1.4.1.0 = OID:
.1.3.6.1.4.1.29464.1.2|.1.3.6.1.4.1.29464.1.3 = STRING:
"78:e4:00:f0:df:78"|.1.3.6.1.4.1.29464.1.4 = INTEGER: 258 END VARIABLEBINDINGS
to queued trapList (main::addTrapLineToQueue)
Apr 23 13:24:54 pfsetvlan(0) TRACE: locking - sending signal for
trapList_queued (main::addTrapLineToQueue)
Apr 23 13:24:54 pfsetvlan(21) TRACE: locking - received signal for
trapList_queued in signalHandlerTrapListQueued
(main::signalHandlerTrapListQueued)
Apr 23 13:24:54 pfsetvlan(21) TRACE: initially trapList_queued contains
raw|2014-04-23|19:24:52|UDP:
[127.0.0.1]:58311->[127.0.0.1]:162|10.8.254.12|BEGIN TYPE 6 END TYPE BEGIN
SUBTYPE .0 END SUBTYPE BEGIN VARIABLEBINDINGS .1.3.6.1.6.3.1.1.4.1.0 = OID:
.1.3.6.1.4.1.29464.1.2|.1.3.6.1.4.1.29464.1.3 = STRING:
"78:e4:00:f0:df:78"|.1.3.6.1.4.1.29464.1.4 = INTEGER: 258 END VARIABLEBINDINGS
(main::signalHandlerTrapListQueued)
Apr 23 13:24:54 pfsetvlan(21) DEBUG: retrieved raw trapline
2014-04-23|19:24:52|UDP: [127.0.0.1]:58311->[127.0.0.1]:162|10.8.254.12|BEGIN
TYPE 6 END TYPE BEGIN SUBTYPE .0 END SUBTYPE BEGIN VARIABLEBINDINGS
.1.3.6.1.6.3.1.1.4.1.0 = OID: .1.3.6.1.4.1.29464.1.2|.1.3.6.1.4.1.29464.1.3 =
STRING: "78:e4:00:f0:df:78"|.1.3.6.1.4.1.29464.1.4 = INTEGER: 258 END
VARIABLEBINDINGS from trapList_queued at position 0
(main::signalHandlerTrapListQueued)
Apr 23 13:24:54 pfsetvlan(21) TRACE: after retrieval operation trapList_queued
contains
inparse21|2014-04-23|19:24:52|UDP:
[127.0.0.1]:58311->[127.0.0.1]:162|10.8.254.12|BEGIN TYPE 6 END TYPE BEGIN
SUBTYPE .0 END SUBTYPE BEGIN VARIABLEBINDINGS .1.3.6.1.6.3.1.1.4.1.0 = OID:
.1.3.6.1.4.1.29464.1.2|.1.3.6.1.4.1.29464.1.3 = STRING:
"78:e4:00:f0:df:78"|.1.3.6.1.4.1.29464.1.4 = INTEGER: 258 END VARIABLEBINDINGS
(main::signalHandlerTrapListQueued)
Apr 23 13:24:54 pfsetvlan(0) TRACE: locking - unlocked trapList_queued
(main::addTrapLineToQueue)
Apr 23 13:24:54 pfsetvlan(21) TRACE: locking - unlocked trapList_queued in
signalHandlerTrapListQueued (main::signalHandlerTrapListQueued)
Apr 23 13:24:54 pfsetvlan(21) DEBUG: calling parseTrap for
2014-04-23|19:24:52|UDP: [127.0.0.1]:58311->[127.0.0.1]:162|10.8.254.12|BEGIN
TYPE 6 END TYPE BEGIN SUBTYPE .0 END SUBTYPE BEGIN VARIABLEBINDINGS
.1.3.6.1.6.3.1.1.4.1.0 = OID: .1.3.6.1.4.1.29464.1.2|.1.3.6.1.4.1.29464.1.3 =
STRING: "78:e4:00:f0:df:78"|.1.3.6.1.4.1.29464.1.4 = INTEGER: 258 END
VARIABLEBINDINGS (main::signalHandlerTrapListQueued)
Apr 23 13:24:54 pfsetvlan(21) DEBUG: parsing trap 2014-04-23|19:24:52|UDP:
[127.0.0.1]:58311->[127.0.0.1]:162|10.8.254.12|BEGIN TYPE 6 END TYPE BEGIN
SUBTYPE .0 END SUBTYPE BEGIN VARIABLEBINDINGS .1.3.6.1.6.3.1.1.4.1.0 = OID:
.1.3.6.1.4.1.29464.1.2|.1.3.6.1.4.1.29464.1.3 = STRING:
"78:e4:00:f0:df:78"|.1.3.6.1.4.1.29464.1.4 = INTEGER: 258 END VARIABLEBINDINGS
(main::parseTrap)
Apr 23 13:24:54 pfsetvlan(21) TRACE: locking - trying to lock
switchFactory_locker in parseTrap (main::parseTrap)
Apr 23 13:24:54 pfsetvlan(21) TRACE: locking - obtained lock on
switchFactory_locker in parseTrap (main::parseTrap)
Apr 23 13:24:54 pfsetvlan(21) INFO: local (127.0.0.1) trap for switch
10.8.254.12 (main::parseTrap)
Apr 23 13:24:55 pfsetvlan(21) DEBUG: creating new pf::SNMP::Cisco::Aironet_1250
object (pf::SwitchFactory::instantiate)
Apr 23 13:24:55 pfsetvlan(21) TRACE: locking - unlocked switchFactory_locker in
parseTrap (main::parseTrap)
Apr 23 13:24:55 pfsetvlan(21) TRACE: locking - trying to lock trapList_queued
in signalHandlerTrapListQueued (main::signalHandlerTrapListQueued)
Apr 23 13:24:55 pfsetvlan(21) TRACE: locking - obtained lock on trapList_queued
in signalHandlerTrapListQueued (main::signalHandlerTrapListQueued)
Apr 23 13:24:55 pfsetvlan(21) TRACE: after parseTrap operation trapList_queued
contains
inparse21|2014-04-23|19:24:52|UDP:
[127.0.0.1]:58311->[127.0.0.1]:162|10.8.254.12|BEGIN TYPE 6 END TYPE BEGIN
SUBTYPE .0 END SUBTYPE BEGIN VARIABLEBINDINGS .1.3.6.1.6.3.1.1.4.1.0 = OID:
.1.3.6.1.4.1.29464.1.2|.1.3.6.1.4.1.29464.1.3 = STRING:
"78:e4:00:f0:df:78"|.1.3.6.1.4.1.29464.1.4 = INTEGER: 258 END VARIABLEBINDINGS
(main::signalHandlerTrapListQueued)
Apr 23 13:24:55 pfsetvlan(21) TRACE: replacing threadList_queued[0] with
parseTrap result (main::signalHandlerTrapListQueued)
Apr 23 13:24:55 pfsetvlan(21) TRACE: after parseTrap and replacement operation
trapList_queued contains
parsed21|10.8.254.12|WIFI|desAssociate||258|78:e4:00:f0:df:78||||
(main::signalHandlerTrapListQueued)
Apr 23 13:24:55 pfsetvlan(21) DEBUG: finished parsing 0th trapList_queued entry
(main::signalHandlerTrapListQueued)
Apr 23 13:24:55 pfsetvlan(21) TRACE: locking - unlocked trapList_queued in
signalHandlerTrapListQueued (main::signalHandlerTrapListQueued)
Apr 23 13:24:55 pfsetvlan(21) TRACE: locking - trying to lock trapList_queued
in signalHandlerTrapListQueued (main::signalHandlerTrapListQueued)
Apr 23 13:24:55 pfsetvlan(21) TRACE: locking - obtained lock on trapList_queued
in signalHandlerTrapListQueued (main::signalHandlerTrapListQueued)
Apr 23 13:24:55 pfsetvlan(21) TRACE: retrieved parsed trapLine
10.8.254.12|WIFI|desAssociate||258|78:e4:00:f0:df:78|||| with prefix parsed21|
from trapList_queued. Adding it to candidatesForThreadList_queued
(main::signalHandlerTrapListQueued)
Apr 23 13:24:55 pfsetvlan(21) TRACE: after intelligent removal of parsed traps
trapList_queued contains
(main::signalHandlerTrapListQueued)
Apr 23 13:24:55 pfsetvlan(21) TRACE: locking - trying to lock threadList_queued
in signalHandlerTrapListQueued (main::signalHandlerTrapListQueued)
Apr 23 13:24:55 pfsetvlan(21) TRACE: locking - obtained lock on
threadList_queued in signalHandlerTrapListQueued
(main::signalHandlerTrapListQueued)
Apr 23 13:24:55 pfsetvlan(21) DEBUG: validating if parsed trapLine
10.8.254.12|WIFI|desAssociate||258|78:e4:00:f0:df:78|||| should be added to
threadList_queued (main::signalHandlerTrapListQueued)
Apr 23 13:24:55 pfsetvlan(21) DEBUG: creating new pf::SNMP::Cisco::Aironet_1250
object (pf::SwitchFactory::instantiate)
Apr 23 13:24:55 pfsetvlan(21) DEBUG: added trap desAssociate at 10.8.254.12
ifindex WIFI to queued threadList (main::signalHandlerTrapListQueued)
Apr 23 13:24:55 pfsetvlan(21) TRACE: attempt #0 to run query traplog_insert_sql
from module traplog (pf::db::db_query_execute)
Apr 23 13:24:55 pfsetvlan(21) DEBUG: Database statements not prepared,
preparing... (pf::db::db_query_execute)
Apr 23 13:24:55 pfsetvlan(21) DEBUG: Preparing pf::traplog database queries
(pf::traplog::traplog_db_prepare)
Apr 23 13:24:55 pfsetvlan(21) DEBUG: function pf::db::get_db_handle is calling
db_connect (pf::db::db_connect)
Apr 23 13:24:55 pfsetvlan(21) DEBUG: checking handle (pf::db::db_connect)
Apr 23 13:24:55 pfsetvlan(21) DEBUG: (Re)Connecting to MySQL (thread id: 21)
(pf::db::db_connect)
Apr 23 13:24:55 pfsetvlan(21) DEBUG: connected (pf::db::db_connect)
Apr 23 13:24:55 pfsetvlan(21) TRACE: locking - sending signal for
threadList_queued in signalHanderTrapListQueued
(main::signalHandlerTrapListQueued)
Apr 23 13:24:55 pfsetvlan(1) TRACE: locking - received signal for
threadList_queued in signalHandlerThreadListQueued
(main::signalHandlerThreadListQueued)
Apr 23 13:24:55 pfsetvlan(1) TRACE: locking - unlocked threadList_queued in
signalHandlerThreadListQueued (main::signalHandlerThreadListQueued)
Apr 23 13:24:55 pfsetvlan(1) DEBUG: new enqueue or dequeue operation happened
and threadList_queued is not empty (main::signalHandlerThreadListQueued)
Apr 23 13:24:55 pfsetvlan(1) TRACE: locking - trying to lock threadList_queued,
threadList_running and treadList_toBeKilled in startTrapHandlers
(main::startTrapHandlers)
Apr 23 13:24:55 pfsetvlan(1) TRACE: locking - obtained lock on
threadList_queued, threadList_running and treadList_toBeKilled in
startTrapHandlers (main::startTrapHandlers)
Apr 23 13:24:55 pfsetvlan(1) INFO: nb of items in queue: 1; nb of threads
running: 0 (main::startTrapHandlers)
Apr 23 13:24:55 pfsetvlan(1) DEBUG: items in queue:
10.8.254.12 WIFI desAssociate (main::startTrapHandlers)
Apr 23 13:24:55 pfsetvlan(1) DEBUG: threads running: (main::startTrapHandlers)
Apr 23 13:24:55 pfsetvlan(1) TRACE: locking - unlocked threadList_queued,
threadList_running and treadList_toBeKilled in startTrapHandlers
(main::startTrapHandlers)
Apr 23 13:24:55 pfsetvlan(1) DEBUG: calling handleTrap (main::startTrapHandlers)
Apr 23 13:24:55 pfsetvlan(1) DEBUG: instantiating new pf::vlan object
(pf::vlan::new)
Apr 23 13:24:55 pfsetvlan(21) TRACE: locking - unlocked threadList_queued in
signalHandlerTrapListQueued (main::signalHandlerTrapListQueued)
Apr 23 13:24:55 pfsetvlan(1) TRACE: locking - trying to lock
switchFactory_locker in handleTrap (main::handleTrap)
Apr 23 13:24:55 pfsetvlan(21) TRACE: locking - unlocked trapList_queued in
signalHandlerTrapListQueued (main::signalHandlerTrapListQueued)
Apr 23 13:24:55 pfsetvlan(1) TRACE: locking - obtained lock on
switchFactory_locker in handleTrap (main::handleTrap)
Apr 23 13:24:55 pfsetvlan(21) TRACE: Reloading all configs
(pf::config::cached::ReloadConfigs)
Apr 23 13:24:55 pfsetvlan(21) TRACE: ReadConfig for
/usr/local/pf/conf/documentation.conf (pf::config::cached::ReadConfig)
Apr 23 13:24:55 pfsetvlan(21) TRACE: ReadConfig for
/usr/local/pf/conf/pf.conf.defaults (pf::config::cached::ReadConfig)
Apr 23 13:24:55 pfsetvlan(21) TRACE: ReadConfig for /usr/local/pf/conf/pf.conf
(pf::config::cached::ReadConfig)
Apr 23 13:24:55 pfsetvlan(21) TRACE: ReadConfig for
/usr/local/pf/conf/profiles.conf (pf::config::cached::ReadConfig)
Apr 23 13:24:55 pfsetvlan(21) TRACE: ReadConfig for
/usr/local/pf/conf/networks.conf (pf::config::cached::ReadConfig)
Apr 23 13:24:55 pfsetvlan(21) TRACE: ReadConfig for
/usr/local/pf/conf/floating_network_device.conf (pf::config::cached::ReadConfig)
Apr 23 13:24:55 pfsetvlan(21) TRACE: ReadConfig for
/usr/local/pf/conf/switches.conf (pf::config::cached::ReadConfig)
Apr 23 13:24:55 pfsetvlan(21) TRACE: ReadConfig for
/usr/local/pf/conf/authentication.conf (pf::config::cached::ReadConfig)
Apr 23 13:24:55 pfsetvlan(21) TRACE: locking - trying to lock trapList_queued
in signalHandlerTrapListQueued (main::signalHandlerTrapListQueued)
Apr 23 13:24:55 pfsetvlan(21) TRACE: locking - obtained lock on trapList_queued
in signalHandlerTrapListQueued (main::signalHandlerTrapListQueued)
Apr 23 13:24:55 pfsetvlan(21) TRACE: locking - waiting for signal for
trapList_queued in signalHandlerTrapListQueued
(main::signalHandlerTrapListQueued)
Apr 23 13:24:58 pfdns(5586) TRACE: Reloading all configs
(pf::config::cached::ReloadConfigs)
Apr 23 13:24:58 pfdns(5586) TRACE: ReadConfig for
/usr/local/pf/conf/documentation.conf (pf::config::cached::ReadConfig)
Apr 23 13:24:58 pfdns(5586) TRACE: ReadConfig for
/usr/local/pf/conf/pf.conf.defaults (pf::config::cached::ReadConfig)
Apr 23 13:24:58 pfdns(5586) TRACE: ReadConfig for /usr/local/pf/conf/pf.conf
(pf::config::cached::ReadConfig)
Apr 23 13:24:58 pfdns(5586) TRACE: ReadConfig for
/usr/local/pf/conf/profiles.conf (pf::config::cached::ReadConfig)
Apr 23 13:24:58 pfdns(5586) TRACE: ReadConfig for
/usr/local/pf/conf/networks.conf (pf::config::cached::ReadConfig)
Apr 23 13:24:58 pfdns(5586) TRACE: ReadConfig for
/usr/local/pf/conf/floating_network_device.conf (pf::config::cached::ReadConfig)
Apr 23 13:24:58 pfdns(5586) TRACE: ReadConfig for
/usr/local/pf/conf/authentication.conf (pf::config::cached::ReadConfig)
Apr 23 13:24:58 pfdns(5586) TRACE: ReadConfig for
/usr/local/pf/conf/switches.conf (pf::config::cached::ReadConfig)
Apr 23 13:24:58 pfdns(5586) TRACE: Requested Domain: teredo.ipv6.microsoft.com
(main::regzone)
Apr 23 13:25:08 pfmon(1) INFO: running expire check (main::cleanup)
Apr 23 13:25:08 pfmon(1) DEBUG: calling iplog_cleanup with time=7776000
(pf::iplog::iplog_cleanup)
Apr 23 13:25:08 pfmon(1) TRACE: attempt #0 to run query iplog_cleanup_sql from
module iplog (pf::db::db_query_execute)
Apr 23 13:25:08 pfmon(1) DEBUG: deleted 0 entries from iplog during iplog
cleanup (pf::iplog::iplog_cleanup)
Apr 23 13:25:08 pfmon(1) DEBUG: calling locationlog_cleanup with time=15552000
(pf::locationlog::locationlog_cleanup)
Apr 23 13:25:08 pfmon(1) TRACE: attempt #0 to run query locationlog_cleanup_sql
from module locationlog (pf::db::db_query_execute)
Apr 23 13:25:08 pfmon(1) DEBUG: deleted 0 entries from locationlog during
locationlog cleanup (pf::locationlog::locationlog_cleanup)
Apr 23 13:25:08 pfmon(1) DEBUG: calling node_cleanup with time=604800
(pf::node::node_cleanup)
Apr 23 13:25:08 pfmon(1) TRACE: attempt #0 to run query node_expire_lastarp_sql
from module node (pf::db::db_query_execute)
Apr 23 13:25:08 pfmon(1) TRACE: attempt #0 to run query
node_expire_lastdhcp_sql from module node (pf::db::db_query_execute)
Apr 23 13:25:08 pfmon(1) DEBUG: calling traplog_cleanup with time=7776000
(pf::traplog::traplog_cleanup)
Apr 23 13:25:08 pfmon(1) TRACE: attempt #0 to run query traplog_cleanup_sql
from module traplog (pf::db::db_query_execute)
Apr 23 13:25:08 pfmon(1) DEBUG: deleted 0 entries from traplog during traplog
cleanup (pf::traplog::traplog_cleanup)
Apr 23 13:25:08 pfmon(1) INFO: checking registered nodes for expiration
(main::cleanup)
Apr 23 13:25:08 pfmon(1) DEBUG: nodes_maintenance called
(pf::node::nodes_maintenance)
Apr 23 13:25:08 pfmon(1) TRACE: attempt #0 to run query
node_expire_unreg_field_sql from module node (pf::db::db_query_execute)
Apr 23 13:25:08 pfmon(1) INFO: checking violations for expiration
(main::cleanup)
Apr 23 13:25:08 pfmon(1) DEBUG: Looking at expired violations...
(pf::violation::violation_maintenance)
Apr 23 13:25:08 pfmon(1) TRACE: attempt #0 to run query violation_release_sql
from module violation (pf::db::db_query_execute)
Apr 23 13:25:08 pfmon(1) INFO: checking accounting data for potential bandwidth
abuse (main::cleanup)
Apr 23 13:25:08 pfmon(1) INFO: getting violations triggers for accounting
cleanup (pf::accounting::acct_maintenance)
Apr 23 13:25:08 pfmon(1) TRACE: attempt #0 to run query trigger_view_type_sql
from module trigger (pf::db::db_query_execute)
Apr 23 13:25:08 pfmon(1) TRACE: attempt #0 to run query trigger_view_tid_sql
from module trigger (pf::db::db_query_execute)
Apr 23 13:25:08 pfmon(1) INFO: Calling node acct maintenance total with monthly
and 1 for 21474836480 (pf::accounting::acct_maintenance)
Apr 23 13:25:08 pfmon(1) TRACE: attempt #0 to run query
acct_maintenance_bw_monthly_all from module accounting
(pf::db::db_query_execute)
Apr 23 13:25:08 pfmon(1) TRACE: Reloading all configs
(pf::config::cached::ReloadConfigs)
Apr 23 13:25:08 pfmon(1) TRACE: ReadConfig for
/usr/local/pf/conf/documentation.conf (pf::config::cached::ReadConfig)
Apr 23 13:25:08 pfmon(1) TRACE: ReadConfig for
/usr/local/pf/conf/pf.conf.defaults (pf::config::cached::ReadConfig)
Apr 23 13:25:08 pfmon(1) TRACE: ReadConfig for /usr/local/pf/conf/pf.conf
(pf::config::cached::ReadConfig)
Apr 23 13:25:08 pfmon(1) TRACE: ReadConfig for /usr/local/pf/conf/profiles.conf
(pf::config::cached::ReadConfig)
Apr 23 13:25:08 pfmon(1) TRACE: ReadConfig for /usr/local/pf/conf/networks.conf
(pf::config::cached::ReadConfig)
Apr 23 13:25:08 pfmon(1) TRACE: ReadConfig for
/usr/local/pf/conf/floating_network_device.conf (pf::config::cached::ReadConfig)
Apr 23 13:25:08 pfmon(1) TRACE: ReadConfig for /usr/local/pf/conf/switches.conf
(pf::config::cached::ReadConfig)
Apr 23 13:25:08 pfmon(1) TRACE: ReadConfig for
/usr/local/pf/conf/authentication.conf (pf::config::cached::ReadConfig)
Any idea on what's going on and how to fix this?
Thanks. Your help is greatly appreciated.
Victor
------------------------------------------------------------------------------
Start Your Social Network Today - Download eXo Platform
Build your Enterprise Intranet with eXo Platform Software
Java Based Open Source Intranet - Social, Extensible, Cloud Ready
Get Started Now And Turn Your Intranet Into A Collaboration Platform
http://p.sf.net/sfu/ExoPlatform
_______________________________________________
PacketFence-users mailing list
[email protected]
https://lists.sourceforge.net/lists/listinfo/packetfence-users
