Hello all,

Yes, I applied the database update to the current installation.

I increased the log level to debug, same issues are noticed in psetvlan and dhcplistener:

Jan 17 09:10:39 pfsetvlan(7) DEBUG: new enqueue or dequeue operation happened and threadList_queued is not empty (main::signalHandlerThreadListQueued) Jan 17 09:10:39 pfsetvlan(7) INFO: nb of items in queue: 1; nb of threads running: 0 (main::startTrapHandlers)
Jan 17 09:10:39 pfsetvlan(7) DEBUG: items in queue:
192.168.0.245   10013   secureMacAddrViolation (main::startTrapHandlers)
Jan 17 09:10:39 pfsetvlan(7) DEBUG: threads running: (main::startTrapHandlers) Jan 17 09:10:39 pfsetvlan(7) DEBUG: calling handleTrap (main::startTrapHandlers) Jan 17 09:10:39 pfsetvlan(7) DEBUG: instantiating new pf::vlan object (pf::vlan::new) Jan 17 09:10:39 pfsetvlan(7) DEBUG: creating new pf::SNMP::Cisco::Catalyst_2960 object (pf::SwitchFactory::instantiate) Jan 17 09:10:39 pfsetvlan(7) INFO: secureMacAddrViolation trap received on 192.168.0.245 ifIndex 10013 for 28:d2:44:2b:5c:7d (main::handleTrap) *Jan 17 09:10:39 pfsetvlan(7) WARN: database query failed with: MySQL server has gone away. (errno: 2006), will try again (pf::db::db_query_execute)* Jan 17 09:10:39 pfsetvlan(7) DEBUG: function pf::db::db_query_execute is calling db_connect (pf::db::db_connect)
Jan 17 09:10:39 pfsetvlan(7) DEBUG: checking handle (pf::db::db_connect)
Jan 17 09:10:39 pfsetvlan(7) DEBUG: (Re)Connecting to MySQL (thread id: 7) (pf::db::db_connect)
Jan 17 09:10:39 pfsetvlan(7) DEBUG: connected (pf::db::db_connect)
Jan 17 09:10:39 pfsetvlan(7) DEBUG: Database statements not prepared, preparing... (pf::db::db_query_execute) Jan 17 09:10:39 pfsetvlan(7) DEBUG: Preparing pf::locationlog database queries (pf::locationlog::locationlog_db_prepare) Jan 17 09:10:39 pfsetvlan(7) WARN: database query failed with: MySQL server has gone away. (errno: 2006), will try again (pf::db::db_query_execute) Jan 17 09:10:39 pfsetvlan(7) DEBUG: function pf::db::db_query_execute is calling db_connect (pf::db::db_connect)
Jan 17 09:10:39 pfsetvlan(7) DEBUG: checking handle (pf::db::db_connect)
Jan 17 09:10:39 pfsetvlan(7) DEBUG: we are currently connected (pf::db::db_connect) Jan 17 09:10:39 pfsetvlan(7) DEBUG: Database statements not prepared, preparing... (pf::db::db_query_execute) Jan 17 09:10:39 pfsetvlan(7) DEBUG: Preparing pf::node database queries (pf::node::node_db_prepare) Jan 17 09:10:39 pfsetvlan(7) DEBUG: 28:d2:44:2b:5c:7d has still open locationlog entry at 192.168.0.245 ifIndex 10013 (main::do_port_security) Jan 17 09:10:39 pfsetvlan(7) INFO: Will try to check on this node's previous switch if secured entry needs to be removed. Old Switch IP: 192.168.0.245 (main::do_port_security) Jan 17 09:10:39 pfsetvlan(7) INFO: MAC 28:d2:44:2b:5c:7d is already authorized on 192.168.0.245 ifIndex 10013. Stopping secureMacAddrViolation trap handling here (main::handleTrap)
Jan 17 09:10:39 pfsetvlan(7) INFO: finished (main::cleanupAfterThread)




