[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]

[xmlblaster] support for multiple mime-plugins broken



I've been trying to get multiple mime plugins in a slave node to
work. I can get the plugins working fine in isolation, both
PublishLenChecker and PublishRateLimiter work. However, after
specifying both in a xmlblaster.properties file via

MimePublishPlugin[PublishRateLimiter][1.0]=com.bbn.quo.foo.PublishRateLimiter,MAX_RATE_MPH=30
MimePublishPlugin[PublishLenChecker][1.0]=com.bbn.quo.foo.PublishLenChecker,DEFAULT_MAX_LEN=46000

both plugins seem to be getting initialized (even with the correct
variables), but only PublishLenChecker seems to be getting its intercept() method
called.

How can I activate both plugins at the same time ?

Here is a trace:

Script started on Fri Feb 14 11:02:57 2003
matighet at coconut > ]0;~/matighettomato/quo/foo/xmlblasterDjmProxy1
Property: Loading xmlBlaster.properties from CLASSPATH file:/mnt/quo2/3rdparty/foo/xmlBlaster/lib/xmlBlaster.jar!/xmlBlaster.properties
Property: No args array given.
Property: Loading /home/matighet/matighettomato/quo/foo/xmlblaster/djmproxy1.xmlblaster.properties from directory /mnt/quo2/3rdparty/foo/xmlBlaster
Property: Added 4 property pairs
[Feb 14, 2003 11:03:04 AM CALL  RunlevelManager-/node/djmproxy1] Incarnated run level manager #1
[Feb 14, 2003 11:03:05 AM INFO  Global] Setting xmlBlaster instance name (-cluster.node.id) to 'djmproxy1'
[Feb 14, 2003 11:03:06 AM INFO  SimpleSecuritySubject] Access for __RequestBroker_internal[djmproxy1] granted, without further checks.
[Feb 14, 2003 11:03:06 AM CALL  QueuePluginManager-/node/djmproxy1] Constructor QueuePluginManager
[Feb 14, 2003 11:03:07 AM INFO  SessionInfo-/node/djmproxy1/client/__RequestBroker_internal[djmproxy1]] Session lasts forever, requested expiry timer was 0
[Feb 14, 2003 11:03:07 AM TRACE Global-/node/djmproxy1] New log channel 'mime' ready: ERROR | WARN | INFO | CALL | TRACE
[Feb 14, 2003 11:03:08 AM CALL  RunlevelManager-/node/djmproxy1] Initialized run level manager #1
[Feb 14, 2003 11:03:08 AM CALL  RunlevelManager-/node/djmproxy1] Changing from run level 0 to run level 9 with force=false
[Feb 14, 2003 11:03:08 AM INFO  RunlevelManager-/node/djmproxy1] Change request from run level HALTED to run level RUNNING ...
[Feb 14, 2003 11:03:08 AM CALL  RequestBroker-/node/djmproxy1] Entering startupTopicStore(), looking for persisted topics
[Feb 14, 2003 11:03:08 AM WARN  RequestBroker-/node/djmproxy1] Persistent and recoverable topics are switched of with '-useTopicStore false', topics are handled RAM based only.
[Feb 14, 2003 11:03:08 AM INFO  PublishLenChecker] Setting DEFAULT_MAX_LEN=46000 as configured in xmlBlaster.properties
[Feb 14, 2003 11:03:08 AM INFO  PublishLenChecker] Filter is initialized, we check all mime types if content is not too long
[Feb 14, 2003 11:03:08 AM TRACE PublishPluginManager-/node/djmproxy1] Instantiated publish filter plugin 'PublishLenChecker'
[Feb 14, 2003 11:03:08 AM INFO  PublishRateLimiter] Setting MAX_RATE_MPH=30 as configured in xmlBlaster.properties
[Feb 14, 2003 11:03:08 AM INFO  PublishRateLimiter] Rate Limiter is initialized, we check all mime types if rate is too high
[Feb 14, 2003 11:03:08 AM TRACE PublishPluginManager-/node/djmproxy1] Instantiated publish filter plugin 'PublishRateLimiter'
[Feb 14, 2003 11:03:08 AM INFO  PublishPluginManager-/node/djmproxy1] Instantiated 2 publish filter plugins
	JacORB V 1.3.30, www.jacorb.org
	(C) Gerald Brose, FU Berlin, 13 June 2001
