use LOG for logging macro
[l2tpns.git] / cluster.c
index a8c9310..c5b7c8b 100644 (file)
--- a/cluster.c
+++ b/cluster.c
@@ -1,6 +1,6 @@
 // L2TPNS Clustering Stuff
 
-char const *cvs_id_cluster = "$Id: cluster.c,v 1.7 2004/07/07 09:09:53 bodea Exp $";
+char const *cvs_id_cluster = "$Id: cluster.c,v 1.16 2004/11/05 04:55:26 bodea Exp $";
 
 #include <stdio.h>
 #include <sys/file.h>
@@ -66,7 +66,6 @@ static struct {
        int     uptodate;
 } peers[CLUSTER_MAX_SIZE];     // List of all the peers we've heard from.
 static int num_peers;          // Number of peers in list.
-static int have_peers;         // At least one up to date peer
 
 int rle_decompress(u8 ** src_p, int ssize, u8 *dst, int dsize);
 int rle_compress(u8 ** src_p, int ssize, u8 *dst, int dsize);
@@ -78,65 +77,68 @@ int rle_compress(u8 ** src_p, int ssize, u8 *dst, int dsize);
 //
 int cluster_init()
 {
-    struct sockaddr_in addr;
-    struct sockaddr_in interface_addr;
-    struct ip_mreq mreq;
-    struct ifreq   ifr;
-    int opt = 0;
+       struct sockaddr_in addr;
+       struct sockaddr_in interface_addr;
+       struct ip_mreq mreq;
+       struct ifreq   ifr;
+       int opt = 0;
 
-    config->cluster_undefined_sessions = MAXSESSION-1;
-    config->cluster_undefined_tunnels = MAXTUNNEL-1;
+       config->cluster_undefined_sessions = MAXSESSION-1;
+       config->cluster_undefined_tunnels = MAXTUNNEL-1;
 
-    if (!config->cluster_address)
-       return 0;
-    if (!*config->cluster_interface)
-       return 0;
+       if (!config->cluster_address)
+               return 0;
+       if (!*config->cluster_interface)
+               return 0;
 
-    cluster_sockfd = socket(AF_INET, SOCK_DGRAM, IPPROTO_UDP);
+       cluster_sockfd = socket(AF_INET, SOCK_DGRAM, IPPROTO_UDP);
 
-    memset(&addr, 0, sizeof(addr));
-    addr.sin_family = AF_INET;
-    addr.sin_port = htons(CLUSTERPORT);
-    addr.sin_addr.s_addr = INADDR_ANY;
-    setsockopt(cluster_sockfd, SOL_SOCKET, SO_REUSEADDR, &addr, sizeof(addr));
+       memset(&addr, 0, sizeof(addr));
+       addr.sin_family = AF_INET;
+       addr.sin_port = htons(CLUSTERPORT);
+       addr.sin_addr.s_addr = INADDR_ANY;
+       setsockopt(cluster_sockfd, SOL_SOCKET, SO_REUSEADDR, &addr, sizeof(addr));
 
-    if (bind(cluster_sockfd, (void *) &addr, sizeof(addr)) < 0)
-    {
-       log(0, 0, 0, 0, "Failed to bind cluster socket: %s\n", strerror(errno));
-       return -1;
-    }
+       if (bind(cluster_sockfd, (void *) &addr, sizeof(addr)) < 0)
+       {
+               LOG(0, 0, 0, 0, "Failed to bind cluster socket: %s\n", strerror(errno));
+               return -1;
+       }
 
-    strcpy(ifr.ifr_name, config->cluster_interface);
-    if (ioctl(cluster_sockfd, SIOCGIFADDR, &ifr) < 0) {
-       log(0, 0, 0, 0, "Failed to get interface address for (%s): %s\n", config->cluster_interface, strerror(errno));
-       return -1;
-    }
+       strcpy(ifr.ifr_name, config->cluster_interface);
+       if (ioctl(cluster_sockfd, SIOCGIFADDR, &ifr) < 0)
+       {
+               LOG(0, 0, 0, 0, "Failed to get interface address for (%s): %s\n", config->cluster_interface, strerror(errno));
+               return -1;
+       }
 
-    memcpy(&interface_addr, &ifr.ifr_addr, sizeof(interface_addr) );
-    my_address = interface_addr.sin_addr.s_addr;
+       memcpy(&interface_addr, &ifr.ifr_addr, sizeof(interface_addr));
+       my_address = interface_addr.sin_addr.s_addr;
 
-               // Join multicast group.
-    mreq.imr_multiaddr.s_addr = config->cluster_address;
-    mreq.imr_interface = interface_addr.sin_addr;
+       // Join multicast group.
+       mreq.imr_multiaddr.s_addr = config->cluster_address;
+       mreq.imr_interface = interface_addr.sin_addr;
 
 
-    opt = 0;   // Turn off multicast loopback.
-    setsockopt(cluster_sockfd, IPPROTO_IP, IP_MULTICAST_LOOP, &opt, sizeof(opt));
+       opt = 0;        // Turn off multicast loopback.
+       setsockopt(cluster_sockfd, IPPROTO_IP, IP_MULTICAST_LOOP, &opt, sizeof(opt));
 
-    if (setsockopt(cluster_sockfd, IPPROTO_IP, IP_ADD_MEMBERSHIP, &mreq, sizeof(mreq)) < 0) {
-       log(0, 0, 0, 0, "Failed to setsockopt (join mcast group): %s\n", strerror(errno));
-       return -1;
-    }
+       if (setsockopt(cluster_sockfd, IPPROTO_IP, IP_ADD_MEMBERSHIP, &mreq, sizeof(mreq)) < 0)
+       {
+               LOG(0, 0, 0, 0, "Failed to setsockopt (join mcast group): %s\n", strerror(errno));
+               return -1;
+       }
 
-    if (setsockopt (cluster_sockfd, IPPROTO_IP, IP_MULTICAST_IF, &interface_addr, sizeof(interface_addr)) < 0) {
-       log(0, 0, 0, 0, "Failed to setsockopt (set mcast interface): %s\n", strerror(errno));
-       return -1;
-    }
+       if (setsockopt (cluster_sockfd, IPPROTO_IP, IP_MULTICAST_IF, &interface_addr, sizeof(interface_addr)) < 0)
+       {
+               LOG(0, 0, 0, 0, "Failed to setsockopt (set mcast interface): %s\n", strerror(errno));
+               return -1;
+       }
 
-    config->cluster_last_hb = TIME;
-    config->cluster_seq_number = -1;
+       config->cluster_last_hb = TIME;
+       config->cluster_seq_number = -1;
 
-    return cluster_sockfd;
+       return cluster_sockfd;
 }
 
 