Jan 20 09:48:29 pfdhcplistener(18534) DEBUG: 10.0.2.219 && 88:51:fb:72:d2:55 (main::update_iplog) *Jan 20 09:48:29 pfdhcplistener(18534) WARN: database query failed with: MySQL server has gone away. (errno: 2006), will try again (pf::db::db_query_execute)* Jan 20 09:48:29 pfdhcplistener(18534) DEBUG: function pf::db::db_query_execute is calling db_connect (pf::db::db_connect) Jan 20 09:48:29 pfdhcplistener(18534) DEBUG: checking handle (pf::db::db_connect) Jan 20 09:48:29 pfdhcplistener(18534) DEBUG: we are currently connected (pf::db::db_connect) Jan 20 09:48:29 pfdhcplistener(18534) DEBUG: Database statements not prepared, preparing... (pf::db::db_query_execute) Jan 20 09:48:29 pfdhcplistener(18534) DEBUG: Preparing pf::iplog database queries (pf::iplog::iplog_db_prepare) Jan 20 09:48:29 pfdhcplistener(18534) DEBUG: could not resolve 10.0.2.219 to mac in iplog table (pf::iplog::ip2mac) Jan 20 09:48:29 pfdhcplistener(18534) INFO: could not resolve 10.0.2.219 to mac in ARP table (pf::iplog::ip2macinarp) Jan 20 09:48:29 pfdhcplistener(18534) DEBUG: trying to resolve 10.0.2.219 to mac using ping (pf::iplog::ip2mac) Jan 20 09:48:29 pfdhcplistener(18534) DEBUG: found 10.0.2.219 in Network 10.0.2.1/24 (pf::iplog::ip2mac) Jan 20 09:48:29 pfdhcplistener(18534) DEBUG: binding ping src IP to 10.0.2.1 for ping (pf::iplog::ip2mac) Jan 20 09:48:29 pfdhcplistener(18534) INFO: resolved 10.0.2.219 to mac (88:51:fb:72:d2:55) in ARP table (pf::iplog::ip2macinarp) Jan 20 09:48:29 pfdhcplistener(18534) DEBUG: creating new entry for (88:51:fb:72:d2:55 - 10.0.2.219) with empty end_time (pf::iplog::iplog_open) Jan 20 09:48:29 pfdhcplistener(18534) WARN: database query failed with: MySQL server has gone away. (errno: 2006), will try again (pf::db::db_query_execute) Jan 20 09:48:29 pfdhcplistener(18534) DEBUG: function pf::db::db_query_execute is calling db_connect (pf::db::db_connect) Jan 20 09:48:29 pfdhcplistener(18534) DEBUG: checking handle (pf::db::db_connect) Jan 20 09:48:29 pfdhcplistener(18534) DEBUG: we are currently connected (pf::db::db_connect) Jan 20 09:48:29 pfdhcplistener(18534) DEBUG: Database statements not prepared, preparing... (pf::db::db_query_execute) Jan 20 09:48:29 pfdhcplistener(18534) DEBUG: Preparing pf::nodecategory database queries (pf::nodecategory::nodecategory_db_prepare) Jan 20 09:48:29 pfdhcplistener(18534) WARN: database query failed with: MySQL server has gone away. (errno: 2006), will try again (pf::db::db_query_execute) Jan 20 09:48:29 pfdhcplistener(18534) DEBUG: function pf::db::db_query_execute is calling db_connect (pf::db::db_connect) Jan 20 09:48:29 pfdhcplistener(18534) DEBUG: checking handle (pf::db::db_connect)




Also seems that there are several duplicated entries with the same MAC, how can be possible?

Jan 20 14:30:26 pfdhcplistener(18540) WARN: database query failed with: Duplicate entry '00:50:56:a9:7b:43' for key 'PRIMARY'. (errno: 1062), will try again (pf::db::db_query_execute) Jan 20 14:30:26 pfdhcplistener(18540) WARN: database query failed with: Duplicate entry '00:50:56:a9:7b:43' for key 'PRIMARY'. (errno: 1062), will try again (pf::db::db_query_execute) Jan 20 14:30:26 pfdhcplistener(18540) WARN: database query failed with: Duplicate entry '00:50:56:a9:7b:43' for key 'PRIMARY'. (errno: 1062), will try again (pf::db::db_query_execute) Jan 20 14:30:26 pfdhcplistener(18540) ERROR: Database issue: We tried 3 times to serve query node_add_sql called from pf::node::node_add and we failed. Is the database running? (pf::db::db_query_execute)


Thanks


*Alberto Losada
IT Systems Engineer*

On 01/20/2014 02:14 PM, Fabrice DURAND wrote:
Hello Alberto,

by upgrading the database James mean using the database upgrade script in /usr/local/pf/db/upgrade-4.0.0-4.1.0.sql.

Regards
Fabrice

Le 2014-01-20 04:17, Alberto Losada a écrit :
Hi all,

No I'm sure I did not upgrade mysql from 4.0.6 to 4.1, however I can't be sure if there was an upgrande moving from version 3 to 4. Here it is mysql version installed currently:

[root@packetfence logs]# rpm -qa mysql
mysql-5.1.69-1.el6_4.x86_64

Is this the recommended one?

*Alberto Losada
IT Systems Engineer*

Scytl Secure Electronic Voting
Plaça Gal.la Placídia, 1-3, 1º Planta, 08006 Barcelona
+ e-mail: [email protected]
+ Phone: +34 934230324
+ Fax: +34 933251028
+ www: http://www.scytl.com
On 01/17/2014 09:03 PM, James Rouzier wrote:
Did you upgrade your database?

