Interpreting Log Output

Each line in the log file describes a significant event in the operation of a routing daemon. A time stamp indicates the date and time of the interaction. The remainder of the line is a string describing the event.

The log file begins with events in the routing daemon’s start sequence. First, it discovers its hardware and software operating environment:

TIB/Rendezvous daemon
Copyright 1994-2004 by Cloud Software Group, Inc.
All rights reserved.
Version 7.3.0
2004-09-08 14:03:13 rvrd: Hostname: optimist
2004-09-08 14:03:13 rvrd: Hostname IP address: 10.101.2.140
2004-09-08 14:03:13 rvrd: Detected IP interface: 127.0.0.1 (lo)
2004-09-08 14:03:13 rvrd: Detected IP interface: 10.101.2.140 (eth0)
2004-09-08 14:03:13 rvrd: Using ticket file /usr/local/tibco/bin/tibrv.tkt
2004-09-08 14:03:13 rvrd: Using store file /tmp/1.admin
2004-09-08 14:03:13 rvrd: Warning: zlib compression not supported in SSL initialization.
2004-09-08 14:03:13 rvrd: OpenSSL 0.9.7c 30 Sep 2003
2004-09-08 14:03:13 rvrd: Initializing random pool...
2004-09-08 14:03:13 rvrd: Invoking callback for case 2 and certificate 1.

Next, the routing daemon reads its configuration from its store file. In this example, it defines a router (routing table entry) named optimist. That router has an accept any neighbor interface, and a local network interface.

2004-09-08 14:03:13 rvrd: [optimist]: Defined.
2004-09-08 14:03:13 rvrd: [optimist]: Any neighbor is allowed to connect to local port 9666. Link cost: 1.
2004-09-08 14:03:13 rvrd: [optimist]: Local network 7505.RV.TIBCO defined. Interface: 10.101.2.140. Service UDP port: 7505, Service spec: 7505, Network spec: 10.101.2. Link cost: 1.

The routing daemon finishes its start sequence by reporting the URL bindings of its browser administration interfaces.

2004-09-08 14:03:13 rvrd: Http interface - http://optimist.rv.tibco.com:8000/

The administrator sets the logging parameters for normal activity.

2004-09-08 14:08:35 rvrd: Logging: [Connections - On], [Subject Interest - On], [Subject Data - On].

Now the routing daemon begins normal operations. Log items reflect neighbor connections to other routers (viggen-r1), exchange of subscription interest information, and forwarding of message data.

2004-09-08 14:13:26 rvrd: [optimist]: Connected to viggen-r1.
2004-09-08 14:15:40 rvrd: [optimist]: Sending subscription for [TEST] to viggen-r1 for source 0A65023F/hpux11-viggen-n1.
2004-09-08 14:16:30 rvrd: [optimist]: Received data on [TEST] from neighbor viggen-r1.
2004-09-08 14:18:03 rvrd: [optimist]: Sending cancel for [TEST] to viggen-r1 for source 0A65023F/hpux11-viggen-n1.
2004-09-08 14:19:31 rvrd: [optimist]: Disconnected from viggen-r1 (4).

Then optimist discovers another routing daemon (fanox) serving the same local network and service (redundancy for fault tolerance). Then it loses contact with fanox.

2004-09-08 14:23:16 rvrd: [optimist]: Found fanox in 7505.RV.TIBCO.
2004-09-08 14:24:24 rvrd: [optimist]: Lost fanox in 7505.RV.TIBCO.