@@ -147,24 +149,24 @@ int cluster_init()
 
 int cluster_send_data(void *data, int datalen)
 {
-    struct sockaddr_in addr = {0};
+       struct sockaddr_in addr = {0};
 
-    if (!cluster_sockfd) return -1;
-    if (!config->cluster_address) return 0;
+       if (!cluster_sockfd) return -1;
+       if (!config->cluster_address) return 0;
 
-    addr.sin_addr.s_addr = config->cluster_address;
-    addr.sin_port = htons(CLUSTERPORT);
-    addr.sin_family = AF_INET;
+       addr.sin_addr.s_addr = config->cluster_address;
+       addr.sin_port = htons(CLUSTERPORT);
+       addr.sin_family = AF_INET;
 
-    log(5,0,0,0, "Cluster send data: %d bytes\n", datalen);
+       LOG(5,0,0,0, "Cluster send data: %d bytes\n", datalen);
 
-    if (sendto(cluster_sockfd, data, datalen, MSG_NOSIGNAL, (void *) &addr, sizeof(addr)) < 0)
-    {
-       log(0, 0, 0, 0, "sendto: %s\n", strerror(errno));
-       return -1;
-    }
+       if (sendto(cluster_sockfd, data, datalen, MSG_NOSIGNAL, (void *) &addr, sizeof(addr)) < 0)
+       {
+               LOG(0, 0, 0, 0, "sendto: %s\n", strerror(errno));
+               return -1;
+       }
 
-    return 0;
+       return 0;
 }
 
 //
@@ -196,7 +198,7 @@ void cluster_uptodate(void)
 
        config->cluster_iam_uptodate = 1;
 
-       log(0,0,0,0, "Now uptodate with master.\n");
+       LOG(0,0,0,0, "Now uptodate with master.\n");
 
 #ifdef BGP
        if (bgp_configured)
@@ -213,27 +215,27 @@ void cluster_uptodate(void)
 //
 int peer_send_data(u32 peer, char * data, int size)
 {
-    struct sockaddr_in addr = {0};
+       struct sockaddr_in addr = {0};
 
-    if (!cluster_sockfd) return -1;
-    if (!config->cluster_address) return 0;
+       if (!cluster_sockfd) return -1;
+       if (!config->cluster_address) return 0;
 
-    if (!peer) // Odd??
-       return -1;
+       if (!peer)      // Odd??
+               return -1;
 
-    addr.sin_addr.s_addr = peer;
-    addr.sin_port = htons(CLUSTERPORT);
-    addr.sin_family = AF_INET;
+       addr.sin_addr.s_addr = peer;
+       addr.sin_port = htons(CLUSTERPORT);
+       addr.sin_family = AF_INET;
 
-    log_hex(5, "Peer send", data, size);
+       LOG_HEX(5, "Peer send", data, size);
 
-    if (sendto(cluster_sockfd, data, size, MSG_NOSIGNAL, (void *) &addr, sizeof(addr)) < 0)
-    {
-       log(0, 0, 0, 0, "sendto: %s\n", strerror(errno));
-       return -1;
-    }
+       if (sendto(cluster_sockfd, data, size, MSG_NOSIGNAL, (void *) &addr, sizeof(addr)) < 0)
+       {
+               LOG(0, 0, 0, 0, "sendto: %s\n", strerror(errno));
+               return -1;
+       }
 
-    return 0;
+       return 0;
 }
 
 //
@@ -244,7 +246,7 @@ int peer_send_message(u32 peer, int type, int more, char * data, int size)
        char buf[65536];        // Vast overkill.
        char * p = buf;
 
-       log(4,0,0,0, "Sending message to peer (type %d, more %d, size %d)\n", type, more, size);
+       LOG(4,0,0,0, "Sending message to peer (type %d, more %d, size %d)\n", type, more, size);
        add_type(&p, type, more, data, size);
 
        return peer_send_data(peer, buf, (p-buf) );
@@ -254,17 +256,17 @@ int peer_send_message(u32 peer, int type, int more, char * data, int size)
 // Forward a state changing packet to the master.
 //
 // The master just processes the payload as if it had
-// received it off the tap device.
+// received it off the tun device.
 //