James Rouzier
[email protected]  :: +1.514.755.3630  ::http://www.inverse.ca
Inverse inc. :: Leaders behind SOGo (http://www.sogo.nu) and PacketFence 
(http://www.packetfence.org)

On 1/17/2014, 12:30 PM, Alberto Losada wrote:
Hi all,

Upgraded from 4.06 to 4.1.0 recently, however almost every day I am
seeing these errors in packetfence.log:

Jan 16 17:25:32 pfdhcplistener(27721) ERROR: Database issue: We tried 3
times to serve query node_add_sql called from pf::node::node_add and we
failed. Is the database running? (pf::db::db_query_execute)
Jan 16 17:34:19 pfdhcplistener(27721) ERROR: Database issue: We tried 3
times to serve query node_add_sql called from pf::node::node_add and we
failed. Is the database running? (pf::db::db_query_execute)
Jan 17 10:30:08 pfdhcplistener(18536) ERROR: Database issue: We tried 3
times to serve query node_add_sql called from pf::node::node_add and we
failed. Is the database running? (pf::db::db_query_execute)
Jan 17 10:43:33 pfdhcplistener(18536) ERROR: Database issue: We tried 3
times to serve query node_add_sql called from pf::node::node_add and we
failed. Is the database running? (pf::db::db_query_execute)
Jan 17 13:09:10 pfdhcplistener(18565) ERROR: Database issue: We tried 3
times to serve query node_add_sql called from pf::node::node_add and we
failed. Is the database running? (pf::db::db_query_execute)
Jan 17 15:48:07 pfdhcplistener(27721) ERROR: Database issue: We tried 3
times to serve query node_add_sql called from pf::node::node_add and we
failed. Is the database running? (pf::db::db_query_execute)
Jan 17 17:35:59 pfdhcplistener(27722) ERROR: Database issue: We tried 3
times to serve query node_add_sql called from pf::node::node_add and we
failed. Is the database running? (pf::db::db_query_execute)
Jan 17 17:36:17 pfdhcplistener(27721) ERROR: Database issue: We tried 3
times to serve query node_add_sql called from pf::node::node_add and we
failed. Is the database running? (pf::db::db_query_execute)

I did not fine tune mysql database or modify default parameters.... Any
hint what is going on or where can I start checking?

Thank you and good weekend

------------------------------------------------------------------------------
CenturyLink Cloud: The Leader in Enterprise Cloud Services.
Learn Why More Businesses Are Choosing CenturyLink Cloud For
Critical Workloads, Development Environments & Everything In Between.
Get a Quote or Start a Free Trial Today.
http://pubads.g.doubleclick.net/gampad/clk?id=119420431&iu=/4140/ostg.clktrk
_______________________________________________
PacketFence-users mailing list
[email protected]
https://lists.sourceforge.net/lists/listinfo/packetfence-users
------------------------------------------------------------------------------
CenturyLink Cloud: The Leader in Enterprise Cloud Services.
Learn Why More Businesses Are Choosing CenturyLink Cloud For
Critical Workloads, Development Environments & Everything In Between.
Get a Quote or Start a Free Trial Today.
http://pubads.g.doubleclick.net/gampad/clk?id=119420431&iu=/4140/ostg.clktrk
_______________________________________________
PacketFence-users mailing list
[email protected]
https://lists.sourceforge.net/lists/listinfo/packetfence-users



------------------------------------------------------------------------------
CenturyLink Cloud: The Leader in Enterprise Cloud Services.
Learn Why More Businesses Are Choosing CenturyLink Cloud For
Critical Workloads, Development Environments & Everything In Between.
Get a Quote or Start a Free Trial Today.
http://pubads.g.doubleclick.net/gampad/clk?id=119420431&iu=/4140/ostg.clktrk


_______________________________________________
PacketFence-users mailing list
[email protected]
https://lists.sourceforge.net/lists/listinfo/packetfence-users


--
Fabrice Durand
[email protected]  ::  +1.514.447.4918 (x135) ::www.inverse.ca
Inverse inc. :: Leaders behind SOGo (http://www.sogo.nu) and PacketFence 
(http://packetfence.org)


------------------------------------------------------------------------------
CenturyLink Cloud: The Leader in Enterprise Cloud Services.
Learn Why More Businesses Are Choosing CenturyLink Cloud For
Critical Workloads, Development Environments & Everything In Between.
Get a Quote or Start a Free Trial Today.
http://pubads.g.doubleclick.net/gampad/clk?id=119420431&iu=/4140/ostg.clktrk


_______________________________________________
PacketFence-users mailing list
[email protected]
https://lists.sourceforge.net/lists/listinfo/packetfence-users

------------------------------------------------------------------------------
CenturyLink Cloud: The Leader in Enterprise Cloud Services.
Learn Why More Businesses Are Choosing CenturyLink Cloud For
Critical Workloads, Development Environments & Everything In Between.
Get a Quote or Start a Free Trial Today. 
http://pubads.g.doubleclick.net/gampad/clk?id=119420431&iu=/4140/ostg.clktrk
_______________________________________________
PacketFence-users mailing list
[email protected]
https://lists.sourceforge.net/lists/listinfo/packetfence-users

Reply via email to