[Feb 14, 2003 11:03:11 AM INFO  ProtocolManager-/node/djmproxy1] Ignoring empty protocol driver JDBC:1.0
[Feb 14, 2003 11:03:12 AM INFO  XmlBlasterSecurityManager] Using security policy file:/mnt/quo2/3rdparty/foo/xmlBlaster/lib/xmlBlaster.jar!/xmlBlaster.policy, found it in your CLASSPATH.
[Feb 14, 2003 11:03:13 AM INFO  RmiDriver-/node/djmproxy1] Started RMI registry on port 1099
[Feb 14, 2003 11:03:13 AM INFO  PropertyHandler-/node/djmproxy1] Property administration plugin is initialized
[Feb 14, 2003 11:03:13 AM INFO  CoreHandler-/node/djmproxy1] Core administration plugin is initialized
[Feb 14, 2003 11:03:14 AM INFO  MsgHandler-/node/djmproxy1] Message administration plugin is initialized
[Feb 14, 2003 11:03:14 AM INFO  CommandManager-/node/djmproxy1] Administration manager is ready
[Feb 14, 2003 11:03:14 AM INFO  RunlevelManager-/node/djmproxy1] Successful startup to run level STANDBY [ 5 sec 569 millis ]
[Feb 14, 2003 11:03:14 AM INFO  RoundRobin-djmproxy1] Round robin load balancer is initialized
[Feb 14, 2003 11:03:14 AM INFO  ClusterManager-/node/djmproxy1] Envrionment for node 'psq1' parsed.
[Feb 14, 2003 11:03:14 AM INFO  ClusterManager-/node/djmproxy1] Initialized and ready
[Feb 14, 2003 11:03:14 AM INFO  XmlBlasterConnection-djmproxy1-psq1] Initializing fail save mode
[Feb 14, 2003 11:03:15 AM INFO  ClusterNode-/node/djmproxy1-/node/psq1/] Trying to connect to node 'psq1' on address 'http://128.33.15.35:7600' using protocol=IOR
	JacORB V 1.3.30, www.jacorb.org
	(C) Gerald Brose, FU Berlin, 13 June 2001
[Feb 14, 2003 11:03:15 AM INFO  XmlBlasterConnection-djmproxy1-psq1] Loaded security plugin=htpasswd version=1.0
	JacORB V 1.3.30, www.jacorb.org
	(C) Gerald Brose, FU Berlin, 13 June 2001