-int master_forward_packet(char * data, int size, u32 addr, int port)
+int master_forward_packet(char *data, int size, u32 addr, int port)
 {
        char buf[65536];        // Vast overkill.
-       char * p = buf;
+       char *p = buf;
 
        if (!config->cluster_master_address) // No election has been held yet. Just skip it.
                return -1;
 
-       log(4,0,0,0,    "Forwarding packet from %s to master (size %d)\n", inet_toa(addr), size);
+       LOG(4,0,0,0,    "Forwarding packet from %s to master (size %d)\n", inet_toa(addr), size);
 
        STAT(c_forwarded);
        add_type(&p, C_FORWARD, addr, (char*) &port, sizeof(port) );
@@ -282,15 +284,15 @@ int master_forward_packet(char * data, int size, u32 addr, int port)
 // token bucket queue, and lets normal processing take care
 // of it.
 //
-int master_throttle_packet(int tbfid, char * data, int size)
+int master_throttle_packet(int tbfid, char *data, int size)
 {
        char buf[65536];        // Vast overkill.
-       char * p = buf;
+       char *p = buf;
 
        if (!config->cluster_master_address) // No election has been held yet. Just skip it.
                return -1;
 
-       log(4,0,0,0,    "Throttling packet master (size %d, tbfid %d)\n", size, tbfid);
+       LOG(4,0,0,0,    "Throttling packet master (size %d, tbfid %d)\n", size, tbfid);
 
        add_type(&p, C_THROTTLE, tbfid, data, size);
 
@@ -315,7 +317,7 @@ int master_garden_packet(sessionidt s, char *data, int size)
        if (!config->cluster_master_address) // No election has been held yet. Just skip it.
                return -1;
 
-       log(4,0,0,0,    "Walled garden packet to master (size %d)\n", size);
+       LOG(4,0,0,0,    "Walled garden packet to master (size %d)\n", size);
 
        add_type(&p, C_GARDEN, s, data, size);
 
@@ -329,25 +331,19 @@ int master_garden_packet(sessionidt s, char *data, int size)
 //
 static void send_heartbeat(int seq, char * data, int size)
 {
-    int i;
-    static int last_seq = -1;
-
-    if (last_seq != -1 && (seq != (last_seq+1)%HB_MAX_SEQ) ) {
-       log(0,0,0,0, "FATAL: Sequence number skipped! (%d != %d)\n",
-               seq, last_seq);
-    } 
-    last_seq = seq;
-
-    if (size > sizeof(past_hearts[0].data)) {
-       log(0,0,0,0, "Tried to heartbeat something larger than the maximum packet!\n");
-       kill(0, SIGTERM);
-       exit(1);
-    }
-    i = seq % HB_HISTORY_SIZE;
-    past_hearts[i].seq = seq;
-    past_hearts[i].size = size;
-    memcpy(&past_hearts[i].data, data, size);  // Save it.
-    cluster_send_data(data, size);
+       int i;
+
+       if (size > sizeof(past_hearts[0].data))
+       {
+               LOG(0,0,0,0, "Tried to heartbeat something larger than the maximum packet!\n");
+               kill(0, SIGTERM);
+               exit(1);
+       }
+       i = seq % HB_HISTORY_SIZE;
+       past_hearts[i].seq = seq;
+       past_hearts[i].size = size;
+       memcpy(&past_hearts[i].data, data, size);       // Save it.
+       cluster_send_data(data, size);
 }
 
 //
@@ -362,7 +358,7 @@ void cluster_send_ping(time_t basetime)
        if (config->cluster_iam_master && basetime)             // We're heartbeating so no need to ping.
                return;
 
-       log(5,0,0,0, "Sending cluster ping...\n");
+       LOG(5,0,0,0, "Sending cluster ping...\n");
 
        x.ver = 1;
        x.addr = config->bind_address;
@@ -375,12 +371,12 @@ void cluster_send_ping(time_t basetime)
 
 //
 // Walk the session counters looking for non-zero ones to send
-// to the master. We send up to 100 of them at one time.
-// We examine a maximum of 2000 sessions.
+// to the master. We send up to 600 of them at one time.
+// We examine a maximum of 3000 sessions.
 // (50k max session should mean that we normally
 // examine the entire session table every 25 seconds).
 
-#define MAX_B_RECS (400)
+#define MAX_B_RECS (600)
 void master_update_counts(void)
 {
        int i, c;
@@ -421,61 +417,95 @@ void master_update_counts(void)
 
 
                        // Forward the data to the master.
-       log(4,0,0,0, "Sending byte counters to master (%d elements)\n", c);
+       LOG(4,0,0,0, "Sending byte counters to master (%d elements)\n", c);
        peer_send_message(config->cluster_master_address, C_BYTES, c, (char*) &b, sizeof(b[0]) * c);
        return;
 }
 
+//
+// On the master, check how our slaves are going. If
+// one of them's not up-to-date we'll heartbeat faster.
+// If we don't have any of them, then we need to turn
+// on our own packet handling!
+//
+void cluster_check_slaves(void)
+{
+       int i;
+       static int have_peers = 0;
+       int had_peers = have_peers;
+       clockt t = TIME;
+
+       if (!config->cluster_iam_master)
+               return;         // Only runs on the master...
+
+       config->cluster_iam_uptodate = 1;       // cleared in loop below
+
+       for (i = have_peers = 0; i < num_peers; i++)
+       {
+               if ((peers[i].timestamp + config->cluster_hb_timeout) < t)
+                       continue;       // Stale peer! Skip them.
+
+               if (!peers[i].basetime)
+                       continue;       // Shutdown peer! Skip them.
+
+               if (peers[i].uptodate)
+                       have_peers = 1;
+
+               if (!peers[i].uptodate)
+                       config->cluster_iam_uptodate = 0; // Start fast heartbeats
+       }
+
+#ifdef BGP
+       // master lost all slaves, need to handle traffic ourself
+       if (bgp_configured && had_peers && !have_peers)
+               bgp_enable_routing(1);
+       else if (bgp_configured && !had_peers && have_peers)
+               bgp_enable_routing(0);
+#endif /* BGP */
+}
+
 //
 // Check that we have a master. If it's been too
 // long since we heard from a master then hold an election.
 //
 void cluster_check_master(void)
 {
-       int i, count, tcount, high_sid = 0;
+       int i, count, tcount, high_unique_id = 0;
        int last_free = 0;
-       int had_peers = have_peers;
        clockt t = TIME;
        static int probed = 0;
 
-       if (TIME < (config->cluster_last_hb + config->cluster_hb_timeout))
+       if (config->cluster_iam_master)
+               return;         // Only runs on the slaves...
+
+       // If the master is late (missed 2 hearbeats by a second and a
+       // hair) it may be that the switch has dropped us from the
+       // multicast group, try unicasting one probe to the master
+       // which will hopefully respond with a unicast heartbeat that
+       // will allow us to limp along until the querier next runs.
+       if (TIME > (config->cluster_last_hb + 2 * config->cluster_hb_interval + 11))
        {
-               // If the master is late (missed 2 hearbeats by a second and a
-               // hair) it may be that the switch has dropped us from the
-               // multicast group, try unicasting one probe to the master
-               // which will hopefully respond with a unicast heartbeat that
-               // will allow us to limp along until the querier next runs.
-               if (config->cluster_master_address
-                   && TIME > (config->cluster_last_hb + 2 * config->cluster_hb_interval + 11))
+               if (!probed && config->cluster_master_address)
                {
-                       if (!probed)
-                       {
-                               probed = 1;
-                               log(1, 0, 0, 0, "Heartbeat from master %.1fs late, probing...\n",
-                                   TIME - (config->cluster_last_hb + config->cluster_hb_interval));
-
-                               peer_send_message(config->cluster_master_address,
-                                   C_LASTSEEN, config->cluster_seq_number, NULL, 0);
-                       }
-               } else {        // We got a recent heartbeat; reset the probe flag.
-                       probed = 0;
-               }
+                       probed = 1;
+                       LOG(1, 0, 0, 0, "Heartbeat from master %.1fs late, probing...\n",
+                               0.1 * (TIME - (config->cluster_last_hb + config->cluster_hb_interval)));
 
-               if (!config->cluster_iam_master)
-                       return;         // Everything's ok. return.
-
-               // Master needs to check peer state
+                       peer_send_message(config->cluster_master_address,
+                               C_LASTSEEN, config->cluster_seq_number, NULL, 0);
+               }
+       } else {        // We got a recent heartbeat; reset the probe flag.
+               probed = 0;
        }
 
-       config->cluster_last_hb = TIME + 1;
+       if (TIME < (config->cluster_last_hb + config->cluster_hb_timeout))
+               return; // Everything's ok!
 
-       if (config->cluster_iam_master)
-               config->cluster_iam_uptodate = 1;       // cleared in loop below
-       else
-               log(0,0,0,0, "Master timed out! Holding election...\n");
+       config->cluster_last_hb = TIME + 1;     // Just the one election thanks.
 
+       LOG(0,0,0,0, "Master timed out! Holding election...\n");
 
-       for (i = have_peers = 0; i < num_peers; i++)
+       for (i = 0; i < num_peers; i++)
        {
                if ((peers[i].timestamp + config->cluster_hb_timeout) < t)
                        continue;       // Stale peer! Skip them.
@@ -483,39 +513,18 @@ void cluster_check_master(void)
                if (!peers[i].basetime)
                        continue;       // Shutdown peer! Skip them.
 
-               if (peers[i].uptodate)
-                       have_peers = 1;
-
-               if (config->cluster_iam_master)
-               {
-                       if (!peers[i].uptodate)
-                               config->cluster_iam_uptodate = 0; // Start fast heartbeats
-
-                       continue;
-               }
-
                if (peers[i].basetime < basetime) {
-                       log(1,0,0,0, "Expecting %s to become master\n", inet_toa(peers[i].peer) );
+                       LOG(1,0,0,0, "Expecting %s to become master\n", inet_toa(peers[i].peer) );
                        return;         // They'll win the election. Get out of here.
                }
 
                if (peers[i].basetime == basetime &&
                        peers[i].peer > my_address) {
-                       log(1,0,0,0, "Expecting %s to become master\n", inet_toa(peers[i].peer) );
+                       LOG(1,0,0,0, "Expecting %s to become master\n", inet_toa(peers[i].peer) );
                        return;         // They'll win the election. Wait for them to come up.
                }
        }
 
-       if (config->cluster_iam_master)         // If we're the master, we've already won
-       {
-#ifdef BGP
-               // master lost all slaves, need to handle traffic ourself
-               if (bgp_configured && had_peers && !have_peers)
-                       bgp_enable_routing(1);
-#endif /* BGP */
-               return;
-       }
-
                // Wow. it's been ages since I last heard a heartbeat
                // and I'm better than an of my peers so it's time
                // to become a master!!!
@@ -523,12 +532,7 @@ void cluster_check_master(void)
        config->cluster_iam_master = 1;
        config->cluster_master_address = 0;
 
-       log(0,0,0,0, "I am declaring myself the master!\n");
-
-#ifdef BGP
-       if (bgp_configured && have_peers)
-               bgp_enable_routing(0); /* stop handling traffic */
-#endif /* BGP */
+       LOG(0,0,0,0, "I am declaring myself the master!\n");
 
        if (config->cluster_seq_number == -1)
                config->cluster_seq_number = 0;
@@ -553,7 +557,7 @@ void cluster_check_master(void)
                // Re-string the free list.
                // Find the ID of the highest session.
        last_free = 0;
-       high_sid = 0;
+       high_unique_id = 0;
        config->cluster_highest_sessionid = 0;
        for (i = 0, count = 0; i < MAXSESSION; ++i) {
                if (session[i].tunnel == T_UNDEF) {
@@ -580,26 +584,19 @@ void cluster_check_master(void)
 
                session[i].radius = 0;  // Reset authentication as the radius blocks aren't up to date.
 
-               if (session[i].sid >= high_sid) // This is different to the index into the session table!!!
-                       high_sid = session[i].sid+1;
+               if (session[i].unique_id >= high_unique_id)     // This is different to the index into the session table!!!
+                       high_unique_id = session[i].unique_id+1;
 
 
                session[i].tbf_in = session[i].tbf_out = 0; // Remove stale pointers from old master.
-               throttle_session(i, session[i].throttle);
-
-// I'm unsure about this. --mo
-// It's potentially a good thing, but it could send a
-// LOT of packets.
-//             if (session[i].throttle)
-//                     cluster_send_session(s);        // Tell the slaves about the new tbf indexes.
+               throttle_session(i, session[i].throttle_in, session[i].throttle_out);
 
                if (session[i].tunnel != T_FREE && i > config->cluster_highest_sessionid)
                        config->cluster_highest_sessionid = i;
-
        }
 
        session[last_free].next = 0;    // End of chain.
-       last_sid = high_sid;            // Keep track of the highest used session ID.
+       last_id = high_unique_id;               // Keep track of the highest used session ID.
 
        become_master();
 
@@ -607,11 +604,11 @@ void cluster_check_master(void)
 
                // If we're not the very first master, this is a big issue!
        if(count>0)
-               log(0,0,0,0, "Warning: Fixed %d uninitialized sessions in becoming master!\n", count);
+               LOG(0,0,0,0, "Warning: Fixed %d uninitialized sessions in becoming master!\n", count);
 
        config->cluster_undefined_sessions = 0;
        config->cluster_undefined_tunnels = 0;
-       config->cluster_iam_uptodate = 1; // assume all peers are up-to-date
+       config->cluster_iam_uptodate = 1; // assume all peers are up-to-date
 
        // FIXME. We need to fix up the tunnel control message
        // queue here! There's a number of other variables we
@@ -667,7 +664,7 @@ static void cluster_check_sessions(int highsession, int freesession_ptr, int hig
 
 
        if (config->cluster_undefined_sessions || config->cluster_undefined_tunnels) {
-               log(2,0,0,0, "Cleared undefined sessions/tunnels. %d sess (high %d), %d tunn (high %d)\n",
+               LOG(2,0,0,0, "Cleared undefined sessions/tunnels. %d sess (high %d), %d tunn (high %d)\n",
                        config->cluster_undefined_sessions, highsession, config->cluster_undefined_tunnels, hightunnel);
                return;
        }
@@ -721,7 +718,7 @@ int hb_add_type(char **p, int type, int id)
                        (char*) &tunnel[id], sizeof(tunnelt));
                        break;
                default:
-                       log(0,0,0,0, "Found an invalid type in heart queue! (%d)\n", type);
+                       LOG(0,0,0,0, "Found an invalid type in heart queue! (%d)\n", type);
                        kill(0, SIGTERM);
                        exit(1);
        }
@@ -764,7 +761,7 @@ void cluster_heartbeat()
        }
 
        if (p > (buff + sizeof(buff))) {        // Did we somehow manage to overun the buffer?
-               log(0,0,0,0, "FATAL: Overran the heartbeat buffer! This is fatal. Exiting. (size %d)\n", p - buff);
+               LOG(0,0,0,0, "FATAL: Overran the heartbeat buffer! This is fatal. Exiting. (size %d)\n", p - buff);
                kill(0, SIGTERM);
                exit(1);
        }
@@ -809,12 +806,12 @@ void cluster_heartbeat()
                //
                // Did we do something wrong?
        if (p > (buff + sizeof(buff))) {        // Did we somehow manage to overun the buffer?
-               log(0,0,0,0, "Overran the heartbeat buffer now! This is fatal. Exiting. (size %d)\n", p - buff);
+               LOG(0,0,0,0, "Overran the heartbeat buffer now! This is fatal. Exiting. (size %d)\n", p - buff);
                kill(0, SIGTERM);
                exit(1);
        }
 
-       log(3,0,0,0, "Sending heartbeat #%d with %d changes (%d x-sess, %d x-tunnels, %d highsess, %d hightun size %d)\n",
+       LOG(3,0,0,0, "Sending heartbeat #%d with %d changes (%d x-sess, %d x-tunnels, %d highsess, %d hightun, size %d)\n",
                        h.seq, config->cluster_num_changes, count, tcount, config->cluster_highest_sessionid,
                        config->cluster_highest_tunnelid, (p-buff));
 
@@ -852,7 +849,7 @@ int type_changed(int type, int id)
 int cluster_send_session(int sid)
 {
        if (!config->cluster_iam_master) {
-               log(0,0,sid,0, "I'm not a master, but I just tried to change a session!\n");
+               LOG(0,0,sid,0, "I'm not a master, but I just tried to change a session!\n");
                return -1;
        }
 
@@ -863,7 +860,7 @@ int cluster_send_session(int sid)
 int cluster_send_tunnel(int tid)
 {
        if (!config->cluster_iam_master) {
-               log(0,0,0,tid, "I'm not a master, but I just tried to change a tunnel!\n");
+               LOG(0,0,0,tid, "I'm not a master, but I just tried to change a tunnel!\n");
                return -1;
        }
 
@@ -881,14 +878,14 @@ int cluster_catchup_slave(int seq, u32 slave)
        int s;
        int diff;
 
-       log(1,0,0,0, "Slave %s sent LASTSEEN with seq %d\n", inet_toa(slave), seq);
+       LOG(1,0,0,0, "Slave %s sent LASTSEEN with seq %d\n", inet_toa(slave), seq);
 
        diff = config->cluster_seq_number - seq;        // How many packet do we need to send?
        if (diff < 0)
                diff += HB_MAX_SEQ;
 
        if (diff >= HB_HISTORY_SIZE) {  // Ouch. We don't have the packet to send it!
-               log(0,0,0,0, "A slaved asked for message %d when our seq number is %d. Killing it.\n",
+               LOG(0,0,0,0, "A slaved asked for message %d when our seq number is %d. Killing it.\n",
                        seq, config->cluster_seq_number);
                return peer_send_message(slave, C_KILL, seq, NULL, 0);// Kill the slave. Nothing else to do.
        }
@@ -897,13 +894,8 @@ int cluster_catchup_slave(int seq, u32 slave)
        while (seq != config->cluster_seq_number) {
                s = seq%HB_HISTORY_SIZE;
                if (seq != past_hearts[s].seq) {
-                       int i;
-                       log(0,0,0,0, "Tried to re-send heartbeat for %s but %d doesn't match %d! (%d,%d)\n",
+                       LOG(0,0,0,0, "Tried to re-send heartbeat for %s but %d doesn't match %d! (%d,%d)\n",
                                inet_toa(slave), seq, past_hearts[s].seq, s, config->cluster_seq_number);
-
-                       for (i = 0; i < HB_HISTORY_SIZE; ++i) {
-                               log(0,0,0,0, "\tentry %3d: seq %d (size %d)\n", i, past_hearts[s].seq, past_hearts[s].size);
-                       }
                        return -1;      // What to do here!?
                }
                peer_send_data(slave, past_hearts[s].data, past_hearts[s].size);
@@ -916,16 +908,27 @@ int cluster_catchup_slave(int seq, u32 slave)
 // We've heard from another peer! Add it to the list
 // that we select from at election time.
 //
-int cluster_add_peer(u32 peer, time_t basetime, pingt *p)
+int cluster_add_peer(u32 peer, time_t basetime, pingt *pp, int size)
 {
        int i;
        u32 clusterid;
+       pingt p;
+
+       // Allow for backward compatability.
+       // Just the ping packet into a new structure to allow
+       // for the possibility that we might have received
+       // more or fewer elements than we were expecting.
+       if (size > sizeof(p))
+               size = sizeof(p);
 
-       clusterid = p->addr;
+       memset( (void*) &p, 0, sizeof(p) );
+       memcpy( (void*) &p, (void*) pp, size);
+
+       clusterid = p.addr;
        if (clusterid != config->bind_address)
        {
                // Is this for us?
-               log(4,0,0,0, "Skipping ping from %s (different cluster)\n", inet_toa(peer));
+               LOG(4,0,0,0, "Skipping ping from %s (different cluster)\n", inet_toa(peer));
                return 0;
        }
 
@@ -937,12 +940,13 @@ int cluster_add_peer(u32 peer, time_t basetime, pingt *p)
                // This peer already exists. Just update the timestamp.
                peers[i].basetime = basetime;
                peers[i].timestamp = TIME;
-               peers[i].uptodate = !p->undef;
+               peers[i].uptodate = !p.undef;
                break;
        }
 
-               // Is this the master shutting down??
+       // Is this the master shutting down??
        if (peer == config->cluster_master_address && !basetime) {
+               LOG(3,0,0,0, "Master %s shutting down...\n", inet_toa(config->cluster_master_address));
                config->cluster_master_address = 0;
                config->cluster_last_hb = 0; // Force an election.
                cluster_check_master();
@@ -951,7 +955,7 @@ int cluster_add_peer(u32 peer, time_t basetime, pingt *p)
 
        if (i >= num_peers)
        {
-               log(4,0,0,0, "Adding %s as a peer\n", inet_toa(peer));
+               LOG(4,0,0,0, "Adding %s as a peer\n", inet_toa(peer));
 
                // Not found. Is there a stale slot to re-use?
                for (i = 0; i < num_peers ; ++i)
@@ -966,34 +970,19 @@ int cluster_add_peer(u32 peer, time_t basetime, pingt *p)
                if (i >= CLUSTER_MAX_SIZE)
                {
                        // Too many peers!!
-                       log(0,0,0,0, "Tried to add %s as a peer, but I already have %d of them!\n", inet_toa(peer), i);
+                       LOG(0,0,0,0, "Tried to add %s as a peer, but I already have %d of them!\n", inet_toa(peer), i);
                        return -1;
                }
 
                peers[i].peer = peer;
                peers[i].basetime = basetime;
                peers[i].timestamp = TIME;
-               peers[i].uptodate = !p->undef;
+               peers[i].uptodate = !p.undef;
                if (i == num_peers)
                        ++num_peers;
 
-               log(1,0,0,0, "Added %s as a new peer. Now %d peers\n", inet_toa(peer), num_peers);
-       }
-
-       if (peers[i].uptodate)
-       {
-#ifdef BGP
-               /* drop routes if we've now got a peer */
-               if (config->cluster_iam_master && bgp_configured && !have_peers)
-                       bgp_enable_routing(0);
-#endif /* BGP */
-               have_peers = 1;
+               LOG(1,0,0,0, "Added %s as a new peer. Now %d peers\n", inet_toa(peer), num_peers);
        }
-       else if (config->cluster_iam_master)
-       {
-               config->cluster_iam_uptodate = 0; // increase heart-rate...
-       }
-
 
        return 1;
 }
@@ -1009,14 +998,14 @@ int cluster_handle_bytes(char * data, int size)
 
        b = (bytest*) data;
 
-       log(3,0,0,0, "Got byte counter update (size %d)\n", size);
+       LOG(3,0,0,0, "Got byte counter update (size %d)\n", size);
 
                                /* Loop around, adding the byte
                                counts to each of the sessions. */
 
        while (size >= sizeof(*b) ) {
                if (b->sid > MAXSESSION) {
-                       log(0,0,0,0, "Got C_BYTES with session #%d!\n", b->sid);
+                       LOG(0,0,0,0, "Got C_BYTES with session #%d!\n", b->sid);
                        return -1; /* Abort processing */
                }
 
@@ -1032,7 +1021,7 @@ int cluster_handle_bytes(char * data, int size)
        }
 
        if (size != 0)
-               log(0,0,0,0, "Got C_BYTES with %d bytes of trailing junk!\n", size);
+               LOG(0,0,0,0, "Got C_BYTES with %d bytes of trailing junk!\n", size);
 
        return size;
 }
@@ -1043,13 +1032,13 @@ int cluster_handle_bytes(char * data, int size)
 static int cluster_recv_session(int more , u8 * p)
 {
        if (more >= MAXSESSION) {
-               log(0,0,0,0, "DANGER: Received a heartbeat session id > MAXSESSION!\n");
+               LOG(0,0,0,0, "DANGER: Received a heartbeat session id > MAXSESSION!\n");
                return -1;
        }
 
        if (session[more].tunnel == T_UNDEF) {
                if (config->cluster_iam_uptodate) { // Sanity.
-                       log(0,0,0,0, "I thought I was uptodate but I just found an undefined session!\n");
+                       LOG(0,0,0,0, "I thought I was uptodate but I just found an undefined session!\n");
                } else {
                        --config->cluster_undefined_sessions;
                }
@@ -1057,7 +1046,7 @@ static int cluster_recv_session(int more , u8 * p)
 
        load_session(more, (sessiont*) p);      // Copy session into session table..
 
-       log(5,0,more,0, "Received session update (%d undef)\n", config->cluster_undefined_sessions);
+       LOG(5,0,more,0, "Received session update (%d undef)\n", config->cluster_undefined_sessions);
 
        if (!config->cluster_iam_uptodate)
                cluster_uptodate();     // Check to see if we're up to date.
@@ -1068,13 +1057,13 @@ static int cluster_recv_session(int more , u8 * p)
 static int cluster_recv_tunnel(int more, u8 *p)
 {
        if (more >= MAXTUNNEL) {
-               log(0,0,0,0, "DANGER: Received a tunnel session id > MAXTUNNEL!\n");
+               LOG(0,0,0,0, "DANGER: Received a tunnel session id > MAXTUNNEL!\n");
                return -1;
        }
 
        if (tunnel[more].state == TUNNELUNDEF) {
                if (config->cluster_iam_uptodate) { // Sanity.
-                       log(0,0,0,0, "I thought I was uptodate but I just found an undefined tunnel!\n");
+                       LOG(0,0,0,0, "I thought I was uptodate but I just found an undefined tunnel!\n");
                } else {
                        --config->cluster_undefined_tunnels;
                }
@@ -1089,7 +1078,7 @@ static int cluster_recv_tunnel(int more, u8 *p)
        tunnel[more].controls = tunnel[more].controle = NULL;
        tunnel[more].controlc = 0;
 
-       log(5,0,0,more, "Received tunnel update\n");
+       LOG(5,0,0,more, "Received tunnel update\n");
 
        if (!config->cluster_iam_uptodate)
                cluster_uptodate();     // Check to see if we're up to date.
@@ -1113,7 +1102,7 @@ static int cluster_process_heartbeat(u8 * data, int size, int more, u8 * p, u32
 
        // we handle version 2+
        if (more < 2 || more > HB_VERSION) {
-               log(0,0,0,0, "Received a heartbeat version that I don't support (%d)!\n", more);
+               LOG(0,0,0,0, "Received a heartbeat version that I don't support (%d)!\n", more);
                return -1; // Ignore it??
        }
 
@@ -1131,18 +1120,18 @@ static int cluster_process_heartbeat(u8 * data, int size, int more, u8 * p, u32
        if (config->cluster_iam_master) {       // Sanity...
                                // Note that this MUST match the election process above!
 
-               log(0,0,0,0, "I just got a packet claiming to be from a master but _I_ am the master!\n");
+               LOG(0,0,0,0, "I just got a packet claiming to be from a master but _I_ am the master!\n");
                if (!h->basetime) {
-                       log(0,0,0,0, "Heartbeat from addr %s with zero basetime!\n", inet_toa(addr) );
+                       LOG(0,0,0,0, "Heartbeat from addr %s with zero basetime!\n", inet_toa(addr) );
                        return -1; // Skip it.
                }
                if (basetime > h->basetime) {
-                       log(0,0,0,0, "They're (%s) an older master than me so I'm gone!\n", inet_toa(addr));
+                       LOG(0,0,0,0, "They're (%s) an older master than me so I'm gone!\n", inet_toa(addr));
                        kill(0, SIGTERM);
                        exit(1);
                }
                if (basetime == h->basetime && my_address < addr) { // Tie breaker.
-                       log(0,0,0,0, "They're a higher IP address than me, so I'm gone!\n");
+                       LOG(0,0,0,0, "They're a higher IP address than me, so I'm gone!\n");
                        kill(0, SIGTERM);
                        exit(1);
                }
@@ -1155,7 +1144,7 @@ static int cluster_process_heartbeat(u8 * data, int size, int more, u8 * p, u32
        config->cluster_last_hb = TIME; // Reset to ensure that we don't become master!!
 
        if (config->cluster_seq_number != h->seq) {     // Out of sequence heartbeat!
-               log(1,0,0,0, "HB: Got seq# %d but was expecting %d. asking for resend.\n", h->seq, config->cluster_seq_number);
+               LOG(1,0,0,0, "HB: Got seq# %d but was expecting %d. asking for resend.\n", h->seq, config->cluster_seq_number);
 
                peer_send_message(addr, C_LASTSEEN, config->cluster_seq_number, NULL, 0);
 
@@ -1182,18 +1171,18 @@ static int cluster_process_heartbeat(u8 * data, int size, int more, u8 * p, u32
        {
                if (h->interval != config->cluster_hb_interval)
                {
-                       log(2, 0, 0, 0, "Master set ping/heartbeat interval to %u (was %u)\n",
-                           h->interval, config->cluster_hb_interval);
+                       LOG(2, 0, 0, 0, "Master set ping/heartbeat interval to %u (was %u)\n",
+                               h->interval, config->cluster_hb_interval);
 
-                       config->cluster_hb_interval = h->interval;
+                       config->cluster_hb_interval = h->interval;
                }
 
                if (h->timeout != config->cluster_hb_timeout)
                {
-                       log(2, 0, 0, 0, "Master set heartbeat timeout to %u (was %u)\n",
-                           h->timeout, config->cluster_hb_timeout);
+                       LOG(2, 0, 0, 0, "Master set heartbeat timeout to %u (was %u)\n",
+                               h->timeout, config->cluster_hb_timeout);
 
-                       config->cluster_hb_timeout = h->timeout;
+                       config->cluster_hb_timeout = h->timeout;
                }
        }
 
@@ -1218,7 +1207,7 @@ static int cluster_process_heartbeat(u8 * data, int size, int more, u8 * p, u32
                                s -= (p - orig_p);
 
                                if (size != sizeof(sessiont) ) { // Ouch! Very very bad!
-                                       log(0,0,0,0, "DANGER: Received a CSESSION that didn't decompress correctly!\n");
+                                       LOG(0,0,0,0, "DANGER: Received a CSESSION that didn't decompress correctly!\n");
                                                // Now what? Should exit! No-longer up to date!
                                        break;
                                }
@@ -1245,7 +1234,7 @@ static int cluster_process_heartbeat(u8 * data, int size, int more, u8 * p, u32
                                s -= (p - orig_p);
 
                                if (size != sizeof(tunnelt) ) { // Ouch! Very very bad!
-                                       log(0,0,0,0, "DANGER: Received a CSESSION that didn't decompress correctly!\n");
+                                       LOG(0,0,0,0, "DANGER: Received a CSESSION that didn't decompress correctly!\n");
                                                // Now what? Should exit! No-longer up to date!
                                        break;
                                }
@@ -1264,7 +1253,7 @@ static int cluster_process_heartbeat(u8 * data, int size, int more, u8 * p, u32
                                s -= sizeof(tunnel[more]);
                                break;
                        default:
-                               log(0,0,0,0, "DANGER: I received a heartbeat element where I didn't understand the type! (%d)\n", type);
+                               LOG(0,0,0,0, "DANGER: I received a heartbeat element where I didn't understand the type! (%d)\n", type);
                                return -1; // can't process any more of the packet!!
                }
        }
@@ -1272,7 +1261,7 @@ static int cluster_process_heartbeat(u8 * data, int size, int more, u8 * p, u32
        {
                char *str;
                str = strdup(inet_toa(config->cluster_master_address));
-               log(0,0,0,0, "My master just changed from %s to %s!\n", str, inet_toa(addr));
+               LOG(0,0,0,0, "My master just changed from %s to %s!\n", str, inet_toa(addr));
                if (str) free(str);
        }
 
@@ -1281,7 +1270,7 @@ static int cluster_process_heartbeat(u8 * data, int size, int more, u8 * p, u32
        return 0;
 
 shortpacket:
-       log(0,0,0,0, "I got an incomplete heartbeat packet! This means I'm probably out of sync!!\n");
+       LOG(0,0,0,0, "I got an incomplete heartbeat packet! This means I'm probably out of sync!!\n");
        return -1;
 }
 
@@ -1298,7 +1287,7 @@ int processcluster(char * data, int size, u32 addr)
        if (addr == my_address)
                return -1;      // Ignore it. Something looped back the multicast!
 
-       log(5,0,0,0, "Process cluster: %d bytes from %s\n", size, inet_toa(addr));
+       LOG(5,0,0,0, "Process cluster: %d bytes from %s\n", size, inet_toa(addr));
 
        if (s <= 0)     // Any data there??
                return -1;
@@ -1316,7 +1305,7 @@ int processcluster(char * data, int size, u32 addr)
 
        switch (type) {
        case C_PING:    // Update the peers table.
-               return cluster_add_peer(addr, more, (pingt*)p);
+               return cluster_add_peer(addr, more, (pingt*)p, s);
 
        case C_LASTSEEN:        // Catch up a slave (slave missed a packet).
                return cluster_catchup_slave(more, addr);
@@ -1330,18 +1319,18 @@ int processcluster(char * data, int size, u32 addr)
                p += sizeof(int);
 
                if (!config->cluster_iam_master) { // huh?
-                       log(0,0,0,0, "I'm not the master, but I got a C_FORWARD from %s?\n", inet_toa(addr));
+                       LOG(0,0,0,0, "I'm not the master, but I got a C_FORWARD from %s?\n", inet_toa(addr));
                        return -1;
                }
 
-               log(4,0,0,0, "Got a forwarded packet... (%s:%d)\n", inet_toa(more), a.sin_port);
+               LOG(4,0,0,0, "Got a forwarded packet... (%s:%d)\n", inet_toa(more), a.sin_port);
                STAT(recv_forward);
                processudp(p, s, &a);
                return 0;
        }
        case C_THROTTLE: {      // Receive a forwarded packet from a slave.
                if (!config->cluster_iam_master) {
-                       log(0,0,0,0, "I'm not the master, but I got a C_THROTTLE from %s?\n", inet_toa(addr));
+                       LOG(0,0,0,0, "I'm not the master, but I got a C_THROTTLE from %s?\n", inet_toa(addr));
                        return -1;
                }
 
@@ -1351,7 +1340,7 @@ int processcluster(char * data, int size, u32 addr)
        case C_GARDEN:
                // Receive a walled garden packet from a slave.
                if (!config->cluster_iam_master) {
-                       log(0,0,0,0, "I'm not the master, but I got a C_GARDEN from %s?\n", inet_toa(addr));
+                       LOG(0,0,0,0, "I'm not the master, but I got a C_GARDEN from %s?\n", inet_toa(addr));
                        return -1;
                }
 
@@ -1363,37 +1352,37 @@ int processcluster(char * data, int size, u32 addr)
 
        case C_KILL:    // The master asked us to die!? (usually because we're too out of date).
                if (config->cluster_iam_master) {
-                       log(0,0,0,0, "_I_ am master, but I received a C_KILL from %s! (Seq# %d)\n", inet_toa(addr), more);
+                       LOG(0,0,0,0, "_I_ am master, but I received a C_KILL from %s! (Seq# %d)\n", inet_toa(addr), more);
                        return -1;
                }
                if (more != config->cluster_seq_number) {
-                       log(0,0,0,0, "The master asked us to die but the seq number didn't match!?\n");
+                       LOG(0,0,0,0, "The master asked us to die but the seq number didn't match!?\n");
                        return -1;
                }
 
                if (addr != config->cluster_master_address) {
-                       log(0,0,0,0, "Received a C_KILL from %s which doesn't match config->cluster_master_address (%x)\n",
+                       LOG(0,0,0,0, "Received a C_KILL from %s which doesn't match config->cluster_master_address (%x)\n",
                                inet_toa(addr), config->cluster_master_address);
                        // We can only warn about it. The master might really have switched!
                }
 
-               log(0,0,0,0, "Received a valid C_KILL: I'm going to die now.\n");
+               LOG(0,0,0,0, "Received a valid C_KILL: I'm going to die now.\n");
                kill(0, SIGTERM);
                exit(0);        // Lets be paranoid;
                return -1;              // Just signalling the compiler.
 
        case C_HEARTBEAT:
-               log(4,0,0,0, "Got a heartbeat from %s\n", inet_toa(addr));
+               LOG(4,0,0,0, "Got a heartbeat from %s\n", inet_toa(addr));
                return cluster_process_heartbeat(data, size, more, p, addr);
 
        default:
-               log(0,0,0,0, "Strange type packet received on cluster socket (%d)\n", type);
+               LOG(0,0,0,0, "Strange type packet received on cluster socket (%d)\n", type);
                return -1;
        }
        return 0;
 
 shortpacket:
-       log(0,0,0,0, "I got an cluster heartbeat packet! This means I'm probably out of sync!!\n");
+       LOG(0,0,0,0, "I got a _short_ cluster heartbeat packet! This means I'm probably out of sync!!\n");
        return -1;
 }
 
@@ -1406,17 +1395,17 @@ int cmd_show_cluster(struct cli_def *cli, char *command, char **argv, int argc)
        if (CLI_HELP_REQUESTED)
                return CLI_HELP_NO_ARGS;
 
-        cli_print(cli, "Cluster status   : %s", config->cluster_iam_master ? "Master" : "Slave" );
+       cli_print(cli, "Cluster status   : %s", config->cluster_iam_master ? "Master" : "Slave" );
        cli_print(cli, "My address       : %s", inet_toa(my_address));
        cli_print(cli, "VIP address      : %s", inet_toa(config->bind_address));
        cli_print(cli, "Multicast address: %s", inet_toa(config->cluster_address));
        cli_print(cli, "Multicast i'face : %s", config->cluster_interface);
 
-        if (!config->cluster_iam_master) {
+       if (!config->cluster_iam_master) {
                cli_print(cli, "My master        : %s (last heartbeat %.1f seconds old)",
                        config->cluster_master_address ? inet_toa(config->cluster_master_address) : "Not defined",
                        0.1 * (TIME - config->cluster_last_hb));
-                cli_print(cli, "Uptodate         : %s", config->cluster_iam_uptodate ? "Yes" : "No");
+               cli_print(cli, "Uptodate         : %s", config->cluster_iam_uptodate ? "Yes" : "No");
                cli_print(cli, "Next sequence number expected: %d", config->cluster_seq_number);
                cli_print(cli, "%d sessions undefined of %d", config->cluster_undefined_sessions, config->cluster_highest_sessionid);
                cli_print(cli, "%d tunnels undefined of %d", config->cluster_undefined_tunnels, config->cluster_highest_tunnelid);