I'm maintaining a pool with 5 connections and validations every minute. On creation, I
assign them an id for monitoring. Here you can see a test case I've already done:
On startup jboss creates 5 connections (ids 1 to 5), and validates them every minute. In a
given moment, the EIS closes all connections, so the validation of all of them fails and
jboss destroys them:
18:24:25,314 INFO [TAManagedConnectionFactory:142] VALIDATING CONNECTIONS....
18:24:25,314 INFO [TAManagedConnection:249] Validating connection 2
18:24:25,314 INFO [TAManagedConnection:290] I/O ERROR
18:24:25,314 INFO [TAManagedConnectionFactory:150] Invalid connection found
18:24:25,314 INFO [TAManagedConnectionFactory:154] VALIDATION FINISHED
18:24:25,314 WARN [JBossManagedConnectionPool:657]
18:24:25,314 INFO [TAManagedConnection:150] Destroying connection...
18:24:25,314 INFO [TAManagedConnection:160] Connection destroyed
18:24:25,314 INFO [TAManagedConnectionFactory:142] VALIDATING CONNECTIONS....
18:24:25,314 INFO [TAManagedConnection:249] Validating connection 3
18:24:25,314 INFO [TAManagedConnection:290] I/O ERROR
18:24:25,314 INFO [TAManagedConnectionFactory:150] Invalid connection found
18:24:25,314 INFO [TAManagedConnectionFactory:154] VALIDATION FINISHED
18:24:25,314 WARN [JBossManagedConnectionPool:657]
18:24:25,314 INFO [TAManagedConnection:150] Destroying connection...
18:24:25,314 INFO [TAManagedConnection:160] Connection destroyed
18:24:25,314 INFO [TAManagedConnectionFactory:142] VALIDATING CONNECTIONS....
18:24:25,314 INFO [TAManagedConnection:249] Validating connection 4
18:24:25,314 INFO [TAManagedConnection:290] I/O ERROR
18:24:25,314 INFO [TAManagedConnectionFactory:150] Invalid connection found
18:24:25,314 INFO [TAManagedConnectionFactory:154] VALIDATION FINISHED
18:24:25,314 WARN [JBossManagedConnectionPool:657]
18:24:25,314 INFO [TAManagedConnection:150] Destroying connection...
18:24:25,314 INFO [TAManagedConnection:160] Connection destroyed
18:24:25,314 INFO [TAManagedConnectionFactory:142] VALIDATING CONNECTIONS....
18:24:25,314 INFO [TAManagedConnection:249] Validating connection 5
18:24:25,314 INFO [TAManagedConnection:290] I/O ERROR
18:24:25,314 INFO [TAManagedConnectionFactory:150] Invalid connection found
18:24:25,314 INFO [TAManagedConnectionFactory:154] VALIDATION FINISHED
18:24:25,314 WARN [JBossManagedConnectionPool:657]
18:24:25,314 INFO [TAManagedConnection:150] Destroying connection...
18:24:25,314 INFO [TAManagedConnection:160] Connection destroyed
18:24:25,314 INFO [TAManagedConnectionFactory:142] VALIDATING CONNECTIONS....
18:24:25,314 INFO [TAManagedConnection:249] Validating connection 1
18:24:25,329 INFO [TAManagedConnection:290] I/O ERROR
18:24:25,329 INFO [TAManagedConnectionFactory:150] Invalid connection found
18:24:25,329 INFO [TAManagedConnectionFactory:154] VALIDATION FINISHED
18:24:25,329 WARN [JBossManagedConnectionPool:657]
18:24:25,329 INFO [TAManagedConnection:150] Destroying connection...
18:24:25,329 INFO [TAManagedConnection:160] Connection destroyed
Inmediately jboss creates 5 new connections (ids 6 to 10) in order to fill the pool:
18:24:25,329 INFO [TAManagedConnection:111] Initiating connection...
18:24:25,329 INFO [TAManagedConnection:118] Connection established
18:24:25,329 INFO [TAManagedConnectionFactory:111] Connection created - number 6
18:24:25,329 INFO [TAManagedConnection:111] Initiating connection...
18:24:25,329 INFO [TAManagedConnection:118] Connection established
18:24:25,329 INFO [TAManagedConnectionFactory:111] Connection created - number 7
18:24:25,329 INFO [TAManagedConnection:111] Initiating connection...
18:24:25,329 INFO [TAManagedConnection:118] Connection established
18:24:25,329 INFO [TAManagedConnectionFactory:111] Connection created - number 8
18:24:25,329 INFO [TAManagedConnection:111] Initiating connection...
18:24:25,329 INFO [TAManagedConnection:118] Connection established
18:24:25,329 INFO [TAManagedConnectionFactory:111] Connection created - number 9
18:24:25,329 INFO [TAManagedConnection:111] Initiating connection...
18:24:25,329 INFO [TAManagedConnection:118] Connection established
18:24:25,329 INFO [TAManagedConnectionFactory:111] Connection created - number 10
30 seconds before, jboss validates the recently created connections:
18:24:55,330 INFO [TAManagedConnectionFactory:142] VALIDATING CONNECTIONS....
18:24:55,330 INFO [TAManagedConnection:249] Validating connection 6
18:24:55,345 INFO [TAManagedConnection:275] Connection is valid
18:24:55,345 INFO [TAManagedConnectionFactory:154] VALIDATION FINISHED
18:24:55,345 INFO [TAManagedConnectionFactory:142] VALIDATING CONNECTIONS....
18:24:55,345 INFO [TAManagedConnection:249] Validating connection 7
18:24:55,345 INFO [TAManagedConnection:275] Connection is valid
18:24:55,345 INFO [TAManagedConnectionFactory:154] VALIDATION FINISHED
18:24:55,345 INFO [TAManagedConnectionFactory:142] VALIDATING CONNECTIONS....
18:24:55,345 INFO [TAManagedConnection:249] Validating connection 8
18:24:55,345 INFO [TAManagedConnection:275] Connection is valid
18:24:55,345 INFO [TAManagedConnectionFactory:154] VALIDATION FINISHED
18:24:55,361 INFO [TAManagedConnectionFactory:142] VALIDATING CONNECTIONS....
18:24:55,361 INFO [TAManagedConnection:249] Validating connection 9
18:24:55,361 INFO [TAManagedConnection:275] Connection is valid
18:24:55,361 INFO [TAManagedConnectionFactory:154] VALIDATION FINISHED
18:24:55,361 INFO [TAManagedConnectionFactory:142] VALIDATING CONNECTIONS....
18:24:55,361 INFO [TAManagedConnection:249] Validating connection 10
18:24:55,377 INFO [TAManagedConnection:275] Connection is valid
18:24:55,377 INFO [TAManagedConnectionFactory:154] VALIDATION FINISHED
but 30 seconds before this (and exactly 1 minute before the last unsuccessful validation)
jboss validates the destroyed connections (ids 1 to 5):
18:25:25,377 INFO [TAManagedConnectionFactory:142] VALIDATING CONNECTIONS....
18:25:25,377 INFO [TAManagedConnection:249] Validating connection 2
18:25:25,377 INFO [TAManagedConnection:299] Channel is not connected
18:25:25,377 INFO [TAManagedConnectionFactory:150] Invalid connection found
18:25:25,377 INFO [TAManagedConnectionFactory:154] VALIDATION FINISHED
18:25:25,377 WARN [JBossManagedConnectionPool:657]
18:25:25,377 INFO [TAManagedConnectionFactory:142] VALIDATING CONNECTIONS....
18:25:25,377 INFO [TAManagedConnection:249] Validating connection 3
18:25:25,377 INFO [TAManagedConnection:299] Channel is not connected
18:25:25,377 INFO [TAManagedConnectionFactory:150] Invalid connection found
18:25:25,377 INFO [TAManagedConnectionFactory:154] VALIDATION FINISHED
18:25:25,377 WARN [JBossManagedConnectionPool:657]
18:25:25,377 INFO [TAManagedConnectionFactory:142] VALIDATING CONNECTIONS....
18:25:25,377 INFO [TAManagedConnection:249] Validating connection 4
18:25:25,377 INFO [TAManagedConnection:299] Channel is not connected
18:25:25,377 INFO [TAManagedConnectionFactory:150] Invalid connection found
18:25:25,377 INFO [TAManagedConnectionFactory:154] VALIDATION FINISHED
18:25:25,377 WARN [JBossManagedConnectionPool:657]
18:25:25,377 INFO [TAManagedConnectionFactory:142] VALIDATING CONNECTIONS....
18:25:25,377 INFO [TAManagedConnection:249] Validating connection 5
18:25:25,377 INFO [TAManagedConnection:299] Channel is not connected
18:25:25,377 INFO [TAManagedConnectionFactory:150] Invalid connection found
18:25:25,377 INFO [TAManagedConnectionFactory:154] VALIDATION FINISHED
18:25:25,377 WARN [JBossManagedConnectionPool:657]
18:25:25,377 INFO [TAManagedConnectionFactory:142] VALIDATING CONNECTIONS....
18:25:25,377 INFO [TAManagedConnection:249] Validating connection 1
18:25:25,377 INFO [TAManagedConnection:299] Channel is not connected
18:25:25,377 INFO [TAManagedConnectionFactory:150] Invalid connection found
18:25:25,377 INFO [TAManagedConnectionFactory:154] VALIDATION FINISHED
18:25:25,377 WARN [JBossManagedConnectionPool:657]
As you can see, jboss is constantly validating destroyed connections, the more connections
get invalid, the more the problem increases.
View the original post :
http://www.jboss.com/index.html?module=bb&op=viewtopic&p=4024394#...
Reply to the post :
http://www.jboss.com/index.html?module=bb&op=posting&mode=reply&a...