[Feb 14, 2003 11:03:15 AM INFO  CorbaCallbackServer-djmproxy1] Success, created CORBA callback server on host 128.33.15.3
[Feb 14, 2003 11:03:15 AM INFO  XmlBlasterConnection-djmproxy1-psq1] Callback settings: type=RAM onOverflow=deadMessage onFailure=deadMessage maxMsg=1000 type=IOR oneway=false burstMode.collectTime=0
[Feb 14, 2003 11:03:15 AM WARN  Global-/node/djmproxy1] XmlBlaster not found on host 128.33.15.35 and port 7600: java.net.ConnectException: Connection refused
[Feb 14, 2003 11:03:15 AM INFO  FileRecorder] Found 83 unprocessed tail back messages in '/home/matighet/tmp/fileRecorder/tailback-djmproxy1-to-psq1.frc'.
[Feb 14, 2003 11:03:15 AM INFO  FileRecorder] FileRecorder is ready, max=10000000 tail back messages are stored in '/home/matighet/tmp/fileRecorder/tailback-djmproxy1-to-psq1.frc'
[Feb 14, 2003 11:03:15 AM INFO  XmlBlasterConnection-djmproxy1-psq1] Activated fail save mode: type=IOR oneway=false burstMode.collectTime=0 delay=4000 retries=-1 pingInterval=10000
[Feb 14, 2003 11:03:15 AM INFO  XmlBlasterConnection-djmproxy1-psq1] Going to poll for psq1 and queue your messages ...
[Feb 14, 2003 11:03:15 AM WARN  ClusterNode-/node/djmproxy1-/node/psq1/] I_ConnectionProblems: No connection to xmlBlaster node 'psq1'
[Feb 14, 2003 11:03:15 AM INFO  LoginThread-djmproxy1-psq1] Polling for psq1 server every 4000 millis forever.
[Feb 14, 2003 11:03:16 AM WARN  LoginThread-djmproxy1-psq1] No connection established, psq1 still seems to be down after 1 login retries.
[Feb 14, 2003 11:03:15 AM INFO  RunlevelManager-/node/djmproxy1] Successful startup to run level CLEANUP [ 7 sec 419 millis ]
[Feb 14, 2003 11:03:16 AM INFO  CorbaDriver-/node/djmproxy1] Published AuthServer IOR on http://128.33.15.3:7601
[Feb 14, 2003 11:03:17 AM INFO  RmiDriver-/node/djmproxy1] Bound authentication RMI server to registry with name 'rmi://coconut.bbn.com:1099/I_AuthServer'
[Feb 14, 2003 11:03:17 AM INFO  RmiDriver-/node/djmproxy1] Bound xmlBlaster RMI server to registry with name 'rmi://coconut.bbn.com:1099/I_XmlBlaster'
[Feb 14, 2003 11:03:17 AM INFO  RmiDriver-/node/djmproxy1] Started successfully RMI driver.
[Feb 14, 2003 11:03:17 AM INFO  SocketDriver-/node/djmproxy1] Started successfully socket driver on hostname=coconut.bbn.com port=7607
[Feb 14, 2003 11:03:18 AM INFO  XmlRpcDriver-/node/djmproxy1] Started successfully XML-RPC driver, access url=http://coconut.bbn.com:8080/
[Feb 14, 2003 11:03:18 AM INFO  RunlevelManager-/node/djmproxy1] Successful startup to run level RUNNING [ 9 sec 683 millis ]
[Feb 14, 2003 11:03:18 AM INFO  Main-/node/djmproxy1] Total memory allocated = 2.31 MBytes. Free memory available = 850.248 KBytes.
[Feb 14, 2003 11:03:18 AM INFO  Main-/node/djmproxy1] ------------------------------------------------
[Feb 14, 2003 11:03:18 AM INFO  Main-/node/djmproxy1] | xmlBlaster 0.841 build 01/22/2003 07:31 PM   |
[Feb 14, 2003 11:03:18 AM INFO  Main-/node/djmproxy1] | READY - press <?> and <enter> for options    |
[Feb 14, 2003 11:03:18 AM INFO  Main-/node/djmproxy1] ------------------------------------------------
[Feb 14, 2003 11:03:18 AM CALL  RunlevelManager-/node/djmproxy1] Leaving changeRunlevel with runlevel = RUNNING
[Feb 14, 2003 11:03:26 AM WARN  HtPasswd] Security risk, no access control: The passwd file is switched off with 'Security.Server.Plugin.htpasswd.secretfile=NONE'
[Feb 14, 2003 11:03:26 AM CALL  RequestBroker-/node/djmproxy1] Entering publish(oid='__sys__UserList', contentMime='text/plain', contentMimeExtended='null' domain='null' from client '/node/djmproxy1/client/__RequestBroker_internal[djmproxy1]' ...
[Feb 14, 2003 11:03:26 AM TRACE PublishPluginManager-/node/djmproxy1] mime=text/plain mimeExtended=1.0 not found in cache, searching the plugin ...
[Feb 14, 2003 11:03:26 AM INFO  PublishPluginManager-/node/djmproxy1] mime=text/plain mimeExtended=1.0 added to cache with plugin=PublishLenChecker
[Feb 14, 2003 11:03:26 AM INFO  PublishPluginManager-/node/djmproxy1] mime=text/plain mimeExtended=1.0 added to cache with plugin=PublishRateLimiter
[Feb 14, 2003 11:03:26 AM INFO  PublishLenChecker] Message access OK, msgLen=8 max=46000
[Feb 14, 2003 11:03:26 AM CALL  TopicHandler-/node/djmproxy1/topic/__sys__UserList] Entering toUnconfigured(oldState=UNDEF)
[Feb 14, 2003 11:03:26 AM CALL  TopicHandler-/node/djmproxy1/topic/__sys__UserList] Entering toUnreferenced(oldState=UNCONFIGURED)
[Feb 14, 2003 11:03:26 AM INFO  XmlKey] DOM parsed the XmlKey __sys__UserList
[Feb 14, 2003 11:03:26 AM CALL  XmlNotPortable] mergeNode()
[Feb 14, 2003 11:03:26 AM CALL  XmlNotPortable] Successfully merged tree
[Feb 14, 2003 11:03:27 AM CALL  TopicHandler-/node/djmproxy1/topic/__sys__UserList] Entering toAlive(oldState=UNREFERENCED)
[Feb 14, 2003 11:03:27 AM CALL  RequestBroker-/node/djmproxy1] checkExistingSubscriptions(__sys__UserList), should happen only once for each topic.
[Feb 14, 2003 11:03:27 AM INFO  CallbackRmiDriver] Accessing client callback reference using given 'rmi://128.33.15.35:1099/I_XmlBlasterCallback/matighet' string
[Feb 14, 2003 11:03:27 AM CALL  ClientSubscriptions-/node/djmproxy1] Login event for client /node/djmproxy1/client/matighet/-1, nothing to do
[Feb 14, 2003 11:03:27 AM CALL  RequestBroker-/node/djmproxy1] Entering publish(oid='__sys__Login', contentMime='text/plain', contentMimeExtended='null' domain='null' from client '/node/djmproxy1/client/__RequestBroker_internal[djmproxy1]' ...
[Feb 14, 2003 11:03:28 AM INFO  PublishLenChecker] Message access OK, msgLen=8 max=46000
[Feb 14, 2003 11:03:28 AM CALL  TopicHandler-/node/djmproxy1/topic/__sys__Login] Entering toUnconfigured(oldState=UNDEF)
[Feb 14, 2003 11:03:28 AM CALL  TopicHandler-/node/djmproxy1/topic/__sys__Login] Entering toUnreferenced(oldState=UNCONFIGURED)
[Feb 14, 2003 11:03:28 AM INFO  XmlKey] DOM parsed the XmlKey __sys__Login
[Feb 14, 2003 11:03:28 AM CALL  XmlNotPortable] mergeNode()
[Feb 14, 2003 11:03:28 AM CALL  XmlNotPortable] Successfully merged tree
[Feb 14, 2003 11:03:28 AM CALL  TopicHandler-/node/djmproxy1/topic/__sys__Login] Entering toAlive(oldState=UNREFERENCED)
[Feb 14, 2003 11:03:28 AM CALL  RequestBroker-/node/djmproxy1] checkExistingSubscriptions(__sys__Login), should happen only once for each topic.
[Feb 14, 2003 11:03:28 AM INFO  Authenticate-/node/djmproxy1] Successful login for client /node/djmproxy1/client/matighet/-1, session expires after [ 24 h 0 millis ], 1 of 10 sessions are in use.
[Feb 14, 2003 11:03:31 AM CALL  XmlBlasterImpl-/node/djmproxy1] Entering publish()
[Feb 14, 2003 11:03:31 AM CALL  RequestBroker-/node/djmproxy1] Entering publish(oid='xmlBlaster-1045238610800000000', contentMime='text/plain', contentMimeExtended='null' domain='FOO' from client '/node/djmproxy1/client/matighet/-1' ...
[Feb 14, 2003 11:03:31 AM INFO  PublishLenChecker] Message access OK, msgLen=45090 max=46000
[Feb 14, 2003 11:03:31 AM INFO  DomainToMaster-djmproxy1] The simple domain based master mapper plugin is initialized
[Feb 14, 2003 11:03:31 AM INFO  MapMsgToMasterPluginManager] Loaded 'DomainToMaster1.0*1.0'
[Feb 14, 2003 11:03:34 AM CALL  XmlBlasterImpl-/node/djmproxy1] Entering publish()
[Feb 14, 2003 11:03:34 AM CALL  RequestBroker-/node/djmproxy1] Entering publish(oid='xmlBlaster-1045238614297000000', contentMime='text/plain', contentMimeExtended='null' domain='FOO' from client '/node/djmproxy1/client/matighet/-1' ...
[Feb 14, 2003 11:03:34 AM INFO  PublishLenChecker] Message access OK, msgLen=45198 max=46000
[Feb 14, 2003 11:03:38 AM CALL  XmlBlasterImpl-/node/djmproxy1] Entering publish()
[Feb 14, 2003 11:03:38 AM CALL  RequestBroker-/node/djmproxy1] Entering publish(oid='xmlBlaster-1045238617902000000', contentMime='text/plain', contentMimeExtended='null' domain='FOO' from client '/node/djmproxy1/client/matighet/-1' ...
[Feb 14, 2003 11:03:38 AM INFO  PublishLenChecker] Message access OK, msgLen=45145 max=46000
[Feb 14, 2003 11:03:41 AM CALL  XmlBlasterImpl-/node/djmproxy1] Entering publish()
[Feb 14, 2003 11:03:41 AM CALL  RequestBroker-/node/djmproxy1] Entering publish(oid='xmlBlaster-1045238621203000000', contentMime='text/plain', contentMimeExtended='null' domain='FOO' from client '/node/djmproxy1/client/matighet/-1' ...
[Feb 14, 2003 11:03:41 AM INFO  PublishLenChecker] Message access OK, msgLen=45235 max=46000
[Feb 14, 2003 11:03:44 AM CALL  XmlBlasterImpl-/node/djmproxy1] Entering publish()
[Feb 14, 2003 11:03:44 AM CALL  RequestBroker-/node/djmproxy1] Entering publish(oid='xmlBlaster-1045238624756000000', contentMime='text/plain', contentMimeExtended='null' domain='FOO' from client '/node/djmproxy1/client/matighet/-1' ...
[Feb 14, 2003 11:03:44 AM INFO  PublishLenChecker] Message REJECTED, msgLen=48051 max allowed=46000
[Feb 14, 2003 11:03:48 AM INFO  Main-/node/djmproxy1] Shutdown forced by user or signal (Ctrl-C).
[Feb 14, 2003 11:03:48 AM CALL  RunlevelManager-/node/djmproxy1] Changing from run level 9 to run level 0 with force=true
[Feb 14, 2003 11:03:48 AM INFO  RunlevelManager-/node/djmproxy1] Change request from run level RUNNING to run level HALTED ...
[Feb 14, 2003 11:03:48 AM INFO  RmiDriver-/node/djmproxy1] RMI deactivated, no client access possible.
[Feb 14, 2003 11:03:48 AM INFO  SocketDriver-/node/djmproxy1] Closing server coconut.bbn.com on port 7607.
[Feb 14, 2003 11:03:48 AM INFO  XmlRpcDriver-/node/djmproxy1] XML-RPC driver stopped, handler released.
[Feb 14, 2003 11:03:48 AM INFO  RunlevelManager-/node/djmproxy1] Successful shutdown to run level=CLEANUP [ 103 millis ]
[Feb 14, 2003 11:03:48 AM INFO  RunlevelManager-/node/djmproxy1] Successful shutdown to run level=STANDBY [ 109 millis ]
[Feb 14, 2003 11:03:48 AM INFO  Authenticate-/node/djmproxy1] Disconnecting client /node/djmproxy1/client/matighet/-1, instanceId=-1, secretSessionId=sessionId:128.33.15.3-null-1045238606144--47197714-2
[Feb 14, 2003 11:03:48 AM CALL  ClientSubscriptions-/node/djmproxy1] START-logout()
[Feb 14, 2003 11:03:48 AM CALL  RequestBroker-/node/djmproxy1] Entering publish(oid='__sys__Logout', contentMime='text/plain', contentMimeExtended='null' domain='null' from client '/node/djmproxy1/client/__RequestBroker_internal[djmproxy1]' ...
[Feb 14, 2003 11:03:48 AM INFO  PublishLenChecker] Message access OK, msgLen=8 max=46000
[Feb 14, 2003 11:03:48 AM CALL  TopicHandler-/node/djmproxy1/topic/__sys__Logout] Entering toUnconfigured(oldState=UNDEF)
[Feb 14, 2003 11:03:48 AM CALL  TopicHandler-/node/djmproxy1/topic/__sys__Logout] Entering toUnreferenced(oldState=UNCONFIGURED)
[Feb 14, 2003 11:03:48 AM INFO  XmlKey] DOM parsed the XmlKey __sys__Logout
[Feb 14, 2003 11:03:48 AM CALL  XmlNotPortable] mergeNode()
[Feb 14, 2003 11:03:48 AM CALL  XmlNotPortable] Successfully merged tree
[Feb 14, 2003 11:03:48 AM CALL  TopicHandler-/node/djmproxy1/topic/__sys__Logout] Entering toAlive(oldState=UNREFERENCED)
[Feb 14, 2003 11:03:48 AM CALL  RequestBroker-/node/djmproxy1] checkExistingSubscriptions(__sys__Logout), should happen only once for each topic.
[Feb 14, 2003 11:03:48 AM INFO  Authenticate-/node/djmproxy1] Destroying SubjectInfo /node/djmproxy1/client/matighet. Nobody is logged in and no queue entries available
[Feb 14, 2003 11:03:48 AM CALL  RequestBroker-/node/djmproxy1] Entering publish(oid='__sys__UserList', contentMime='text/plain', contentMimeExtended='null' domain='null' from client '/node/djmproxy1/client/__RequestBroker_internal[djmproxy1]' ...
[Feb 14, 2003 11:03:48 AM INFO  PublishLenChecker] Message access OK, msgLen=0 max=46000
[Feb 14, 2003 11:03:48 AM INFO  Authenticate-/node/djmproxy1] loginNameSubjectInfoMap has 0 entries and sessionInfoMap has 0 entries
[Feb 14, 2003 11:03:48 AM INFO  Global-/node/djmproxy1] Destroying global handle
[Feb 14, 2003 11:03:48 AM INFO  Global-/node/djmproxy1] Destroying global handle
[Feb 14, 2003 11:03:48 AM INFO  CorbaDriver-/node/djmproxy1] POA and ORB are down, CORBA resources released.
[Feb 14, 2003 11:03:48 AM INFO  RmiDriver-/node/djmproxy1] RMI driver stopped, naming entries released.
[Feb 14, 2003 11:03:48 AM INFO  SocketDriver-/node/djmproxy1] Socket driver stopped, all resources released.
[Feb 14, 2003 11:03:48 AM INFO  XmlRpcDriver-/node/djmproxy1] XML-RPC shutdown, nothing to do.
[Feb 14, 2003 11:03:48 AM INFO  HttpServer-/node/djmproxy1] Closing http server port=7601.
[Feb 14, 2003 11:03:48 AM INFO  RunlevelManager-/node/djmproxy1] Successful shutdown to run level=HALTED [ 345 millis ]
[Feb 14, 2003 11:03:48 AM INFO  Main-/node/djmproxy1] XmlBlaster halted.
[Feb 14, 2003 11:03:48 AM CALL  RunlevelManager-/node/djmproxy1] Leaving changeRunlevel with runlevel = HALTED
matighet at coconut > ]0;~/matighettomato/quo/foo/xmlblasterexit

Script done on Fri Feb 14 11:03:51 2003

-- 
matighet at bbn.com   BBN Technologies