You are viewing a plain text version of this content. The canonical link for it is here.
Posted to user@roller.apache.org by RW <ro...@tauceti.net> on 2007/07/04 22:08:00 UTC
Re: Comments do not work anymore
Hmmm... Well I'm not even getting something which looks like a comment :-(
Here are the log entries when pressing the "post" button (sorry for the long
output...):
DEBUG 2007-07-04 21:46:20,244 SessionImpl:<init> - opened session at
timestamp: 4847937045479424
DEBUG 2007-07-04 21:46:20,245
ThreadLocalSessionContext$TransactionProtectionWrapper:invoke - allowing
method [beginTransaction] in non-transacted context
DEBUG 2007-07-04 21:46:20,245
ThreadLocalSessionContext$TransactionProtectionWrapper:invoke - allowing
proxied method [beginTransaction] to proceed to real session
DEBUG 2007-07-04 21:46:20,246 JDBCTransaction:begin - begin
DEBUG 2007-07-04 21:46:20,246 ConnectionManager:openConnection - opening
JDBC connection
DEBUG 2007-07-04 21:46:20,246 JDBCTransaction:begin - current autocommit
status: true
DEBUG 2007-07-04 21:46:20,247 JDBCTransaction:begin - disabling autocommit
DEBUG 2007-07-04 21:46:20,247 JDBCContext:afterTransactionBegin - after
transaction begin
DEBUG 2007-07-04 21:46:20,247
ThreadLocalSessionContext$TransactionProtectionWrapper:invoke - allowing
proxied method [get] to proceed to real session
DEBUG 2007-07-04 21:46:20,248 DefaultLoadEventListener:proxyOrLoad -
loading entity:
[org.apache.roller.pojos.WebsiteData#ff80808103753a9901037546d26a0003]
DEBUG 2007-07-04 21:46:20,248 DefaultLoadEventListener:doLoad -
attempting to resolve:
[org.apache.roller.pojos.WebsiteData#ff80808103753a9901037546d26a0003]
DEBUG 2007-07-04 21:46:20,248 ReadWriteCache:get - Cache lookup:
org.apache.roller.pojos.WebsiteData#ff80808103753a9901037546d26a0003
DEBUG 2007-07-04 21:46:20,249 EhCache:get - key:
org.apache.roller.pojos.WebsiteData#ff80808103753a9901037546d26a0003
DEBUG 2007-07-04 21:46:20,249 MemoryStore:get -
org.apache.roller.pojos.WebsiteDataCache: MemoryStore hit for
org.apache.roller.pojos.WebsiteData#ff80808103753a9901037546d26a0003
DEBUG 2007-07-04 21:46:20,249 Cache:isExpired -
org.apache.roller.pojos.WebsiteData#ff80808103753a9901037546d26a0003
now: 1183578380249
DEBUG 2007-07-04 21:46:20,250 Cache:isExpired -
org.apache.roller.pojos.WebsiteData#ff80808103753a9901037546d26a0003
Creation Time: 1183552933720 Next To Last Access Time: 1183578327607
DEBUG 2007-07-04 21:46:20,250 Cache:isExpired -
org.apache.roller.pojos.WebsiteData#ff80808103753a9901037546d26a0003
mostRecentTime:1183578327607
DEBUG 2007-07-04 21:46:20,250 Cache:isExpired -
org.apache.roller.pojos.WebsiteData#ff80808103753a9901037546d26a0003 Age
to Idle: 0 Age Idled: 52642
DEBUG 2007-07-04 21:46:20,251 Cache:isExpired -
org.apache.roller.pojos.WebsiteData: Is element with key
org.apache.roller.pojos.WebsiteData#ff80808103753a9901037546d26a0003
expired?: false
DEBUG 2007-07-04 21:46:20,251 ReadWriteCache:get - Cache hit:
org.apache.roller.pojos.WebsiteData#ff80808103753a9901037546d26a0003
DEBUG 2007-07-04 21:46:20,251
DefaultLoadEventListener:assembleCacheEntry - assembling entity from
second-level
cache:[org.apache.roller.pojos.WebsiteData#ff80808103753a9901037546d26a0003]
DEBUG 2007-07-04 21:46:20,252 CollectionLoadContext:getLoadingCollection
- creating collection
wrapper:[org.apache.roller.pojos.WebsiteData.permissions#ff80808103753a9901037546d26a0003]
DEBUG 2007-07-04 21:46:20,252 DefaultLoadEventListener:proxyOrLoad -
loading entity:
[org.apache.roller.pojos.UserData#ff80808103753a9901037546d2450001]
DEBUG 2007-07-04 21:46:20,253 DefaultLoadEventListener:doLoad -
attempting to resolve:
[org.apache.roller.pojos.UserData#ff80808103753a9901037546d2450001]
DEBUG 2007-07-04 21:46:20,253 ReadWriteCache:get - Cache lookup:
org.apache.roller.pojos.UserData#ff80808103753a9901037546d2450001
DEBUG 2007-07-04 21:46:20,253 EhCache:get - key:
org.apache.roller.pojos.UserData#ff80808103753a9901037546d2450001
DEBUG 2007-07-04 21:46:20,254 MemoryStore:get -
org.apache.roller.pojos.UserDataCache: MemoryStore hit for
org.apache.roller.pojos.UserData#ff80808103753a9901037546d2450001
DEBUG 2007-07-04 21:46:20,254 Cache:isExpired -
org.apache.roller.pojos.UserData#ff80808103753a9901037546d2450001 now:
1183578380254
DEBUG 2007-07-04 21:46:20,255 Cache:isExpired -
org.apache.roller.pojos.UserData#ff80808103753a9901037546d2450001
Creation Time: 1183552698052 Next To Last Access Time: 1183578327614
DEBUG 2007-07-04 21:46:20,255 Cache:isExpired -
org.apache.roller.pojos.UserData#ff80808103753a9901037546d2450001
mostRecentTime: 1183578327614
DEBUG 2007-07-04 21:46:20,255 Cache:isExpired -
org.apache.roller.pojos.UserData#ff80808103753a9901037546d2450001 Age to
Idle: 0 AgeIdled: 52640
DEBUG 2007-07-04 21:46:20,256 Cache:isExpired -
org.apache.roller.pojos.UserData: Is element with key
org.apache.roller.pojos.UserData#ff80808103753a9901037546d2450001
expired?: false
DEBUG 2007-07-04 21:46:20,256 ReadWriteCache:get - Cache hit:
org.apache.roller.pojos.UserData#ff80808103753a9901037546d2450001
DEBUG 2007-07-04 21:46:20,257
DefaultLoadEventListener:assembleCacheEntry - assembling entity from
second-level
cache:[org.apache.roller.pojos.UserData#ff80808103753a9901037546d2450001]
DEBUG 2007-07-04 21:46:20,257 CollectionLoadContext:getLoadingCollection
- creating collection
wrapper:[org.apache.roller.pojos.UserData.permissions#ff80808103753a9901037546d2450001]
DEBUG 2007-07-04 21:46:20,257 CollectionLoadContext:getLoadingCollection
- creating collection
wrapper:[org.apache.roller.pojos.UserData.roles#ff80808103753a9901037546d2450001]
DEBUG 2007-07-04 21:46:20,258
DefaultLoadEventListener:assembleCacheEntry - Cached Version: null
DEBUG 2007-07-04 21:46:20,258
StatefulPersistenceContext:initializeNonLazyCollections - initializing
non-lazy collections
DEBUG 2007-07-04 21:46:20,259
DefaultInitializeCollectionEventListener:onInitializeCollection -
initializing collection
[org.apache.roller.pojos.UserData.roles#ff80808103753a9901037546d2450001]
DEBUG 2007-07-04 21:46:20,259
DefaultInitializeCollectionEventListener:onInitializeCollection -
checking second-level cache
DEBUG 2007-07-04 21:46:20,259
DefaultInitializeCollectionEventListener:onInitializeCollection -
collection not cached
DEBUG 2007-07-04 21:46:20,260 Loader:loadCollection - loading
collection:
[org.apache.roller.pojos.UserData.roles#ff80808103753a9901037546d2450001]
DEBUG 2007-07-04 21:46:20,260 AbstractBatcher:logOpenPreparedStatement -
about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
DEBUG 2007-07-04 21:46:20,261 AbstractBatcher:log - select
roles0_.userid as userid1_, roles0_.id as id1_, roles0_.id as id2_0_, role
s0_.username as username2_0_, roles0_.userid as userid2_0_,
roles0_.rolename as rolename2_0_ from userrole roles0_ where
roles0_.userid=?
DEBUG 2007-07-04 21:46:20,261 AbstractBatcher:getPreparedStatement -
preparing statement
DEBUG 2007-07-04 21:46:20,262 NullableType:nullSafeSet - binding
'ff80808103753a9901037546d2450001' to parameter: 1
DEBUG 2007-07-04 21:46:20,263 AbstractBatcher:logOpenResults - about to
open ResultSet (open ResultSets: 0, globally: 0)
DEBUG 2007-07-04 21:46:20,263 Loader:handleEmptyCollections - result set
contains (possibly empty) collection:
[org.apache.roller.pojos.UserData.roles#ff80808103753a9901037546d2450001]
DEBUG 2007-07-04 21:46:20,264 CollectionLoadContext:getLoadingCollection
- uninitialized collection: initializing
DEBUG 2007-07-04 21:46:20,264 Loader:doQuery - processing result set
DEBUG 2007-07-04 21:46:20,265 Loader:doQuery - result set row: 0
DEBUG 2007-07-04 21:46:20,265 NullableType:nullSafeGet - returning
'ff80808103753a9901037546d2690002' as column: id2_0_
DEBUG 2007-07-04 21:46:20,265 Loader:getRow - result row:
EntityKey[org.apache.roller.pojos.RoleData#ff80808103753a9901037546d2690002]
DEBUG 2007-07-04 21:46:20,266 Loader:loadFromResultSet - Initializing
object from ResultSet:
[org.apache.roller.pojos.RoleData#ff80808103753a9901037546d2690002]
DEBUG 2007-07-04 21:46:20,266 AbstractEntityPersister:hydrate -
Hydrating entity:
[org.apache.roller.pojos.RoleData#ff80808103753a9901037546d2690002]
DEBUG 2007-07-04 21:46:20,267 NullableType:nullSafeGet - returning
'cetixx' as column: username2_0_
DEBUG 2007-07-04 21:46:20,267 NullableType:nullSafeGet - returning
'ff80808103753a9901037546d2450001' as column: userid2_0_
DEBUG 2007-07-04 21:46:20,268 NullableType:nullSafeGet - returning
'editor' as column: rolename2_0_
DEBUG 2007-07-04 21:46:20,268 NullableType:nullSafeGet - returning
'ff80808103753a9901037546d2450001' as column: userid1_
DEBUG 2007-07-04 21:46:20,269 Loader:readCollectionElement - found row
of collection:
[org.apache.roller.pojos.UserData.roles#ff80808103753a9901037546d2450001]
DEBUG 2007-07-04 21:46:20,269 CollectionLoadContext:getLoadingCollection
- reading row
DEBUG 2007-07-04 21:46:20,270 NullableType:nullSafeGet - returning
'ff80808103753a9901037546d2690002' as column: id1_
DEBUG 2007-07-04 21:46:20,270 DefaultLoadEventListener:proxyOrLoad -
loading entity:
[org.apache.roller.pojos.RoleData#ff80808103753a9901037546d2690002]
DEBUG 2007-07-04 21:46:20,271 DefaultLoadEventListener:doLoad -
attempting to resolve:
[org.apache.roller.pojos.RoleData#ff80808103753a9901037546d2690002]
DEBUG 2007-07-04 21:46:20,271 DefaultLoadEventListener:doLoad - resolved
object in session cache:
[org.apache.roller.pojos.RoleData#ff80808103753a9901037546d2690002]
DEBUG 2007-07-04 21:46:20,272 Loader:doQuery - result set row: 1
DEBUG 2007-07-04 21:46:20,272 NullableType:nullSafeGet - returning
'ff80808103753a9901037546d4d3001b' as column: id2_0_
DEBUG 2007-07-04 21:46:20,272 Loader:getRow - result row:
EntityKey[org.apache.roller.pojos.RoleData#ff80808103753a9901037546d4d3001b]
DEBUG 2007-07-04 21:46:20,273 Loader:loadFromResultSet - Initializing
object from ResultSet:
[org.apache.roller.pojos.RoleData#ff80808103753a9901037546d4d3001b]
DEBUG 2007-07-04 21:46:20,273 AbstractEntityPersister:hydrate -
Hydrating entity:
[org.apache.roller.pojos.RoleData#ff80808103753a9901037546d4d3001b]
DEBUG 2007-07-04 21:46:20,274 NullableType:nullSafeGet - returning
'cetixx' as column: username2_0_
DEBUG 2007-07-04 21:46:20,274 NullableType:nullSafeGet - returning
'ff80808103753a9901037546d2450001' as column: userid2_0_
DEBUG 2007-07-04 21:46:20,275 NullableType:nullSafeGet - returning
'admin' as column: rolename2_0_
DEBUG 2007-07-04 21:46:20,275 NullableType:nullSafeGet - returning
'ff80808103753a9901037546d2450001' as column: userid1_
DEBUG 2007-07-04 21:46:20,276 Loader:readCollectionElement - found row
of collection:
[org.apache.roller.pojos.UserData.roles#ff80808103753a9901037546d2450001]
DEBUG 2007-07-04 21:46:20,276 CollectionLoadContext:getLoadingCollection
- reading row
DEBUG 2007-07-04 21:46:20,277 NullableType:nullSafeGet - returning
'ff80808103753a9901037546d4d3001b' as column: id1_
DEBUG 2007-07-04 21:46:20,277 DefaultLoadEventListener:proxyOrLoad -
loading entity:
[org.apache.roller.pojos.RoleData#ff80808103753a9901037546d4d3001b]
DEBUG 2007-07-04 21:46:20,278 DefaultLoadEventListener:doLoad -
attempting to resolve:
[org.apache.roller.pojos.RoleData#ff80808103753a9901037546d4d3001b]
DEBUG 2007-07-04 21:46:20,278 DefaultLoadEventListener:doLoad - resolved
object in session cache:
[org.apache.roller.pojos.RoleData#ff80808103753a9901037546d4d3001b]
DEBUG 2007-07-04 21:46:20,279 Loader:doQuery - done processing result
set (2 rows)
DEBUG 2007-07-04 21:46:20,279 AbstractBatcher:logCloseResults - about to
close ResultSet (open ResultSets: 1, globally: 1)
DEBUG 2007-07-04 21:46:20,279 AbstractBatcher:logClosePreparedStatement
- about to close PreparedStatement (open PreparedStatements:1, globally: 1)
DEBUG 2007-07-04 21:46:20,280 AbstractBatcher:closePreparedStatement -
closing statement
DEBUG 2007-07-04 21:46:20,280 Loader:initializeEntitiesAndCollections -
total objects hydrated: 2
DEBUG 2007-07-04 21:46:20,281 TwoPhaseLoad:initializeEntity - resolving
associations for
[org.apache.roller.pojos.RoleData#ff80808103753a9901037546d2690002]
DEBUG 2007-07-04 21:46:20,281 DefaultLoadEventListener:proxyOrLoad -
loading entity:
[org.apache.roller.pojos.UserData#ff80808103753a9901037546d2450001]
DEBUG 2007-07-04 21:46:20,282 DefaultLoadEventListener:doLoad -
attempting to resolve:
[org.apache.roller.pojos.UserData#ff80808103753a9901037546d2450001]
DEBUG 2007-07-04 21:46:20,282 DefaultLoadEventListener:doLoad - resolved
object in session cache:
[org.apache.roller.pojos.UserData#ff80808103753a9901037546d2450001]
DEBUG 2007-07-04 21:46:20,283 TwoPhaseLoad:initializeEntity - adding
entity to second-level cache:
[org.apache.roller.pojos.RoleData#ff80808103753a9901037546d2690002]
DEBUG 2007-07-04 21:46:20,283 ReadWriteCache:put - Caching:
org.apache.roller.pojos.RoleData#ff80808103753a9901037546d2690002
DEBUG 2007-07-04 21:46:20,283 EhCache:get - key:
org.apache.roller.pojos.RoleData#ff80808103753a9901037546d2690002
DEBUG 2007-07-04 21:46:20,284 MemoryStore:get -
org.apache.roller.pojos.RoleDataCache: MemoryStore hit for
org.apache.roller.pojos.RoleData#ff80808103753a9901037546d2690002
DEBUG 2007-07-04 21:46:20,284 Cache:isExpired -
org.apache.roller.pojos.RoleData#ff80808103753a9901037546d2690002 now:
1183578380284
DEBUG 2007-07-04 21:46:20,285 Cache:isExpired -
org.apache.roller.pojos.RoleData#ff80808103753a9901037546d2690002
Creation Time: 1183577443817 Next To Last Access Time: 1183578327656
DEBUG 2007-07-04 21:46:20,285 Cache:isExpired -
org.apache.roller.pojos.RoleData#ff80808103753a9901037546d2690002
mostRecentTime: 1183578327656
DEBUG 2007-07-04 21:46:20,286 Cache:isExpired -
org.apache.roller.pojos.RoleData#ff80808103753a9901037546d2690002 Age to
Idle: 1200000 Age Idled: 52628
DEBUG 2007-07-04 21:46:20,286 Cache:isExpired -
org.apache.roller.pojos.RoleData: Is element with key
org.apache.roller.pojos.RoleData#ff80808103753a9901037546d2690002
expired?: false
DEBUG 2007-07-04 21:46:20,287 ReadWriteCache:put - Item was already
cached: org.apache.roller.pojos.RoleData#ff80808103753a9901037546d2690002
DEBUG 2007-07-04 21:46:20,287 TwoPhaseLoad:initializeEntity - done
materializing entity
[org.apache.roller.pojos.RoleData#ff80808103753a9901037546d2690002]
DEBUG 2007-07-04 21:46:20,288 TwoPhaseLoad:initializeEntity - resolving
associations for
[org.apache.roller.pojos.RoleData#ff80808103753a9901037546d4d3001b]
DEBUG 2007-07-04 21:46:20,288 DefaultLoadEventListener:proxyOrLoad -
loading entity:
[org.apache.roller.pojos.UserData#ff80808103753a9901037546d2450001]
DEBUG 2007-07-04 21:46:20,289 DefaultLoadEventListener:doLoad -
attempting to resolve:
[org.apache.roller.pojos.UserData#ff80808103753a9901037546d2450001]
DEBUG 2007-07-04 21:46:20,289 DefaultLoadEventListener:doLoad - resolved
object in session cache:
[org.apache.roller.pojos.UserData#ff80808103753a9901037546d2450001]
DEBUG 2007-07-04 21:46:20,289 TwoPhaseLoad:initializeEntity - adding
entity to second-level cache:
[org.apache.roller.pojos.RoleData#ff80808103753a9901037546d4d3001b]
DEBUG 2007-07-04 21:46:20,290 ReadWriteCache:put - Caching:
org.apache.roller.pojos.RoleData#ff80808103753a9901037546d4d3001b
DEBUG 2007-07-04 21:46:20,290 EhCache:get - key:
org.apache.roller.pojos.RoleData#ff80808103753a9901037546d4d3001b
DEBUG 2007-07-04 21:46:20,291 MemoryStore:get -
org.apache.roller.pojos.RoleDataCache: MemoryStore hit for
org.apache.roller.pojos.Ro
leData#ff80808103753a9901037546d4d3001b
DEBUG 2007-07-04 21:46:20,291 Cache:isExpired -
org.apache.roller.pojos.RoleData#ff80808103753a9901037546d4d3001b now:
1183578380291
DEBUG 2007-07-04 21:46:20,292 Cache:isExpired -
org.apache.roller.pojos.RoleData#ff80808103753a9901037546d4d3001b
Creation Time: 1183577443825 Next To Last Access Time: 1183578327666
DEBUG 2007-07-04 21:46:20,292 Cache:isExpired -
org.apache.roller.pojos.RoleData#ff80808103753a9901037546d4d3001b
mostRecentTime: 1183578327666
DEBUG 2007-07-04 21:46:20,293 Cache:isExpired -
org.apache.roller.pojos.RoleData#ff80808103753a9901037546d4d3001b Age to
Idle: 1200000 Age Idled: 52625
DEBUG 2007-07-04 21:46:20,293 Cache:isExpired -
org.apache.roller.pojos.RoleData: Is element with key
org.apache.roller.pojos.RoleData#ff80808103753a9901037546d4d3001b
expired?: false
DEBUG 2007-07-04 21:46:20,294 ReadWriteCache:put - Item was already
cached: org.apache.roller.pojos.RoleData#ff80808103753a9901037546d4d3001b
DEBUG 2007-07-04 21:46:20,294 TwoPhaseLoad:initializeEntity - done
materializing entity
[org.apache.roller.pojos.RoleData#ff80808103753a9901037546d4d3001b]
DEBUG 2007-07-04 21:46:20,294
CollectionLoadContext:endLoadingCollections - 1 collections were found
in result set for role: org.apache.roller.pojos.UserData.roles
DEBUG 2007-07-04 21:46:20,295 CollectionLoadContext:endLoadingCollection
- collection fully initialized:
[org.apache.roller.pojos.UserData.roles#ff80808103753a9901037546d2450001]
DEBUG 2007-07-04 21:46:20,295
CollectionLoadContext:endLoadingCollections - 1 collections initialized
for role: org.apache.roller.pojos.UserData.roles
DEBUG 2007-07-04 21:46:20,296 Loader:loadCollection - done loading
collection
DEBUG 2007-07-04 21:46:20,296
DefaultInitializeCollectionEventListener:onInitializeCollection -
collection initialized
DEBUG 2007-07-04 21:46:20,297 DefaultLoadEventListener:doLoad - resolved
object in second-level cache:
[org.apache.roller.pojos.UserData#ff80808103753a9901037546d2450001]
DEBUG 2007-07-04 21:46:20,297 DefaultLoadEventListener:proxyOrLoad -
loading entity:
[org.apache.roller.pojos.WeblogCategoryData#ff80808103753a9901037546d3aa0006]
DEBUG 2007-07-04 21:46:20,297 DefaultLoadEventListener:doLoad -
attempting to resolve:
[org.apache.roller.pojos.WeblogCategoryData#ff80808103753a9901037546d3aa0006]
DEBUG 2007-07-04 21:46:20,298 ReadWriteCache:get - Cache lookup:
org.apache.roller.pojos.WeblogCategoryData#ff80808103753a9901037546d3aa0006
DEBUG 2007-07-04 21:46:20,298 EhCache:get - key:
org.apache.roller.pojos.WeblogCategoryData#ff80808103753a9901037546d3aa0006
DEBUG 2007-07-04 21:46:20,299 MemoryStore:get -
org.apache.roller.pojos.WeblogCategoryDataCache: MemoryStore hit for
org.apache.roller.pojos.WeblogCategoryData#ff80808103753a9901037546d3aa0006
DEBUG 2007-07-04 21:46:20,299 Cache:isExpired -
org.apache.roller.pojos.WeblogCategoryData#ff80808103753a9901037546d3aa0006
now: 118357380299
DEBUG 2007-07-04 21:46:20,299 Cache:isExpired -
org.apache.roller.pojos.WeblogCategoryData#ff80808103753a9901037546d3aa0006
CreationTime: 1183577443864 Next To Last Access Time: 1183578327677
DEBUG 2007-07-04 21:46:20,300 Cache:isExpired -
org.apache.roller.pojos.WeblogCategoryData#ff80808103753a9901037546d3aa0006
mostRecentTime: 1183578327677
DEBUG 2007-07-04 21:46:20,300 Cache:isExpired -
org.apache.roller.pojos.WeblogCategoryData#ff80808103753a9901037546d3aa0006
Age to Idle: 1200000 Age Idled: 52622
DEBUG 2007-07-04 21:46:20,301 Cache:isExpired -
org.apache.roller.pojos.WeblogCategoryData: Is element with key
org.apache.roller.pojos.WeblogCategoryData#ff80808103753a9901037546d3aa0006
expired?: false
DEBUG 2007-07-04 21:46:20,301 ReadWriteCache:get - Cache hit:
org.apache.roller.pojos.WeblogCategoryData#ff80808103753a9901037546d3aa0006
DEBUG 2007-07-04 21:46:20,302
DefaultLoadEventListener:assembleCacheEntry - assembling entity from
second-level cache:
[org.apache.roller.pojos.WeblogCategoryData#ff80808103753a9901037546d3aa0006]
DEBUG 2007-07-04 21:46:20,302 DefaultLoadEventListener:proxyOrLoad -
loading entity:
[org.apache.roller.pojos.WebsiteData#ff80808103753a9901037546d26a0003]
DEBUG 2007-07-04 21:46:20,302 DefaultLoadEventListener:doLoad -
attempting to resolve:
[org.apache.roller.pojos.WebsiteData#ff80808103753a9901037546d26a0003]
DEBUG 2007-07-04 21:46:20,303 DefaultLoadEventListener:doLoad - resolved
object in session cache:
[org.apache.roller.pojos.WebsiteData#ff80808103753a9901037546d26a0003]
DEBUG 2007-07-04 21:46:20,303
DefaultLoadEventListener:assembleCacheEntry - Cached Version: null
DEBUG 2007-07-04 21:46:20,304
StatefulPersistenceContext:initializeNonLazyCollections - initializing
non-lazy collections
DEBUG 2007-07-04 21:46:20,304 DefaultLoadEventListener:doLoad - resolved
object in second-level cache:
[org.apache.roller.pojos.WeblogCategoryData#ff80808103753a9901037546d3aa0006]
DEBUG 2007-07-04 21:46:20,305 DefaultLoadEventListener:proxyOrLoad -
loading entity:
[org.apache.roller.pojos.WeblogCategoryData#ff80808103753a9901037546d26b0004]
DEBUG 2007-07-04 21:46:20,305 DefaultLoadEventListener:doLoad -
attempting to resolve:
[org.apache.roller.pojos.WeblogCategoryData#ff80808103753a9901037546d26b0004]
DEBUG 2007-07-04 21:46:20,305 ReadWriteCache:get - Cache lookup:
org.apache.roller.pojos.WeblogCategoryData#ff80808103753a9901037546d
26b0004
DEBUG 2007-07-04 21:46:20,306 EhCache:get - key:
org.apache.roller.pojos.WeblogCategoryData#ff80808103753a9901037546d26b0004
DEBUG 2007-07-04 21:46:20,306 MemoryStore:get -
org.apache.roller.pojos.WeblogCategoryDataCache: MemoryStore hit for
org.apache.roller.pojos.WeblogCategoryData#ff80808103753a9901037546d26b0004
DEBUG 2007-07-04 21:46:20,307 Cache:isExpired -
org.apache.roller.pojos.WeblogCategoryData#ff80808103753a9901037546d26b0004
now: 1183578380307
DEBUG 2007-07-04 21:46:20,307 Cache:isExpired -
org.apache.roller.pojos.WeblogCategoryData#ff80808103753a9901037546d26b0004
CreationTime: 1183577443871 Next To Last Access Time: 1183578327687
DEBUG 2007-07-04 21:46:20,308 Cache:isExpired -
org.apache.roller.pojos.WeblogCategoryData#ff80808103753a9901037546d26b0004
mostRecentTime: 1183578327687
DEBUG 2007-07-04 21:46:20,308 Cache:isExpired -
org.apache.roller.pojos.WeblogCategoryData#ff80808103753a9901037546d26b0004
Age to Idle: 1200000 Age Idled: 52620
DEBUG 2007-07-04 21:46:20,308 Cache:isExpired -
org.apache.roller.pojos.WeblogCategoryData: Is element with key
org.apache.roller.pojos.WeblogCategoryData#ff80808103753a9901037546d26b0004
expired?: false
DEBUG 2007-07-04 21:46:20,309 ReadWriteCache:get - Cache hit:
org.apache.roller.pojos.WeblogCategoryData#ff80808103753a9901037546d26b0004
DEBUG 2007-07-04 21:46:20,309
DefaultLoadEventListener:assembleCacheEntry - assembling entity from
second-level cache:
[org.apache.roller.pojos.WeblogCategoryData#ff80808103753a9901037546d26b0004]
DEBUG 2007-07-04 21:46:20,310 DefaultLoadEventListener:proxyOrLoad -
loading entity:
[org.apache.roller.pojos.WebsiteData#ff80808103753a9901037546d26a0003]
DEBUG 2007-07-04 21:46:20,310 DefaultLoadEventListener:doLoad -
attempting to resolve:
[org.apache.roller.pojos.WebsiteData#ff80808103753a9901037546d26a0003]
DEBUG 2007-07-04 21:46:20,310 DefaultLoadEventListener:doLoad - resolved
object in session cache:
[org.apache.roller.pojos.WebsiteData#ff80808103753a9901037546d26a0003]
DEBUG 2007-07-04 21:46:20,311
DefaultLoadEventListener:assembleCacheEntry - Cached Version: null
DEBUG 2007-07-04 21:46:20,311
StatefulPersistenceContext:initializeNonLazyCollections - initializing
non-lazy collections
DEBUG 2007-07-04 21:46:20,312 DefaultLoadEventListener:doLoad - resolved
object in second-level cache:
[org.apache.roller.pojos.WeblogCategoryData#ff80808103753a9901037546d26b0004]
DEBUG 2007-07-04 21:46:20,312
DefaultLoadEventListener:assembleCacheEntry - Cached Version: null
DEBUG 2007-07-04 21:46:20,312
StatefulPersistenceContext:initializeNonLazyCollections - initializing
non-lazy collections
DEBUG 2007-07-04 21:46:20,313 DefaultLoadEventListener:doLoad - resolved
object in second-level cache:
[org.apache.roller.pojos.WebsiteData#ff80808103753a9901037546d26a0003]
DEBUG 2007-07-04 21:46:20,313 ApplicationDispatcher:<init> -
servletPath=/roller-ui/rendering/page,
pathInfo=/cetixx/entry/linux_i_o_scheduler_aendern, queryString=null,
name=null
DEBUG 2007-07-04 21:46:20,314 ApplicationDispatcher:doForward - Path
Based Forward
DEBUG 2007-07-04 21:46:20,314
ThreadLocalSessionContext$TransactionProtectionWrapper:invoke - allowing
proxied method [beginTransaction] to proceed to real session
DEBUG 2007-07-04 21:46:20,315
ThreadLocalSessionContext$TransactionProtectionWrapper:invoke - allowing
proxied method [get] to proceed to real session
DEBUG 2007-07-04 21:46:20,315 DefaultLoadEventListener:proxyOrLoad -
loading entity:
[org.apache.roller.pojos.RollerPropertyData#site.frontpage.weblog.aggregated]
DEBUG 2007-07-04 21:46:20,316 DefaultLoadEventListener:doLoad -
attempting to resolve:
[org.apache.roller.pojos.RollerPropertyData#site.frontpage.weblog.aggregated]
DEBUG 2007-07-04 21:46:20,316 ReadWriteCache:get - Cache lookup:
org.apache.roller.pojos.RollerPropertyData#site.frontpage.weblog.aggregated
DEBUG 2007-07-04 21:46:20,317 EhCache:get - key:
org.apache.roller.pojos.RollerPropertyData#site.frontpage.weblog.aggregated
DEBUG 2007-07-04 21:46:20,317 MemoryStore:get -
org.apache.roller.pojos.RollerPropertyDataCache: MemoryStore hit for
org.apache.roller.pojos.RollerPropertyData#site.frontpage.weblog.aggregated
DEBUG 2007-07-04 21:46:20,318 Cache:isExpired -
org.apache.roller.pojos.RollerPropertyData#site.frontpage.weblog.aggregated
now: 1183578380318
DEBUG 2007-07-04 21:46:20,318 Cache:isExpired -
org.apache.roller.pojos.RollerPropertyData#site.frontpage.weblog.aggregated
CreationTime: 1183552667209 Next To Last Access Time: 1183578327707
DEBUG 2007-07-04 21:46:20,319 Cache:isExpired -
org.apache.roller.pojos.RollerPropertyData#site.frontpage.weblog.aggregated
mostRecentTime: 1183578327707
DEBUG 2007-07-04 21:46:20,319 Cache:isExpired -
org.apache.roller.pojos.RollerPropertyData#site.frontpage.weblog.aggregated
Age to Idle: 0 Age Idled: 52611
DEBUG 2007-07-04 21:46:20,320 Cache:isExpired -
org.apache.roller.pojos.RollerPropertyData: Is element with key
org.apache.roller.pojos.RollerPropertyData#site.frontpage.weblog.aggregated
expired?: false
DEBUG 2007-07-04 21:46:20,320 ReadWriteCache:get - Cache hit:
org.apache.roller.pojos.RollerPropertyData#site.frontpage.weblog.aggregated
DEBUG 2007-07-04 21:46:20,321
DefaultLoadEventListener:assembleCacheEntry - assembling entity from
second-level cache:
[org.apache.roller.pojos.RollerPropertyData#site.frontpage.weblog.aggregated]
DEBUG 2007-07-04 21:46:20,321
DefaultLoadEventListener:assembleCacheEntry - Cached Version: null
DEBUG 2007-07-04 21:46:20,322
StatefulPersistenceContext:initializeNonLazyCollections - initializing
non-lazy collections
DEBUG 2007-07-04 21:46:20,322 DefaultLoadEventListener:doLoad - resolved
object in second-level cache:
[org.apache.roller.pojos.RollerPropertyData#site.frontpage.weblog.aggregated]
DEBUG 2007-07-04 21:46:20,323
ThreadLocalSessionContext$TransactionProtectionWrapper:invoke - allowing
proxied method [beginTransaction] to proceed to real session
DEBUG 2007-07-04 21:46:20,323
ThreadLocalSessionContext$TransactionProtectionWrapper:invoke - allowing
proxied method [get] to proceed to real session
DEBUG 2007-07-04 21:46:20,324 DefaultLoadEventListener:proxyOrLoad -
loading entity:
[org.apache.roller.pojos.RollerPropertyData#site.frontpage.weblog.handle]
DEBUG 2007-07-04 21:46:20,324 DefaultLoadEventListener:doLoad -
attempting to resolve:
[org.apache.roller.pojos.RollerPropertyData#site.frontpage.weblog.handle]
DEBUG 2007-07-04 21:46:20,325 ReadWriteCache:get - Cache lookup:
org.apache.roller.pojos.RollerPropertyData#site.frontpage.weblog.handle
DEBUG 2007-07-04 21:46:20,325 EhCache:get - key:
org.apache.roller.pojos.RollerPropertyData#site.frontpage.weblog.handle
DEBUG 2007-07-04 21:46:20,326 MemoryStore:get -
org.apache.roller.pojos.RollerPropertyDataCache: MemoryStore hit for
org.apache.roller.pojos.RollerPropertyData#site.frontpage.weblog.handle
DEBUG 2007-07-04 21:46:20,327 Cache:isExpired -
org.apache.roller.pojos.RollerPropertyData#site.frontpage.weblog.handle
now: 1183578380327
DEBUG 2007-07-04 21:46:20,327 Cache:isExpired -
org.apache.roller.pojos.RollerPropertyData#site.frontpage.weblog.handle
Creation Time: 1183552667224 Next To Last Access Time: 1183578327716
DEBUG 2007-07-04 21:46:20,328 Cache:isExpired -
org.apache.roller.pojos.RollerPropertyData#site.frontpage.weblog.handle
mostRecentTime: 1183578327716
DEBUG 2007-07-04 21:46:20,328 Cache:isExpired -
org.apache.roller.pojos.RollerPropertyData#site.frontpage.weblog.handle
Age to Idle:0 Age Idled: 52611
DEBUG 2007-07-04 21:46:20,329 Cache:isExpired -
org.apache.roller.pojos.RollerPropertyData: Is element with key
org.apache.roller.pojos.RollerPropertyData#site.frontpage.weblog.handle
expired?: false
DEBUG 2007-07-04 21:46:20,330 ReadWriteCache:get - Cache hit:
org.apache.roller.pojos.RollerPropertyData#site.frontpage.weblog.handle
DEBUG 2007-07-04 21:46:20,330
DefaultLoadEventListener:assembleCacheEntry - assembling entity from
second-level cache:
[org.apache.roller.pojos.RollerPropertyData#site.frontpage.weblog.handle]
DEBUG 2007-07-04 21:46:20,331
DefaultLoadEventListener:assembleCacheEntry - Cached Version: null
DEBUG 2007-07-04 21:46:20,331
StatefulPersistenceContext:initializeNonLazyCollections - initializing
non-lazy collections
DEBUG 2007-07-04 21:46:20,332 DefaultLoadEventListener:doLoad - resolved
object in second-level cache:
[org.apache.roller.pojos.RollerPropertyData#site.frontpage.weblog.handle]
DEBUG 2007-07-04 21:46:20,333
ThreadLocalSessionContext$TransactionProtectionWrapper:invoke - allowing
proxied method [beginTransaction] to proceed to real session
DEBUG 2007-07-04 21:46:20,333
ThreadLocalSessionContext$TransactionProtectionWrapper:invoke - allowing
proxied method [get] to proceed to real session
DEBUG 2007-07-04 21:46:20,334 DefaultLoadEventListener:proxyOrLoad -
loading entity:
[org.apache.roller.pojos.WebsiteData#ff80808103753a9901037546d26a0003]
DEBUG 2007-07-04 21:46:20,334 DefaultLoadEventListener:doLoad -
attempting to resolve:
[org.apache.roller.pojos.WebsiteData#ff80808103753a9901037546d26a0003]
DEBUG 2007-07-04 21:46:20,335 DefaultLoadEventListener:doLoad - resolved
object in session cache:
[org.apache.roller.pojos.WebsiteData#ff80808103753a9901037546d26a0003]
DEBUG 2007-07-04 21:46:20,335
ThreadLocalSessionContext$TransactionProtectionWrapper:invoke - allowing
proxied method [beginTransaction] to proceed to real session
DEBUG 2007-07-04 21:46:20,336
ThreadLocalSessionContext$TransactionProtectionWrapper:invoke - allowing
proxied method [get] to proceed to real session
DEBUG 2007-07-04 21:46:20,336 DefaultLoadEventListener:proxyOrLoad -
loading entity:
[org.apache.roller.pojos.RollerPropertyData#site.frontpage.weblog.aggregated]
DEBUG 2007-07-04 21:46:20,337 DefaultLoadEventListener:doLoad -
attempting to resolve:
[org.apache.roller.pojos.RollerPropertyData#site.frontpage.weblog.aggregated]
DEBUG 2007-07-04 21:46:20,337 DefaultLoadEventListener:doLoad - resolved
object in session cache:
[org.apache.roller.pojos.RollerPropertyData#site.frontpage.weblog.aggregated]
DEBUG 2007-07-04 21:46:20,338
ThreadLocalSessionContext$TransactionProtectionWrapper:invoke - allowing
proxied method [beginTransaction] to proceed to real session
DEBUG 2007-07-04 21:46:20,338
ThreadLocalSessionContext$TransactionProtectionWrapper:invoke - allowing
proxied method [get] to proceed to real session
DEBUG 2007-07-04 21:46:20,339 DefaultLoadEventListener:proxyOrLoad -
loading entity:
[org.apache.roller.pojos.RollerPropertyData#site.frontpage.weblog.handle]
DEBUG 2007-07-04 21:46:20,339 DefaultLoadEventListener:doLoad -
attempting to resolve:
[org.apache.roller.pojos.RollerPropertyData#site.frontpage.weblog.handle]
DEBUG 2007-07-04 21:46:20,340 DefaultLoadEventListener:doLoad - resolved
object in session cache:
[org.apache.roller.pojos.RollerPropertyData#site.frontpage.weblog.handle]
DEBUG 2007-07-04 21:46:20,344 ApplicationDispatcher:doForward -
Disabling the response for futher output
DEBUG 2007-07-04 21:46:20,344
ThreadLocalSessionContext$TransactionProtectionWrapper:invoke - allowing
proxied method [isOpen] to proceed to real session
DEBUG 2007-07-04 21:46:20,345
ThreadLocalSessionContext$TransactionProtectionWrapper:invoke - allowing
proxied method [getTransaction] to proceed to real session
DEBUG 2007-07-04 21:46:20,345 JDBCTransaction:rollback - rollback
DEBUG 2007-07-04 21:46:20,345 JDBCTransaction:toggleAutoCommit -
re-enabling autocommit
DEBUG 2007-07-04 21:46:20,346 JDBCTransaction:rollback - rolled back
JDBC Connection
DEBUG 2007-07-04 21:46:20,346 JDBCContext:afterTransactionCompletion -
after transaction completion
DEBUG 2007-07-04 21:46:20,346 ConnectionManager:aggressiveRelease -
aggressively releasing JDBC connection
DEBUG 2007-07-04 21:46:20,346 ConnectionManager:closeConnection -
releasing JDBC connection [ (open PreparedStatements: 0, globally:
0) (open ResultSets: 0, globally: 0)]
DEBUG 2007-07-04 21:46:20,347 SessionImpl:afterTransactionCompletion -
after transaction completion
DEBUG 2007-07-04 21:46:20,347 SessionImpl:managedClose - automatically
closing session
DEBUG 2007-07-04 21:46:20,347 SessionImpl:close - closing session
DEBUG 2007-07-04 21:46:20,347 ConnectionManager:cleanup - connection
already null in cleanup : no action
DEBUG 2007-07-04 21:46:20,348
ThreadLocalSessionContext$TransactionProtectionWrapper:invoke - allowing
proxied method [isOpen] to proceed to real session
DEBUG 2007-07-04 21:46:20,959 SessionImpl:<init> - opened session at
timestamp: 4847937048408064
DEBUG 2007-07-04 21:46:20,960
ThreadLocalSessionContext$TransactionProtectionWrapper:invoke - allowing
proxied method [isOpen] to proceed to real session
DEBUG 2007-07-04 21:46:20,960
ThreadLocalSessionContext$TransactionProtectionWrapper:invoke - allowing
method [getTransaction] in non-transacted context
DEBUG 2007-07-04 21:46:20,960
ThreadLocalSessionContext$TransactionProtectionWrapper:invoke - allowing
proxied method [getTransaction] to proceed to real session
DEBUG 2007-07-04 21:46:20,961
ThreadLocalSessionContext$TransactionProtectionWrapper:invoke - allowing
proxied method [isOpen] to proceed to real session
DEBUG 2007-07-04 21:46:20,961
ThreadLocalSessionContext$TransactionProtectionWrapper:invoke - allowing
proxied method [close] to proceed to real session
DEBUG 2007-07-04 21:46:20,961 SessionImpl:close - closing session
DEBUG 2007-07-04 21:46:20,961 ConnectionManager:cleanup - connection
already null in cleanup : no action
Hope the output helps the find the problem. Thank you very much for your
support!
Greetings
Robert
Anil Gangolli wrote:
>
> You are probably seeing the sequence:
>
> DEBUG 2007-06-30 09:33:09,072 RequestMappingFilter:doFilter -
> entering DEBUG 2007-06-30 09:33:09,073 RequestMappingFilter:doFilter
> - trying mapper org.apache.roller.ui.rendering.WeblogRequestMapper
> DEBUG 2007-06-30 09:33:09,073 WeblogRequestMapper:handleRequest -
> evaluating [/blog/CommentAuthenticatorServlet] DEBUG 2007-06-30
> 09:33:09,077 WeblogRequestMapper:handleRequest - potential weblog
> handle = CommentAuthenticatorServlet DEBUG 2007-06-30 09:33:09,078
> WeblogRequestMapper:handleRequest - SKIPPED
> CommentAuthenticatorServlet DEBUG 2007-06-30 09:33:09,079
> RequestMappingFilter:doFilter - request not mapped DEBUG 2007-06-30
> 09:33:09,080 RequestMappingFilter:doFilter - exiting
>
> This is normal and should be occurring while the comment form is
> loading not being submitted. The CommentAuthenticatorServlet supplies
> the HTML that drives the client-side comment authentication.
>
> At posting time, you should be seeing something more like the
> following. Try to find the corresponding fragment (or at least the
> beginning of it). Let us know where it diverges from the sequence
> below and that will provide a clue.
>
> If the posting request does not look like url to the blog entry, you
> probably do not have a fully converted theme.
>
>
> DEBUG 2007-06-30 09:36:22,883 RequestMappingFilter:doFilter -
> entering DEBUG 2007-06-30 09:36:22,884 RequestMappingFilter:doFilter
> - trying mapper org.apache.roller.ui.rendering.WeblogRequestMapper
> DEBUG 2007-06-30 09:36:22,885 WeblogRequestMapper:handleRequest -
> evaluating [/blog/anil/entry/restoring_habeas_corpus] DEBUG
> 2007-06-30 09:36:22,886 WeblogRequestMapper:handleRequest - potential
> weblog handle = anil DEBUG 2007-06-30 09:36:22,887
> WeblogRequestMapper:isWeblog - checking weblog handle anil DEBUG
> 2007-06-30 09:36:22,887 HibernatePersistenceStrategy:getSession -
> Opening Hibernate Session DEBUG 2007-06-30 09:36:22,891
> HibernateUserManagerImpl:getWebsiteByHandle - weblogHandleToId CACHE
> HIT - anil DEBUG 2007-06-30 09:36:22,892
> WeblogRequestMapper:handleRequest - WEBLOG_URL
> /anil/entry/restoring_habeas_corpus DEBUG 2007-06-30 09:36:22,897
> WeblogRequestMapper:calculateForwardUrl -
> anil,null,entry,restoring_habeas_corpus DEBUG 2007-06-30 09:36:22,899
> WeblogRequestMapper:calculateForwardUrl - FORWARD_URL
> /roller-ui/rendering/comment/anil/entry/restoring_habeas_corpus DEBUG
> 2007-06-30 09:36:22,900 WeblogRequestMapper:handleRequest -
> forwarding to
> /roller-ui/rendering/comment/anil/entry/restoring_habeas_corpus DEBUG
> 2007-06-30 09:36:22,901 CharEncodingFilter:doFilter - Processing
> CharEncodingFilter DEBUG 2007-06-30 09:36:22,902
> CharEncodingFilter:doFilter - Set request character encoding to UTF-8
> DEBUG 2007-06-30 09:36:22,902 StrutsCharEncodingFilter:doFilter -
> Processing CharEncodingFilter DEBUG 2007-06-30 09:36:22,903
> StrutsCharEncodingFilter:doFilter - Synchronizing JSTL and Struts
> locales DEBUG 2007-06-30 09:36:22,904
> StrutsCharEncodingFilter:doFilter - Set request character encoding to
> UTF-8 DEBUG 2007-06-30 09:36:22,909 IPBanList:<init> - INIT DEBUG
> 2007-06-30 09:36:22,910 RollerConfig:getProperty - Fetching property
> [ipbanlist.file=null] DEBUG 2007-06-30 09:36:22,914
> WeblogRequest:<init> - parsing path
> /anil/entry/restoring_habeas_corpus DEBUG 2007-06-30 09:36:22,915
> WeblogRequest:<init> - handle = anil DEBUG 2007-06-30 09:36:22,916
> WeblogRequest:<init> - locale = null DEBUG 2007-06-30 09:36:22,918
> WeblogRequest:<init> - pathInfo = entry/restoring_habeas_corpus DEBUG
> 2007-06-30 09:36:22,919 WeblogCommentRequest:<init> - name = Anil
> DEBUG 2007-06-30 09:36:22,923 WeblogCommentRequest:<init> - email =
> anil@busybuddha.org DEBUG 2007-06-30 09:36:22,925
> WeblogCommentRequest:<init> - url = DEBUG 2007-06-30 09:36:22,926
> WeblogCommentRequest:<init> - content = temporary test comment DEBUG
> 2007-06-30 09:36:22,927 WeblogCommentRequest:<init> - notify = false
> DEBUG 2007-06-30 09:36:22,929 WeblogCommentRequest:<init> -
> weblogAnchor = restoring_habeas_corpus DEBUG 2007-06-30 09:36:22,930
> HibernatePersistenceStrategy:getSession - Opening Hibernate Session
> DEBUG 2007-06-30 09:36:22,931
> HibernateUserManagerImpl:getWebsiteByHandle - weblogHandleToId CACHE
> HIT - anil DEBUG 2007-06-30 09:36:22,933
> HibernatePersistenceStrategy:getSession - Opening Hibernate Session
> DEBUG 2007-06-30 09:36:22,934
> HibernateUserManagerImpl:getWebsiteByHandle - weblogHandleToId CACHE
> HIT - anil DEBUG 2007-06-30 09:36:22,936
> HibernatePersistenceStrategy:getSession - Opening Hibernate Session
> DEBUG 2007-06-30 09:36:22,939
> HibernateWeblogManagerImpl:getWeblogEntryByAnchor -
> entryAnchorToIdMap CACHE HIT - anil:restoring_habeas_corpus DEBUG
> 2007-06-30 09:36:22,943 CommentServlet:doPost - Doing comment posting
> for entry = /anil/entry/restoring_habeas_corpus
>
>
> --a.
>
>
>
>
> ----- Original Message ----- From: "RW" <ro...@tauceti.net> To:
> <us...@roller.apache.org> Sent: Thursday, June 28, 2007 2:48 PM
> Subject: Re: Comments do not work anymore
>
>
> > Thanks for your reply!
> >> Some general suggestions:
> >>
> >> Try checking the entries in the database (the "roller_comment"
> >> table) directly. Verify that your posted comments are making it
> >> there and are in approved state (approved flag is 1).
> > I've checked this. The comments are not making it there. If I post
> > a comment nothing get's inserted into "roller_comment" table. As a
> > additional note: The time comments have worked and after submitting
> > a comment the user got the message:
> >
> > "Your comment has been submitted to the moderator for approval."
> >
> > This text doesn't appear anymore.
> >
> >>
> >> Check that your theme is using up-to-date macros for displaying
> >> comments.
> >>
> > The macros are up to date but I think that displaying isn't the
> > problem. The comments aren't making it into the database.
> >> Try enabling DEBUG logging broadly.
> > I've enabled it but I really don't see anything usefull. After
> > clearing the cache I submitted a comment and get 250 KByte of
> > logfile. I don't want to post it here because of the size. Normally
> > I would expect to see the comment text as a binding variable but
> > that's not the case. I've also enabled hibernate logging but I
> > don't see any entries which shows me the problem.
> >
> > When the cache is filled and I submit a comment the only entries in
> > the logfile I get are:
> >
> > DEBUG 2007-06-28 22:23:51,543 WeblogRequestMapper:handleRequest -
> > evaluating [/roller/CommentAuthenticatorServlet] DEBUG 2007-06-28
> > 22:23:51,543 WeblogRequestMapper:handleRequest - potential weblog
> > handle = CommentAuthenticatorServlet DEBUG 2007-06-28 22:23:51,544
> > WeblogRequestMapper:handleRequest - SKIPPED
> > CommentAuthenticatorServlet
> >
> > Any hints for what queries I especially should look for?
> >
> > Greetings Robert
> >
> >>
> >> --a.
> >>
> >> ----- Original Message ----- From: "RW" <ro...@tauceti.net> To:
> >> <us...@roller.apache.org> Sent: Wednesday, June 27, 2007 12:55 PM
> >> Subject: Comments do not work anymore
> >>
> >>
> >>> Hi!
> >>>
> >>> I'm using Roller 3.1 for a while now (updated from several
> >>> versions during the last years...) and I've just recognized
> >>> that the comments are not working anymore. I'm using Tomcat 5.5
> >>> and Java 1.5 on Linux (Gentoo 2007.1).
> >>>
> >>> Checking the output of catalina.out and roller.log gives me
> >>> absolutely no hint what's going on. There is no entry (error)
> >>> in the log files when I try to make a comment and press "Post"
> >>> button.
> >>>
> >>> Formerly I've configured the comments to be moderated. I
> >>> disabled it but still no comments possible. Comments are of
> >>> course allowed in the weblog settings and by default comments
> >>> for new entries are also allowed for an unlimited time.
> >>>
> >>> Are there anyboy who can give me some hints? Any ways I can
> >>> track this?
> >>>
> >>> Thank you very much! Robert
> >>>
> >>
> >
>
Re: Comments do not work anymore
Posted by Allen Gilliland <al...@sun.com>.
actually, that is definitely the right thing to do. the absolute site
url is supposed to point to the root of the roller application, wherever
it happens to be deployed, so it is incorrect to leave out the /roller part.
-- Allen
RW wrote:
> I've now changed "absolute url for your site" in server adminstration
> from http://www.tauceti.net
> to http://www.tauceti.net/roller and now it works. I think that this
> isn't the "real" solution it's
> just a workaround. Maybe someone comes up with another solution but it
> works for now. I've
> to set the parameter since internally the daemon has another Url than
> externally.
>
> Many thanks for your support Anil!
> Robert
>
> RW wrote:
>> Well I think I've found the problem. I've just to figure out what
>> solution I should apply.
>> Here's the problem: Someone comes to my homepage I redirect him to
>> /roller/cetixx/.
>> Now he want's to comment and clicks the comment link. Now all comment
>> links goes to
>> /cetixx/entry/arkanoid_nostalgique_remake#comments . But that don't
>> work since /roller
>> is the webapp and not /cetixx. So I've created a RewriteRule in Apache
>> to redirect the
>> request to /roller/cetixx/entry/... Well and there the POST is getting
>> a GET...
>>
>> I've looked into the html source and it looks like this:
>>
>> <form method="post"
>> action="http://www.tauceti.net/cetixx/entry/arkanoid_nostalgique_remake"
>> focus="name"
>> name="form" onsubmit="fixURL(this); return validateComments(this)">
>>
>> So the question is: How do I get /roller into
>> $url.entry($entry.anchor) in weblog.vm?
>> I'll try to find it out.
>>
>> Thank you very much for your help!
>>
>> Robert
>>
>> Anil Gangolli wrote:
>>>
>>> Restricting attention to the last log excerpt from the comment
>>> posting to the testblog,
>>> it looks like the server is processing a GET for
>>> /roller/testblog/entry/first_entry rather than
>>> a POST. Assuming you got the right chunk of the the log, this
>>> suggests you need to look at
>>> your comment form.
>>>
>>> You can view the page source just before posting the comment and find
>>> the comment form HTML fragment.
>>> The action should be a POST to the entry URL. The form should begin
>>> with an element that looks something
>>> like this. If it does not, you are probably using old macros; check
>>> that your theme is showing the form by
>>> doing a #showWeblogEntryCommentForm($entry)
>>>
>>> <form method="post"
>>> action=http://yourhostname/roller/testblog/entry/first_entry
>>> focus="name"
>>> name="commentForm" onsubmit="fixURL(this); return
>>> validateComments(this)">
>>>
>>>
>>> Also, on the off-chance this is a browser-specific issue, what
>>> version of browser are you using and do you
>>> have any unusual plugins enabled?
>>>
>>> --a.
>>>
>>
>
Re: Comments do not work anymore
Posted by RW <ro...@tauceti.net>.
I've now changed "absolute url for your site" in server adminstration
from http://www.tauceti.net
to http://www.tauceti.net/roller and now it works. I think that this
isn't the "real" solution it's
just a workaround. Maybe someone comes up with another solution but it
works for now. I've
to set the parameter since internally the daemon has another Url than
externally.
Many thanks for your support Anil!
Robert
RW wrote:
> Well I think I've found the problem. I've just to figure out what
> solution I should apply.
> Here's the problem: Someone comes to my homepage I redirect him to
> /roller/cetixx/.
> Now he want's to comment and clicks the comment link. Now all comment
> links goes to
> /cetixx/entry/arkanoid_nostalgique_remake#comments . But that don't
> work since /roller
> is the webapp and not /cetixx. So I've created a RewriteRule in Apache
> to redirect the
> request to /roller/cetixx/entry/... Well and there the POST is getting
> a GET...
>
> I've looked into the html source and it looks like this:
>
> <form method="post"
> action="http://www.tauceti.net/cetixx/entry/arkanoid_nostalgique_remake"
> focus="name"
> name="form" onsubmit="fixURL(this); return validateComments(this)">
>
> So the question is: How do I get /roller into
> $url.entry($entry.anchor) in weblog.vm?
> I'll try to find it out.
>
> Thank you very much for your help!
>
> Robert
>
> Anil Gangolli wrote:
>>
>> Restricting attention to the last log excerpt from the comment
>> posting to the testblog,
>> it looks like the server is processing a GET for
>> /roller/testblog/entry/first_entry rather than
>> a POST. Assuming you got the right chunk of the the log, this
>> suggests you need to look at
>> your comment form.
>>
>> You can view the page source just before posting the comment and find
>> the comment form HTML fragment.
>> The action should be a POST to the entry URL. The form should begin
>> with an element that looks something
>> like this. If it does not, you are probably using old macros; check
>> that your theme is showing the form by
>> doing a #showWeblogEntryCommentForm($entry)
>>
>> <form method="post"
>> action=http://yourhostname/roller/testblog/entry/first_entry
>> focus="name"
>> name="commentForm" onsubmit="fixURL(this); return
>> validateComments(this)">
>>
>>
>> Also, on the off-chance this is a browser-specific issue, what
>> version of browser are you using and do you
>> have any unusual plugins enabled?
>>
>> --a.
>>
>
Re: Comments do not work anymore
Posted by RW <ro...@tauceti.net>.
Well I think I've found the problem. I've just to figure out what
solution I should apply.
Here's the problem: Someone comes to my homepage I redirect him to
/roller/cetixx/.
Now he want's to comment and clicks the comment link. Now all comment
links goes to
/cetixx/entry/arkanoid_nostalgique_remake#comments . But that don't work
since /roller
is the webapp and not /cetixx. So I've created a RewriteRule in Apache
to redirect the
request to /roller/cetixx/entry/... Well and there the POST is getting a
GET...
I've looked into the html source and it looks like this:
<form method="post"
action="http://www.tauceti.net/cetixx/entry/arkanoid_nostalgique_remake"
focus="name"
name="form" onsubmit="fixURL(this); return validateComments(this)">
So the question is: How do I get /roller into $url.entry($entry.anchor)
in weblog.vm?
I'll try to find it out.
Thank you very much for your help!
Robert
Anil Gangolli wrote:
>
> Restricting attention to the last log excerpt from the comment posting
> to the testblog,
> it looks like the server is processing a GET for
> /roller/testblog/entry/first_entry rather than
> a POST. Assuming you got the right chunk of the the log, this
> suggests you need to look at
> your comment form.
>
> You can view the page source just before posting the comment and find
> the comment form HTML fragment.
> The action should be a POST to the entry URL. The form should begin
> with an element that looks something
> like this. If it does not, you are probably using old macros; check
> that your theme is showing the form by
> doing a #showWeblogEntryCommentForm($entry)
>
> <form method="post"
> action=http://yourhostname/roller/testblog/entry/first_entry focus="name"
> name="commentForm" onsubmit="fixURL(this); return
> validateComments(this)">
>
>
> Also, on the off-chance this is a browser-specific issue, what version
> of browser are you using and do you
> have any unusual plugins enabled?
>
> --a.
>
Re: Comments do not work anymore
Posted by Anil Gangolli <an...@busybuddha.org>.
Restricting attention to the last log excerpt from the comment posting to
the testblog,
it looks like the server is processing a GET for
/roller/testblog/entry/first_entry rather than
a POST. Assuming you got the right chunk of the the log, this suggests you
need to look at
your comment form.
You can view the page source just before posting the comment and find the
comment form HTML fragment.
The action should be a POST to the entry URL. The form should begin with an
element that looks something
like this. If it does not, you are probably using old macros; check that
your theme is showing the form by
doing a #showWeblogEntryCommentForm($entry)
<form method="post"
action=http://yourhostname/roller/testblog/entry/first_entry focus="name"
name="commentForm" onsubmit="fixURL(this); return
validateComments(this)">
Also, on the off-chance this is a browser-specific issue, what version of
browser are you using and do you
have any unusual plugins enabled?
--a.
----- Original Message -----
From: "RW" <ro...@tauceti.net>
To: <us...@roller.apache.org>
Sent: Thursday, July 05, 2007 11:14 AM
Subject: Re: Comments do not work anymore
> Hi!
>
> Oh... Sorry! I've had enabled
>
> log4j.rootCategory=DEBUG,roller
>
> But I thought that this would enable all logging possible. Ok. Now I've
> configured
>
> log4j.category.org.apache.roller=DEBUG
> log4j.category.net.java.roller=DEBUG
>
> and switched to BASIC theme. Now the log looks like this when pressing the
> submit button:
>
> DEBUG 2007-07-05 19:33:11,421 CharEncodingFilter:doFilter - Processing
> CharEncodingFilter
> DEBUG 2007-07-05 19:33:11,422 CharEncodingFilter:doFilter - Set request
> character encoding to UTF-8
> DEBUG 2007-07-05 19:33:11,422 PersistenceSessionFilter:doFilter - Entered
> PersistenceSessionFilter
> DEBUG 2007-07-05 19:33:11,423 RequestMappingFilter:doFilter - entering
> DEBUG 2007-07-05 19:33:11,423 RequestMappingFilter:doFilter - trying
> mapper org.apache.roller.ui.rendering.WeblogRequestMapper
> DEBUG 2007-07-05 19:33:11,423 WeblogRequestMapper:handleRequest -
> evaluating [/roller/cetixx/entry/arkanoid_nostalgique_remake]
> DEBUG 2007-07-05 19:33:11,423 WeblogRequestMapper:handleRequest -
> potential weblog handle = cetixx
> DEBUG 2007-07-05 19:33:11,424 WeblogRequestMapper:isWeblog - checking
> weblog handle cetixx
> DEBUG 2007-07-05 19:33:11,424 HibernatePersistenceStrategy:getSession -
> Opening Hibernate Session
> DEBUG 2007-07-05 19:33:11,427
> HibernateUserManagerImpl:getWebsiteByHandle - weblogHandleToId CACHE HIT -
> cetixx
> DEBUG 2007-07-05 19:33:11,428 WeblogRequestMapper:handleRequest -
> WEBLOG_URL /cetixx/entry/arkanoid_nostalgique_remake
> DEBUG 2007-07-05 19:33:11,428 WeblogRequestMapper:calculateForwardUrl -
> cetixx,null,entry,arkanoid_nostalgique_remake
> DEBUG 2007-07-05 19:33:11,428 WeblogRequestMapper:calculateForwardUrl -
> FORWARD_URL
> /roller-ui/rendering/page/cetixx/entry/arkanoid_nostalgique_remake
> DEBUG 2007-07-05 19:33:11,429 WeblogRequestMapper:handleRequest -
> forwarding to
> /roller-ui/rendering/page/cetixx/entry/arkanoid_nostalgique_remake
> DEBUG 2007-07-05 19:33:11,429 CharEncodingFilter:doFilter - Processing
> CharEncodingFilter
> DEBUG 2007-07-05 19:33:11,429 CharEncodingFilter:doFilter - Set request
> character encoding to UTF-8
> DEBUG 2007-07-05 19:33:11,430 StrutsCharEncodingFilter:doFilter -
> Processing CharEncodingFilter
> DEBUG 2007-07-05 19:33:11,430 StrutsCharEncodingFilter:doFilter -
> Synchronizing JSTL and Struts locales
> DEBUG 2007-07-05 19:33:11,430 StrutsCharEncodingFilter:doFilter - Set
> request character encoding to UTF-8
> DEBUG 2007-07-05 19:33:11,431 PageServlet:doGet - Entering
> DEBUG 2007-07-05 19:33:11,431 PageServlet:processReferrer - processing
> referrer for
> /roller/roller-ui/rendering/page/cetixx/entry/arkanoid_nostalgique_remake
> DEBUG 2007-07-05 19:33:11,432 WeblogRequest:<init> - parsing path
> /cetixx/entry/arkanoid_nostalgique_remake
> DEBUG 2007-07-05 19:33:11,432 WeblogRequest:<init> - handle = cetixx
> DEBUG 2007-07-05 19:33:11,433 WeblogRequest:<init> - locale = null
> DEBUG 2007-07-05 19:33:11,433 WeblogRequest:<init> - pathInfo =
> entry/arkanoid_nostalgique_remake
> DEBUG 2007-07-05 19:33:11,434 WeblogPageRequest:<init> - parsing path
> entry/arkanoid_nostalgique_remake
> DEBUG 2007-07-05 19:33:11,434 WeblogPageRequest:<init> - context = entry
> DEBUG 2007-07-05 19:33:11,434 WeblogPageRequest:<init> - weblogAnchor =
> arkanoid_nostalgique_remake
> DEBUG 2007-07-05 19:33:11,435 WeblogPageRequest:<init> - weblogDate = null
> DEBUG 2007-07-05 19:33:11,435 WeblogPageRequest:<init> - weblogCategory =
> null
> DEBUG 2007-07-05 19:33:11,436 WeblogPageRequest:<init> - tags = null
> DEBUG 2007-07-05 19:33:11,436 WeblogPageRequest:<init> - weblogPage = null
> DEBUG 2007-07-05 19:33:11,437 WeblogPageRequest:<init> - pageNum = 0
> DEBUG 2007-07-05 19:33:11,437 HibernatePersistenceStrategy:getSession -
> Opening Hibernate Session
> DEBUG 2007-07-05 19:33:11,438 RollerRuntimeConfig:getProperty - fetched
> property [site.frontpage.weblog.aggregated=false]
> DEBUG 2007-07-05 19:33:11,438 HibernatePersistenceStrategy:getSession -
> Opening Hibernate Session
> DEBUG 2007-07-05 19:33:11,439 RollerRuntimeConfig:getProperty - fetched
> property [site.frontpage.weblog.handle=cetixx]
> DEBUG 2007-07-05 19:33:11,439 PageServlet:processReferrer - referrer =
> http://www.tauceti.net/roller/cetixx/entry/arkanoid_nostalgique_remake
> DEBUG 2007-07-05 19:33:11,440 PageServlet:processReferrer - skipping
> referrer from own blog
> DEBUG 2007-07-05 19:33:11,440 WeblogRequest:<init> - parsing path
> /cetixx/entry/arkanoid_nostalgique_remake
> DEBUG 2007-07-05 19:33:11,440 PageServlet:processReferrer - skipping
> referrer from own blog
> DEBUG 2007-07-05 19:33:11,440 WeblogRequest:<init> - parsing path
> /cetixx/entry/arkanoid_nostalgique_remake
> DEBUG 2007-07-05 19:33:11,441 WeblogRequest:<init> - handle = cetixx
> DEBUG 2007-07-05 19:33:11,441 WeblogRequest:<init> - locale = null
> DEBUG 2007-07-05 19:33:11,442 WeblogRequest:<init> - pathInfo =
> entry/arkanoid_nostalgique_remake
> DEBUG 2007-07-05 19:33:11,442 WeblogPageRequest:<init> - parsing path
> entry/arkanoid_nostalgique_remake
> DEBUG 2007-07-05 19:33:11,443 WeblogPageRequest:<init> - context = entry
> DEBUG 2007-07-05 19:33:11,443 WeblogPageRequest:<init> - weblogAnchor =
> arkanoid_nostalgique_remake
> DEBUG 2007-07-05 19:33:11,443 WeblogPageRequest:<init> - weblogDate = null
> DEBUG 2007-07-05 19:33:11,444 WeblogPageRequest:<init> - weblogCategory =
> null
> DEBUG 2007-07-05 19:33:11,444 WeblogPageRequest:<init> - tags = null
> DEBUG 2007-07-05 19:33:11,445 WeblogPageRequest:<init> - weblogPage = null
> DEBUG 2007-07-05 19:33:11,445 WeblogPageRequest:<init> - pageNum = 0
> DEBUG 2007-07-05 19:33:11,446 HibernatePersistenceStrategy:getSession -
> Opening Hibernate Session
> DEBUG 2007-07-05 19:33:11,446
> HibernateUserManagerImpl:getWebsiteByHandle - weblogHandleToId CACHE HIT -
> cetixx
> DEBUG 2007-07-05 19:33:11,447 HibernatePersistenceStrategy:getSession -
> Opening Hibernate Session
> DEBUG 2007-07-05 19:33:11,447 RollerRuntimeConfig:getProperty - fetched
> property [site.frontpage.weblog.aggregated=false]
> DEBUG 2007-07-05 19:33:11,448 HibernatePersistenceStrategy:getSession -
> Opening Hibernate Session
> DEBUG 2007-07-05 19:33:11,448 RollerRuntimeConfig:getProperty - fetched
> property [site.frontpage.weblog.handle=cetixx]
> DEBUG 2007-07-05 19:33:11,449 ModDateHeaderUtil:respondIfNotModified -
> since date = 1183656069000
> DEBUG 2007-07-05 19:33:11,449 ModDateHeaderUtil:respondIfNotModified -
> last mod date (trucated to seconds) = 1183656069000
> DEBUG 2007-07-05 19:33:11,450 ModDateHeaderUtil:respondIfNotModified - NOT
> MODIFIED
> http://www.tauceti.net/roller/roller-ui/rendering/page/cetixx/entry/arkanoid_nostalgique_remake
> DEBUG 2007-07-05 19:33:11,450 CompressionFilter:doFilter - Pre-zip size:0
> DEBUG 2007-07-05 19:33:11,451 CompressionFilter:doFilter - Gzip size:20
> DEBUG 2007-07-05 19:33:11,451 RequestMappingFilter:doFilter - request
> handled by org.apache.roller.ui.rendering.WeblogRequestMapper
> DEBUG 2007-07-05 19:33:11,452 RequestMappingFilter:doFilter - exiting
> DEBUG 2007-07-05 19:33:11,452 PersistenceSessionFilter:doFilter -
> Releasing Roller Session
> DEBUG 2007-07-05 19:33:11,452 HibernatePersistenceStrategy:release -
> Closing Hibernate Session
> DEBUG 2007-07-05 19:33:11,453 HibernatePersistenceStrategy:release -
> Forcing rollback on active transaction
> DEBUG 2007-07-05 19:33:11,453 PersistenceSessionFilter:doFilter - Exiting
> PersistenceSessionFilter
> DEBUG 2007-07-05 19:33:12,122 CharEncodingFilter:doFilter - Processing
> CharEncodingFilter
> DEBUG 2007-07-05 19:33:12,122 CharEncodingFilter:doFilter - Set request
> character encoding to UTF-8
> DEBUG 2007-07-05 19:33:12,122 PersistenceSessionFilter:doFilter - Entered
> PersistenceSessionFilter
> DEBUG 2007-07-05 19:33:12,123 RequestMappingFilter:doFilter - entering
> DEBUG 2007-07-05 19:33:12,123 RequestMappingFilter:doFilter - trying
> mapper org.apache.roller.ui.rendering.WeblogRequestMapper
> DEBUG 2007-07-05 19:33:12,123 WeblogRequestMapper:handleRequest -
> evaluating [/roller/CommentAuthenticatorServlet]
> DEBUG 2007-07-05 19:33:12,123 WeblogRequestMapper:handleRequest -
> potential weblog handle = CommentAuthenticatorServlet
> DEBUG 2007-07-05 19:33:12,124 WeblogRequestMapper:handleRequest - SKIPPED
> CommentAuthenticatorServlet
> DEBUG 2007-07-05 19:33:12,124 RequestMappingFilter:doFilter - request not
> mapped
> DEBUG 2007-07-05 19:33:12,124 RequestMappingFilter:doFilter - exiting
> DEBUG 2007-07-05 19:33:12,125 PersistenceSessionFilter:doFilter -
> Releasing Roller Session
> DEBUG 2007-07-05 19:33:12,125 HibernatePersistenceStrategy:release -
> Closing Hibernate Session
> DEBUG 2007-07-05 19:33:12,125 PersistenceSessionFilter:doFilter - Exiting
> PersistenceSessionFilter
> DEBUG 2007-07-05 19:33:19,765 HibernatePersistenceStrategy:getSession -
> Opening Hibernate Session
> DEBUG 2007-07-05 19:33:19,767 RollerTask:run - Attempting to acquire lock
> DEBUG 2007-07-05 19:33:19,767 HibernatePersistenceStrategy:getSession -
> Opening Hibernate Session
> DEBUG 2007-07-05 19:33:19,768 HibernatePersistenceStrategy:getSession -
> Opening Hibernate Session
> DEBUG 2007-07-05 19:33:19,768 HibernatePersistenceStrategy:getSession -
> Opening Hibernate Session
> DEBUG 2007-07-05 19:33:19,770 RollerTask:run - Lock acquired, running task
> DEBUG 2007-07-05 19:33:19,770 PingQueueTask:runTask - task started
> DEBUG 2007-07-05 19:33:19,770 HibernatePersistenceStrategy:getSession -
> Opening Hibernate Session
> DEBUG 2007-07-05 19:33:19,770 RollerRuntimeConfig:getProperty - fetched
> property [pings.suspendPingProcessing=false]
> DEBUG 2007-07-05 19:33:19,770 HibernatePersistenceStrategy:getSession -
> Opening Hibernate Session
> DEBUG 2007-07-05 19:33:19,771 RollerRuntimeConfig:getProperty - fetched
> property [site.absoluteurl=http://www.tauceti.net]
> DEBUG 2007-07-05 19:33:19,771 PingQueueProcessor:processQueue - Started
> processing ping queue.
> DEBUG 2007-07-05 19:33:19,771 HibernatePersistenceStrategy:getSession -
> Opening Hibernate Session
> DEBUG 2007-07-05 19:33:19,778 PingQueueProcessor:processQueue - Finished
> processing ping queue.
> DEBUG 2007-07-05 19:33:19,778 HibernatePersistenceStrategy:getSession -
> Opening Hibernate Session
> DEBUG 2007-07-05 19:33:19,778 PingQueueTask:runTask - task completed
> DEBUG 2007-07-05 19:33:19,779 HibernatePersistenceStrategy:release -
> Closing Hibernate Session
> DEBUG 2007-07-05 19:33:19,779 RollerTask:run - Attempting to release lock
> DEBUG 2007-07-05 19:33:19,779 HibernatePersistenceStrategy:getSession -
> Opening Hibernate Session
> DEBUG 2007-07-05 19:33:19,780 HibernatePersistenceStrategy:getSession -
> Opening Hibernate Session
> DEBUG 2007-07-05 19:33:19,780 HibernatePersistenceStrategy:getSession -
> Opening Hibernate Session
> DEBUG 2007-07-05 19:33:19,781 RollerTask:run - Lock released, time to
> sleep
> DEBUG 2007-07-05 19:33:19,781 HibernatePersistenceStrategy:release -
> Closing Hibernate Session
> DEBUG 2007-07-05 19:33:21,043 RollerContext:sessionDestroyed -
> sessions=-6:freemem=15507072:totalmem=87818240
>
> I only see three entries which contains something like "comment"... Then
> I've created a blog "testblog"
> with BASIC theme then created a new entry and tried to comment. This is
> the output of the roller.log:
>
> DEBUG 2007-07-05 19:59:09,244 CharEncodingFilter:doFilter - Processing
> CharEncodingFilter
> DEBUG 2007-07-05 19:59:09,244 CharEncodingFilter:doFilter - Set request
> character encoding to UTF-8
> DEBUG 2007-07-05 19:59:09,244 PersistenceSessionFilter:doFilter - Entered
> PersistenceSessionFilter
> DEBUG 2007-07-05 19:59:09,245 RequestMappingFilter:doFilter - entering
> DEBUG 2007-07-05 19:59:09,245 RequestMappingFilter:doFilter - trying
> mapper org.apache.roller.ui.rendering.WeblogRequestMapper
> DEBUG 2007-07-05 19:59:09,245 WeblogRequestMapper:handleRequest -
> evaluating [/roller/testblog/entry/first_entry]
> DEBUG 2007-07-05 19:59:09,246 WeblogRequestMapper:handleRequest -
> potential weblog handle = testblog
> DEBUG 2007-07-05 19:59:09,246 WeblogRequestMapper:isWeblog - checking
> weblog handle testblog
> DEBUG 2007-07-05 19:59:09,246 HibernatePersistenceStrategy:getSession -
> Opening Hibernate Session
> DEBUG 2007-07-05 19:59:09,248
> HibernateUserManagerImpl:getWebsiteByHandle - weblogHandleToId CACHE HIT -
> testblog
> DEBUG 2007-07-05 19:59:09,248 WeblogRequestMapper:handleRequest -
> WEBLOG_URL /testblog/entry/first_entry
> DEBUG 2007-07-05 19:59:09,248 WeblogRequestMapper:calculateForwardUrl -
> testblog,null,entry,first_entry
> DEBUG 2007-07-05 19:59:09,249 WeblogRequestMapper:calculateForwardUrl -
> FORWARD_URL /roller-ui/rendering/page/testblog/entry/first_entry
> DEBUG 2007-07-05 19:59:09,249 WeblogRequestMapper:handleRequest -
> forwarding to /roller-ui/rendering/page/testblog/entry/first_entry
> DEBUG 2007-07-05 19:59:09,249 CharEncodingFilter:doFilter - Processing
> CharEncodingFilter
> DEBUG 2007-07-05 19:59:09,250 CharEncodingFilter:doFilter - Set request
> character encoding to UTF-8
> DEBUG 2007-07-05 19:59:09,250 StrutsCharEncodingFilter:doFilter -
> Processing CharEncodingFilter
> DEBUG 2007-07-05 19:59:09,250 StrutsCharEncodingFilter:doFilter -
> Synchronizing JSTL and Struts locales
> DEBUG 2007-07-05 19:59:09,251 StrutsCharEncodingFilter:doFilter - Set
> request character encoding to UTF-8
> DEBUG 2007-07-05 19:59:09,251 PageServlet:doGet - Entering
> DEBUG 2007-07-05 19:59:09,252 PageServlet:processReferrer - processing
> referrer for /roller/roller-ui/rendering/page/testblog/entry/first_entry
> DEBUG 2007-07-05 19:59:09,252 WeblogRequest:<init> - parsing path
> /testblog/entry/first_entry
> DEBUG 2007-07-05 19:59:09,253 WeblogRequest:<init> - handle = testblog
> DEBUG 2007-07-05 19:59:09,253 WeblogRequest:<init> - locale = null
> DEBUG 2007-07-05 19:59:09,254 WeblogRequest:<init> - pathInfo =
> entry/first_entry
> DEBUG 2007-07-05 19:59:09,254 WeblogPageRequest:<init> - parsing path
> entry/first_entry
> DEBUG 2007-07-05 19:59:09,255 WeblogPageRequest:<init> - context = entry
> DEBUG 2007-07-05 19:59:09,255 WeblogPageRequest:<init> - weblogAnchor =
> first_entry
> DEBUG 2007-07-05 19:59:09,255 WeblogPageRequest:<init> - weblogDate = null
> DEBUG 2007-07-05 19:59:09,256 WeblogPageRequest:<init> - weblogCategory =
> null
> DEBUG 2007-07-05 19:59:09,256 WeblogPageRequest:<init> - tags = null
> DEBUG 2007-07-05 19:59:09,257 WeblogPageRequest:<init> - weblogPage = null
> DEBUG 2007-07-05 19:59:09,257 WeblogPageRequest:<init> - pageNum = 0
> DEBUG 2007-07-05 19:59:09,258 HibernatePersistenceStrategy:getSession -
> Opening Hibernate Session
> DEBUG 2007-07-05 19:59:09,258 RollerRuntimeConfig:getProperty - fetched
> property [site.frontpage.weblog.aggregated=false]
> DEBUG 2007-07-05 19:59:09,259 HibernatePersistenceStrategy:getSession -
> Opening Hibernate Session
> DEBUG 2007-07-05 19:59:09,259 RollerRuntimeConfig:getProperty - fetched
> property [site.frontpage.weblog.handle=cetixx]
> DEBUG 2007-07-05 19:59:09,260 PageServlet:processReferrer - referrer =
> http://www.tauceti.net/roller/testblog/entry/first_entry
> DEBUG 2007-07-05 19:59:09,260 PageServlet:processReferrer - skipping
> referrer from own blog
> DEBUG 2007-07-05 19:59:09,261 WeblogRequest:<init> - parsing path
> /testblog/entry/first_entry
> DEBUG 2007-07-05 19:59:09,261 WeblogRequest:<init> - handle = testblog
> DEBUG 2007-07-05 19:59:09,262 WeblogRequest:<init> - locale = null
> DEBUG 2007-07-05 19:59:09,262 WeblogRequest:<init> - pathInfo =
> entry/first_entry
> DEBUG 2007-07-05 19:59:09,263 WeblogPageRequest:<init> - parsing path
> entry/first_entry
> DEBUG 2007-07-05 19:59:09,263 WeblogPageRequest:<init> - context = entry
> DEBUG 2007-07-05 19:59:09,264 WeblogPageRequest:<init> - weblogAnchor =
> first_entry
> DEBUG 2007-07-05 19:59:09,264 WeblogPageRequest:<init> - weblogDate = null
> DEBUG 2007-07-05 19:59:09,264 WeblogPageRequest:<init> - weblogCategory =
> null
> DEBUG 2007-07-05 19:59:09,265 WeblogPageRequest:<init> - tags = null
> DEBUG 2007-07-05 19:59:09,265 WeblogPageRequest:<init> - weblogPage = null
> DEBUG 2007-07-05 19:59:09,266 WeblogPageRequest:<init> - pageNum = 0
> DEBUG 2007-07-05 19:59:09,266 HibernatePersistenceStrategy:getSession -
> Opening Hibernate Session
> DEBUG 2007-07-05 19:59:09,267
> HibernateUserManagerImpl:getWebsiteByHandle - weblogHandleToId CACHE HIT -
> testblog
> DEBUG 2007-07-05 19:59:09,267 HibernatePersistenceStrategy:getSession -
> Opening Hibernate Session
> DEBUG 2007-07-05 19:59:09,268 RollerRuntimeConfig:getProperty - fetched
> property [site.frontpage.weblog.aggregated=false]
> DEBUG 2007-07-05 19:59:09,268 HibernatePersistenceStrategy:getSession -
> Opening Hibernate Session
> DEBUG 2007-07-05 19:59:09,269 RollerRuntimeConfig:getProperty - fetched
> property [site.frontpage.weblog.handle=cetixx]
> DEBUG 2007-07-05 19:59:09,269 ModDateHeaderUtil:respondIfNotModified -
> since date = 1183657869000
> DEBUG 2007-07-05 19:59:09,270 ModDateHeaderUtil:respondIfNotModified -
> last mod date (trucated to seconds) = 1183657869000
> DEBUG 2007-07-05 19:59:09,270 ModDateHeaderUtil:respondIfNotModified - NOT
> MODIFIED
> http://www.tauceti.net/roller/roller-ui/rendering/page/testblog/entry/first_entry
> DEBUG 2007-07-05 19:59:09,270 CompressionFilter:doFilter - Pre-zip size:0
> DEBUG 2007-07-05 19:59:09,271 CompressionFilter:doFilter - Gzip size:20
> DEBUG 2007-07-05 19:59:09,272 RequestMappingFilter:doFilter - request
> handled by org.apache.roller.ui.rendering.WeblogRequestMapper
> DEBUG 2007-07-05 19:59:09,272 RequestMappingFilter:doFilter - exiting
> DEBUG 2007-07-05 19:59:09,272 PersistenceSessionFilter:doFilter -
> Releasing Roller Session
> DEBUG 2007-07-05 19:59:09,273 HibernatePersistenceStrategy:release -
> Closing Hibernate Session
> DEBUG 2007-07-05 19:59:09,273 HibernatePersistenceStrategy:release -
> Forcing rollback on active transaction
> DEBUG 2007-07-05 19:59:09,273 PersistenceSessionFilter:doFilter - Exiting
> PersistenceSessionFilter
> DEBUG 2007-07-05 19:59:10,042 CharEncodingFilter:doFilter - Processing
> CharEncodingFilter
> DEBUG 2007-07-05 19:59:10,042 CharEncodingFilter:doFilter - Set request
> character encoding to UTF-8
> DEBUG 2007-07-05 19:59:10,043 PersistenceSessionFilter:doFilter - Entered
> PersistenceSessionFilter
> DEBUG 2007-07-05 19:59:10,043 RequestMappingFilter:doFilter - entering
> DEBUG 2007-07-05 19:59:10,044 RequestMappingFilter:doFilter - trying
> mapper org.apache.roller.ui.rendering.WeblogRequestMapper
> DEBUG 2007-07-05 19:59:10,044 WeblogRequestMapper:handleRequest -
> evaluating [/roller/CommentAuthenticatorServlet]
> DEBUG 2007-07-05 19:59:10,044 WeblogRequestMapper:handleRequest -
> potential weblog handle = CommentAuthenticatorServlet
> DEBUG 2007-07-05 19:59:10,045 WeblogRequestMapper:handleRequest - SKIPPED
> CommentAuthenticatorServlet
> DEBUG 2007-07-05 19:59:10,045 RequestMappingFilter:doFilter - request not
> mapped
> DEBUG 2007-07-05 19:59:10,045 RequestMappingFilter:doFilter - exiting
> DEBUG 2007-07-05 19:59:10,046 PersistenceSessionFilter:doFilter -
> Releasing Roller Session
> DEBUG 2007-07-05 19:59:10,046 HibernatePersistenceStrategy:release -
> Closing Hibernate Session
> DEBUG 2007-07-05 19:59:10,046 PersistenceSessionFilter:doFilter - Exiting
> PersistenceSessionFilter
> EBUG 2007-07-05 19:59:12,476 HibernatePersistenceStrategy:getSession -
> Opening Hibernate Session
> DEBUG 2007-07-05 19:59:12,477 HitCountProcessingJob:execute - Completed: 0
> secs
> DEBUG 2007-07-05 19:59:12,477 HibernatePersistenceStrategy:release -
> Closing Hibernate Session
> DEBUG 2007-07-05 19:59:12,477 HibernatePersistenceStrategy:release -
> Closing Hibernate Session
> DEBUG 2007-07-05 19:59:12,477 ContinuousWorkerThread:run -
> HitCountQueueProcessor SLEEPING for 180000 milliseconds ...
>
> I hope this helps since I can't see anything which points me to the
> problem. What seems
> a little bit strange to me is that I'am always getting the same math.
> question which allows
> me to submit the comment: 7+48.
>
> Thanks!
> Robert
>
>
> Anil Gangolli wrote:
>>
>> RW:
>>
>> Do you have DEBUG enabled on all of org.apache.roller
>> (org.apache.roller=DEBUG in the log4j.properties)?
>> I'm not seeing the RequestMapper logging anything in your log. We want
>> to see that class, WeblogRequest,
>> and hopefully WeblogCommentRequest logging stuff. Alternatively if you
>> have access logging set up in Tomcat
>> see if you see the POST coming in.
>>
>> Did you try the idea of creating a test blog with one of the shipped
>> themes (e.g. the basic theme?) to see if
>> comments work in that?
>>
>> --a.
>>
>>
>
Re: Comments do not work anymore
Posted by RW <ro...@tauceti.net>.
Hi!
Oh... Sorry! I've had enabled
log4j.rootCategory=DEBUG,roller
But I thought that this would enable all logging possible. Ok. Now I've
configured
log4j.category.org.apache.roller=DEBUG
log4j.category.net.java.roller=DEBUG
and switched to BASIC theme. Now the log looks like this when pressing
the submit button:
DEBUG 2007-07-05 19:33:11,421 CharEncodingFilter:doFilter - Processing
CharEncodingFilter
DEBUG 2007-07-05 19:33:11,422 CharEncodingFilter:doFilter - Set request
character encoding to UTF-8
DEBUG 2007-07-05 19:33:11,422 PersistenceSessionFilter:doFilter -
Entered PersistenceSessionFilter
DEBUG 2007-07-05 19:33:11,423 RequestMappingFilter:doFilter - entering
DEBUG 2007-07-05 19:33:11,423 RequestMappingFilter:doFilter - trying
mapper org.apache.roller.ui.rendering.WeblogRequestMapper
DEBUG 2007-07-05 19:33:11,423 WeblogRequestMapper:handleRequest -
evaluating [/roller/cetixx/entry/arkanoid_nostalgique_remake]
DEBUG 2007-07-05 19:33:11,423 WeblogRequestMapper:handleRequest -
potential weblog handle = cetixx
DEBUG 2007-07-05 19:33:11,424 WeblogRequestMapper:isWeblog - checking
weblog handle cetixx
DEBUG 2007-07-05 19:33:11,424 HibernatePersistenceStrategy:getSession -
Opening Hibernate Session
DEBUG 2007-07-05 19:33:11,427
HibernateUserManagerImpl:getWebsiteByHandle - weblogHandleToId CACHE HIT
- cetixx
DEBUG 2007-07-05 19:33:11,428 WeblogRequestMapper:handleRequest -
WEBLOG_URL /cetixx/entry/arkanoid_nostalgique_remake
DEBUG 2007-07-05 19:33:11,428 WeblogRequestMapper:calculateForwardUrl -
cetixx,null,entry,arkanoid_nostalgique_remake
DEBUG 2007-07-05 19:33:11,428 WeblogRequestMapper:calculateForwardUrl -
FORWARD_URL
/roller-ui/rendering/page/cetixx/entry/arkanoid_nostalgique_remake
DEBUG 2007-07-05 19:33:11,429 WeblogRequestMapper:handleRequest -
forwarding to
/roller-ui/rendering/page/cetixx/entry/arkanoid_nostalgique_remake
DEBUG 2007-07-05 19:33:11,429 CharEncodingFilter:doFilter - Processing
CharEncodingFilter
DEBUG 2007-07-05 19:33:11,429 CharEncodingFilter:doFilter - Set request
character encoding to UTF-8
DEBUG 2007-07-05 19:33:11,430 StrutsCharEncodingFilter:doFilter -
Processing CharEncodingFilter
DEBUG 2007-07-05 19:33:11,430 StrutsCharEncodingFilter:doFilter -
Synchronizing JSTL and Struts locales
DEBUG 2007-07-05 19:33:11,430 StrutsCharEncodingFilter:doFilter - Set
request character encoding to UTF-8
DEBUG 2007-07-05 19:33:11,431 PageServlet:doGet - Entering
DEBUG 2007-07-05 19:33:11,431 PageServlet:processReferrer - processing
referrer for
/roller/roller-ui/rendering/page/cetixx/entry/arkanoid_nostalgique_remake
DEBUG 2007-07-05 19:33:11,432 WeblogRequest:<init> - parsing path
/cetixx/entry/arkanoid_nostalgique_remake
DEBUG 2007-07-05 19:33:11,432 WeblogRequest:<init> - handle = cetixx
DEBUG 2007-07-05 19:33:11,433 WeblogRequest:<init> - locale = null
DEBUG 2007-07-05 19:33:11,433 WeblogRequest:<init> - pathInfo =
entry/arkanoid_nostalgique_remake
DEBUG 2007-07-05 19:33:11,434 WeblogPageRequest:<init> - parsing path
entry/arkanoid_nostalgique_remake
DEBUG 2007-07-05 19:33:11,434 WeblogPageRequest:<init> - context = entry
DEBUG 2007-07-05 19:33:11,434 WeblogPageRequest:<init> - weblogAnchor =
arkanoid_nostalgique_remake
DEBUG 2007-07-05 19:33:11,435 WeblogPageRequest:<init> - weblogDate = null
DEBUG 2007-07-05 19:33:11,435 WeblogPageRequest:<init> - weblogCategory
= null
DEBUG 2007-07-05 19:33:11,436 WeblogPageRequest:<init> - tags = null
DEBUG 2007-07-05 19:33:11,436 WeblogPageRequest:<init> - weblogPage = null
DEBUG 2007-07-05 19:33:11,437 WeblogPageRequest:<init> - pageNum = 0
DEBUG 2007-07-05 19:33:11,437 HibernatePersistenceStrategy:getSession -
Opening Hibernate Session
DEBUG 2007-07-05 19:33:11,438 RollerRuntimeConfig:getProperty - fetched
property [site.frontpage.weblog.aggregated=false]
DEBUG 2007-07-05 19:33:11,438 HibernatePersistenceStrategy:getSession -
Opening Hibernate Session
DEBUG 2007-07-05 19:33:11,439 RollerRuntimeConfig:getProperty - fetched
property [site.frontpage.weblog.handle=cetixx]
DEBUG 2007-07-05 19:33:11,439 PageServlet:processReferrer - referrer =
http://www.tauceti.net/roller/cetixx/entry/arkanoid_nostalgique_remake
DEBUG 2007-07-05 19:33:11,440 PageServlet:processReferrer - skipping
referrer from own blog
DEBUG 2007-07-05 19:33:11,440 WeblogRequest:<init> - parsing path
/cetixx/entry/arkanoid_nostalgique_remake
DEBUG 2007-07-05 19:33:11,440 PageServlet:processReferrer - skipping
referrer from own blog
DEBUG 2007-07-05 19:33:11,440 WeblogRequest:<init> - parsing path
/cetixx/entry/arkanoid_nostalgique_remake
DEBUG 2007-07-05 19:33:11,441 WeblogRequest:<init> - handle = cetixx
DEBUG 2007-07-05 19:33:11,441 WeblogRequest:<init> - locale = null
DEBUG 2007-07-05 19:33:11,442 WeblogRequest:<init> - pathInfo =
entry/arkanoid_nostalgique_remake
DEBUG 2007-07-05 19:33:11,442 WeblogPageRequest:<init> - parsing path
entry/arkanoid_nostalgique_remake
DEBUG 2007-07-05 19:33:11,443 WeblogPageRequest:<init> - context = entry
DEBUG 2007-07-05 19:33:11,443 WeblogPageRequest:<init> - weblogAnchor =
arkanoid_nostalgique_remake
DEBUG 2007-07-05 19:33:11,443 WeblogPageRequest:<init> - weblogDate = null
DEBUG 2007-07-05 19:33:11,444 WeblogPageRequest:<init> - weblogCategory
= null
DEBUG 2007-07-05 19:33:11,444 WeblogPageRequest:<init> - tags = null
DEBUG 2007-07-05 19:33:11,445 WeblogPageRequest:<init> - weblogPage = null
DEBUG 2007-07-05 19:33:11,445 WeblogPageRequest:<init> - pageNum = 0
DEBUG 2007-07-05 19:33:11,446 HibernatePersistenceStrategy:getSession -
Opening Hibernate Session
DEBUG 2007-07-05 19:33:11,446
HibernateUserManagerImpl:getWebsiteByHandle - weblogHandleToId CACHE HIT
- cetixx
DEBUG 2007-07-05 19:33:11,447 HibernatePersistenceStrategy:getSession -
Opening Hibernate Session
DEBUG 2007-07-05 19:33:11,447 RollerRuntimeConfig:getProperty - fetched
property [site.frontpage.weblog.aggregated=false]
DEBUG 2007-07-05 19:33:11,448 HibernatePersistenceStrategy:getSession -
Opening Hibernate Session
DEBUG 2007-07-05 19:33:11,448 RollerRuntimeConfig:getProperty - fetched
property [site.frontpage.weblog.handle=cetixx]
DEBUG 2007-07-05 19:33:11,449 ModDateHeaderUtil:respondIfNotModified -
since date = 1183656069000
DEBUG 2007-07-05 19:33:11,449 ModDateHeaderUtil:respondIfNotModified -
last mod date (trucated to seconds) = 1183656069000
DEBUG 2007-07-05 19:33:11,450 ModDateHeaderUtil:respondIfNotModified -
NOT MODIFIED
http://www.tauceti.net/roller/roller-ui/rendering/page/cetixx/entry/arkanoid_nostalgique_remake
DEBUG 2007-07-05 19:33:11,450 CompressionFilter:doFilter - Pre-zip size:0
DEBUG 2007-07-05 19:33:11,451 CompressionFilter:doFilter - Gzip size:20
DEBUG 2007-07-05 19:33:11,451 RequestMappingFilter:doFilter - request
handled by org.apache.roller.ui.rendering.WeblogRequestMapper
DEBUG 2007-07-05 19:33:11,452 RequestMappingFilter:doFilter - exiting
DEBUG 2007-07-05 19:33:11,452 PersistenceSessionFilter:doFilter -
Releasing Roller Session
DEBUG 2007-07-05 19:33:11,452 HibernatePersistenceStrategy:release -
Closing Hibernate Session
DEBUG 2007-07-05 19:33:11,453 HibernatePersistenceStrategy:release -
Forcing rollback on active transaction
DEBUG 2007-07-05 19:33:11,453 PersistenceSessionFilter:doFilter -
Exiting PersistenceSessionFilter
DEBUG 2007-07-05 19:33:12,122 CharEncodingFilter:doFilter - Processing
CharEncodingFilter
DEBUG 2007-07-05 19:33:12,122 CharEncodingFilter:doFilter - Set request
character encoding to UTF-8
DEBUG 2007-07-05 19:33:12,122 PersistenceSessionFilter:doFilter -
Entered PersistenceSessionFilter
DEBUG 2007-07-05 19:33:12,123 RequestMappingFilter:doFilter - entering
DEBUG 2007-07-05 19:33:12,123 RequestMappingFilter:doFilter - trying
mapper org.apache.roller.ui.rendering.WeblogRequestMapper
DEBUG 2007-07-05 19:33:12,123 WeblogRequestMapper:handleRequest -
evaluating [/roller/CommentAuthenticatorServlet]
DEBUG 2007-07-05 19:33:12,123 WeblogRequestMapper:handleRequest -
potential weblog handle = CommentAuthenticatorServlet
DEBUG 2007-07-05 19:33:12,124 WeblogRequestMapper:handleRequest -
SKIPPED CommentAuthenticatorServlet
DEBUG 2007-07-05 19:33:12,124 RequestMappingFilter:doFilter - request
not mapped
DEBUG 2007-07-05 19:33:12,124 RequestMappingFilter:doFilter - exiting
DEBUG 2007-07-05 19:33:12,125 PersistenceSessionFilter:doFilter -
Releasing Roller Session
DEBUG 2007-07-05 19:33:12,125 HibernatePersistenceStrategy:release -
Closing Hibernate Session
DEBUG 2007-07-05 19:33:12,125 PersistenceSessionFilter:doFilter -
Exiting PersistenceSessionFilter
DEBUG 2007-07-05 19:33:19,765 HibernatePersistenceStrategy:getSession -
Opening Hibernate Session
DEBUG 2007-07-05 19:33:19,767 RollerTask:run - Attempting to acquire lock
DEBUG 2007-07-05 19:33:19,767 HibernatePersistenceStrategy:getSession -
Opening Hibernate Session
DEBUG 2007-07-05 19:33:19,768 HibernatePersistenceStrategy:getSession -
Opening Hibernate Session
DEBUG 2007-07-05 19:33:19,768 HibernatePersistenceStrategy:getSession -
Opening Hibernate Session
DEBUG 2007-07-05 19:33:19,770 RollerTask:run - Lock acquired, running task
DEBUG 2007-07-05 19:33:19,770 PingQueueTask:runTask - task started
DEBUG 2007-07-05 19:33:19,770 HibernatePersistenceStrategy:getSession -
Opening Hibernate Session
DEBUG 2007-07-05 19:33:19,770 RollerRuntimeConfig:getProperty - fetched
property [pings.suspendPingProcessing=false]
DEBUG 2007-07-05 19:33:19,770 HibernatePersistenceStrategy:getSession -
Opening Hibernate Session
DEBUG 2007-07-05 19:33:19,771 RollerRuntimeConfig:getProperty - fetched
property [site.absoluteurl=http://www.tauceti.net]
DEBUG 2007-07-05 19:33:19,771 PingQueueProcessor:processQueue - Started
processing ping queue.
DEBUG 2007-07-05 19:33:19,771 HibernatePersistenceStrategy:getSession -
Opening Hibernate Session
DEBUG 2007-07-05 19:33:19,778 PingQueueProcessor:processQueue - Finished
processing ping queue.
DEBUG 2007-07-05 19:33:19,778 HibernatePersistenceStrategy:getSession -
Opening Hibernate Session
DEBUG 2007-07-05 19:33:19,778 PingQueueTask:runTask - task completed
DEBUG 2007-07-05 19:33:19,779 HibernatePersistenceStrategy:release -
Closing Hibernate Session
DEBUG 2007-07-05 19:33:19,779 RollerTask:run - Attempting to release lock
DEBUG 2007-07-05 19:33:19,779 HibernatePersistenceStrategy:getSession -
Opening Hibernate Session
DEBUG 2007-07-05 19:33:19,780 HibernatePersistenceStrategy:getSession -
Opening Hibernate Session
DEBUG 2007-07-05 19:33:19,780 HibernatePersistenceStrategy:getSession -
Opening Hibernate Session
DEBUG 2007-07-05 19:33:19,781 RollerTask:run - Lock released, time to sleep
DEBUG 2007-07-05 19:33:19,781 HibernatePersistenceStrategy:release -
Closing Hibernate Session
DEBUG 2007-07-05 19:33:21,043 RollerContext:sessionDestroyed -
sessions=-6:freemem=15507072:totalmem=87818240
I only see three entries which contains something like "comment"... Then
I've created a blog "testblog"
with BASIC theme then created a new entry and tried to comment. This is
the output of the roller.log:
DEBUG 2007-07-05 19:59:09,244 CharEncodingFilter:doFilter - Processing
CharEncodingFilter
DEBUG 2007-07-05 19:59:09,244 CharEncodingFilter:doFilter - Set request
character encoding to UTF-8
DEBUG 2007-07-05 19:59:09,244 PersistenceSessionFilter:doFilter -
Entered PersistenceSessionFilter
DEBUG 2007-07-05 19:59:09,245 RequestMappingFilter:doFilter - entering
DEBUG 2007-07-05 19:59:09,245 RequestMappingFilter:doFilter - trying
mapper org.apache.roller.ui.rendering.WeblogRequestMapper
DEBUG 2007-07-05 19:59:09,245 WeblogRequestMapper:handleRequest -
evaluating [/roller/testblog/entry/first_entry]
DEBUG 2007-07-05 19:59:09,246 WeblogRequestMapper:handleRequest -
potential weblog handle = testblog
DEBUG 2007-07-05 19:59:09,246 WeblogRequestMapper:isWeblog - checking
weblog handle testblog
DEBUG 2007-07-05 19:59:09,246 HibernatePersistenceStrategy:getSession -
Opening Hibernate Session
DEBUG 2007-07-05 19:59:09,248
HibernateUserManagerImpl:getWebsiteByHandle - weblogHandleToId CACHE HIT
- testblog
DEBUG 2007-07-05 19:59:09,248 WeblogRequestMapper:handleRequest -
WEBLOG_URL /testblog/entry/first_entry
DEBUG 2007-07-05 19:59:09,248 WeblogRequestMapper:calculateForwardUrl -
testblog,null,entry,first_entry
DEBUG 2007-07-05 19:59:09,249 WeblogRequestMapper:calculateForwardUrl -
FORWARD_URL /roller-ui/rendering/page/testblog/entry/first_entry
DEBUG 2007-07-05 19:59:09,249 WeblogRequestMapper:handleRequest -
forwarding to /roller-ui/rendering/page/testblog/entry/first_entry
DEBUG 2007-07-05 19:59:09,249 CharEncodingFilter:doFilter - Processing
CharEncodingFilter
DEBUG 2007-07-05 19:59:09,250 CharEncodingFilter:doFilter - Set request
character encoding to UTF-8
DEBUG 2007-07-05 19:59:09,250 StrutsCharEncodingFilter:doFilter -
Processing CharEncodingFilter
DEBUG 2007-07-05 19:59:09,250 StrutsCharEncodingFilter:doFilter -
Synchronizing JSTL and Struts locales
DEBUG 2007-07-05 19:59:09,251 StrutsCharEncodingFilter:doFilter - Set
request character encoding to UTF-8
DEBUG 2007-07-05 19:59:09,251 PageServlet:doGet - Entering
DEBUG 2007-07-05 19:59:09,252 PageServlet:processReferrer - processing
referrer for /roller/roller-ui/rendering/page/testblog/entry/first_entry
DEBUG 2007-07-05 19:59:09,252 WeblogRequest:<init> - parsing path
/testblog/entry/first_entry
DEBUG 2007-07-05 19:59:09,253 WeblogRequest:<init> - handle = testblog
DEBUG 2007-07-05 19:59:09,253 WeblogRequest:<init> - locale = null
DEBUG 2007-07-05 19:59:09,254 WeblogRequest:<init> - pathInfo =
entry/first_entry
DEBUG 2007-07-05 19:59:09,254 WeblogPageRequest:<init> - parsing path
entry/first_entry
DEBUG 2007-07-05 19:59:09,255 WeblogPageRequest:<init> - context = entry
DEBUG 2007-07-05 19:59:09,255 WeblogPageRequest:<init> - weblogAnchor =
first_entry
DEBUG 2007-07-05 19:59:09,255 WeblogPageRequest:<init> - weblogDate = null
DEBUG 2007-07-05 19:59:09,256 WeblogPageRequest:<init> - weblogCategory
= null
DEBUG 2007-07-05 19:59:09,256 WeblogPageRequest:<init> - tags = null
DEBUG 2007-07-05 19:59:09,257 WeblogPageRequest:<init> - weblogPage = null
DEBUG 2007-07-05 19:59:09,257 WeblogPageRequest:<init> - pageNum = 0
DEBUG 2007-07-05 19:59:09,258 HibernatePersistenceStrategy:getSession -
Opening Hibernate Session
DEBUG 2007-07-05 19:59:09,258 RollerRuntimeConfig:getProperty - fetched
property [site.frontpage.weblog.aggregated=false]
DEBUG 2007-07-05 19:59:09,259 HibernatePersistenceStrategy:getSession -
Opening Hibernate Session
DEBUG 2007-07-05 19:59:09,259 RollerRuntimeConfig:getProperty - fetched
property [site.frontpage.weblog.handle=cetixx]
DEBUG 2007-07-05 19:59:09,260 PageServlet:processReferrer - referrer =
http://www.tauceti.net/roller/testblog/entry/first_entry
DEBUG 2007-07-05 19:59:09,260 PageServlet:processReferrer - skipping
referrer from own blog
DEBUG 2007-07-05 19:59:09,261 WeblogRequest:<init> - parsing path
/testblog/entry/first_entry
DEBUG 2007-07-05 19:59:09,261 WeblogRequest:<init> - handle = testblog
DEBUG 2007-07-05 19:59:09,262 WeblogRequest:<init> - locale = null
DEBUG 2007-07-05 19:59:09,262 WeblogRequest:<init> - pathInfo =
entry/first_entry
DEBUG 2007-07-05 19:59:09,263 WeblogPageRequest:<init> - parsing path
entry/first_entry
DEBUG 2007-07-05 19:59:09,263 WeblogPageRequest:<init> - context = entry
DEBUG 2007-07-05 19:59:09,264 WeblogPageRequest:<init> - weblogAnchor =
first_entry
DEBUG 2007-07-05 19:59:09,264 WeblogPageRequest:<init> - weblogDate = null
DEBUG 2007-07-05 19:59:09,264 WeblogPageRequest:<init> - weblogCategory
= null
DEBUG 2007-07-05 19:59:09,265 WeblogPageRequest:<init> - tags = null
DEBUG 2007-07-05 19:59:09,265 WeblogPageRequest:<init> - weblogPage = null
DEBUG 2007-07-05 19:59:09,266 WeblogPageRequest:<init> - pageNum = 0
DEBUG 2007-07-05 19:59:09,266 HibernatePersistenceStrategy:getSession -
Opening Hibernate Session
DEBUG 2007-07-05 19:59:09,267
HibernateUserManagerImpl:getWebsiteByHandle - weblogHandleToId CACHE HIT
- testblog
DEBUG 2007-07-05 19:59:09,267 HibernatePersistenceStrategy:getSession -
Opening Hibernate Session
DEBUG 2007-07-05 19:59:09,268 RollerRuntimeConfig:getProperty - fetched
property [site.frontpage.weblog.aggregated=false]
DEBUG 2007-07-05 19:59:09,268 HibernatePersistenceStrategy:getSession -
Opening Hibernate Session
DEBUG 2007-07-05 19:59:09,269 RollerRuntimeConfig:getProperty - fetched
property [site.frontpage.weblog.handle=cetixx]
DEBUG 2007-07-05 19:59:09,269 ModDateHeaderUtil:respondIfNotModified -
since date = 1183657869000
DEBUG 2007-07-05 19:59:09,270 ModDateHeaderUtil:respondIfNotModified -
last mod date (trucated to seconds) = 1183657869000
DEBUG 2007-07-05 19:59:09,270 ModDateHeaderUtil:respondIfNotModified -
NOT MODIFIED
http://www.tauceti.net/roller/roller-ui/rendering/page/testblog/entry/first_entry
DEBUG 2007-07-05 19:59:09,270 CompressionFilter:doFilter - Pre-zip size:0
DEBUG 2007-07-05 19:59:09,271 CompressionFilter:doFilter - Gzip size:20
DEBUG 2007-07-05 19:59:09,272 RequestMappingFilter:doFilter - request
handled by org.apache.roller.ui.rendering.WeblogRequestMapper
DEBUG 2007-07-05 19:59:09,272 RequestMappingFilter:doFilter - exiting
DEBUG 2007-07-05 19:59:09,272 PersistenceSessionFilter:doFilter -
Releasing Roller Session
DEBUG 2007-07-05 19:59:09,273 HibernatePersistenceStrategy:release -
Closing Hibernate Session
DEBUG 2007-07-05 19:59:09,273 HibernatePersistenceStrategy:release -
Forcing rollback on active transaction
DEBUG 2007-07-05 19:59:09,273 PersistenceSessionFilter:doFilter -
Exiting PersistenceSessionFilter
DEBUG 2007-07-05 19:59:10,042 CharEncodingFilter:doFilter - Processing
CharEncodingFilter
DEBUG 2007-07-05 19:59:10,042 CharEncodingFilter:doFilter - Set request
character encoding to UTF-8
DEBUG 2007-07-05 19:59:10,043 PersistenceSessionFilter:doFilter -
Entered PersistenceSessionFilter
DEBUG 2007-07-05 19:59:10,043 RequestMappingFilter:doFilter - entering
DEBUG 2007-07-05 19:59:10,044 RequestMappingFilter:doFilter - trying
mapper org.apache.roller.ui.rendering.WeblogRequestMapper
DEBUG 2007-07-05 19:59:10,044 WeblogRequestMapper:handleRequest -
evaluating [/roller/CommentAuthenticatorServlet]
DEBUG 2007-07-05 19:59:10,044 WeblogRequestMapper:handleRequest -
potential weblog handle = CommentAuthenticatorServlet
DEBUG 2007-07-05 19:59:10,045 WeblogRequestMapper:handleRequest -
SKIPPED CommentAuthenticatorServlet
DEBUG 2007-07-05 19:59:10,045 RequestMappingFilter:doFilter - request
not mapped
DEBUG 2007-07-05 19:59:10,045 RequestMappingFilter:doFilter - exiting
DEBUG 2007-07-05 19:59:10,046 PersistenceSessionFilter:doFilter -
Releasing Roller Session
DEBUG 2007-07-05 19:59:10,046 HibernatePersistenceStrategy:release -
Closing Hibernate Session
DEBUG 2007-07-05 19:59:10,046 PersistenceSessionFilter:doFilter -
Exiting PersistenceSessionFilter
EBUG 2007-07-05 19:59:12,476 HibernatePersistenceStrategy:getSession -
Opening Hibernate Session
DEBUG 2007-07-05 19:59:12,477 HitCountProcessingJob:execute - Completed:
0 secs
DEBUG 2007-07-05 19:59:12,477 HibernatePersistenceStrategy:release -
Closing Hibernate Session
DEBUG 2007-07-05 19:59:12,477 HibernatePersistenceStrategy:release -
Closing Hibernate Session
DEBUG 2007-07-05 19:59:12,477 ContinuousWorkerThread:run -
HitCountQueueProcessor SLEEPING for 180000 milliseconds ...
I hope this helps since I can't see anything which points me to the
problem. What seems
a little bit strange to me is that I'am always getting the same math.
question which allows
me to submit the comment: 7+48.
Thanks!
Robert
Anil Gangolli wrote:
>
> RW:
>
> Do you have DEBUG enabled on all of org.apache.roller
> (org.apache.roller=DEBUG in the log4j.properties)?
> I'm not seeing the RequestMapper logging anything in your log. We
> want to see that class, WeblogRequest,
> and hopefully WeblogCommentRequest logging stuff. Alternatively if
> you have access logging set up in Tomcat
> see if you see the POST coming in.
>
> Did you try the idea of creating a test blog with one of the shipped
> themes (e.g. the basic theme?) to see if
> comments work in that?
>
> --a.
>
>
Re: Comments do not work anymore
Posted by Anil Gangolli <an...@busybuddha.org>.
RW:
Do you have DEBUG enabled on all of org.apache.roller
(org.apache.roller=DEBUG in the log4j.properties)?
I'm not seeing the RequestMapper logging anything in your log. We want to
see that class, WeblogRequest,
and hopefully WeblogCommentRequest logging stuff. Alternatively if you
have access logging set up in Tomcat
see if you see the POST coming in.
Did you try the idea of creating a test blog with one of the shipped themes
(e.g. the basic theme?) to see if
comments work in that?
--a.