You are viewing a plain text version of this content. The canonical link for it is here.
Posted to user@forrest.apache.org by Eike Stepper <st...@esc-net.de> on 2004/06/22 10:43:54 UTC

warnings and exceptions related to caching

hi,

there are several warnings related to caching.
sometimes there is an additional NPE or InterruptedException!
doesn't seem to cause further problems but i'd like to be sure.

here is the console output with the InterruptedException:


Apache Forrest.  Run 'forrest -projecthelp' to list options


Buildfile: C:\develop\tools\forrest\src\core\forrest.build.xml

init-props:
Loading project specific properties from C:\develop\workspace\de.escnet.net4j.docs\forrest.properties
Loading user specific properties from C:\Dokumente und Einstellungen\Stepper\forrest.properties
Loading default properties from C:\develop\tools\forrest\src\core\context\default-forrest.properties
Created dir: C:\develop\workspace\de.escnet.net4j.docs\build\tmp
Reading filters from C:\develop\workspace\de.escnet.net4j.docs\build\tmp\projfilters.properties
forrest.basic.jvmargs:-Dproject.home="C:\develop\workspace\de.escnet.net4j.docs" -Dforrest.home="C:\develop\tools\forrest\src\core"

echo-settings:
      ------------------------------------------------
      | Forrest template run.
      | Running from ${forrest.home} = C:\develop\tools\forrest\src\core
      | Working on   ${project.home} = C:\develop\workspace\de.escnet.net4j.docs
      ------------------------------------------------
      | //where to put the result
      | project.site-dir    = C:\develop\workspace\de.escnet.net4j.docs\build\site
      | //uri to start crawling/generation process
      | project.start-uri   = index.html
      | //cocoon.xconf location
      | project.configfile  = C:\develop\workspace\de.escnet.net4j.docs\build\webapp/WEB-INF/cli.xconf
      | //logkit.xconf location
      | project.logkitfile  = C:\develop\workspace\de.escnet.net4j.docs\build\webapp/WEB-INF/logkit.xconf
      | //temp dir to throw stuff in (i.e. work and ctxt)
      | project.temp-dir    = C:\develop\workspace\de.escnet.net4j.docs\build\tmp
      | //temp working directory for generation process
      | project.cocoon-work-dir    = C:\develop\workspace\de.escnet.net4j.docs\build\tmp\cocoon-work
      | //temp context directory for generation process
      | project.webapp    = C:\develop\workspace\de.escnet.net4j.docs\build\webapp
      | //debuglevel for logging (DEBUG, INFO, WARN, ERROR, FATAL_ERROR)
      | project.debuglevel  = ERROR
      | //file for list of broken links
      | project.brokenlinkfile = C:\develop\workspace\de.escnet.net4j.docs\build\brokenlinks.xml
      | //check if you have tools.jar installed
      | tools.jar.present   = true
      ------------------------------------------------
      | The following properties could be removed from future builds:
      | //which skin to apply
      | project.skin        = tigris-style
      | //where your documentation xml is
      | project.content-dir = C:\develop\workspace\de.escnet.net4j.docs\src
      ------------------------------------------------

bare-context:
____________________________________
Using skin tigris-style
____________________________________
Created dir: C:\develop\workspace\de.escnet.net4j.docs\build\webapp
Copying 479 files to C:\develop\workspace\de.escnet.net4j.docs\build\webapp
Created dir: C:\develop\workspace\de.escnet.net4j.docs\build\webapp\WEB-INF\lib

validate-xdocs:
12 file(s) have been successfully validated.
...validated xdocs

validate-skinconf:
1 file(s) have been successfully validated.
...validated skinconf

validate-sitemap:
...validated sitemap

validate-skinchoice:
...validated existence of skin 'tigris-style'

copy-conf:
Copying 1 file to C:\develop\workspace\de.escnet.net4j.docs\build\webapp\WEB-INF

upgrade-skinconf:
Processing C:\develop\workspace\de.escnet.net4j.docs\src\skinconf.xml to
C:\develop\workspace\de.escnet.net4j.docs\build\webapp\skinconf.xml
Loading stylesheet C:\develop\tools\forrest\src\core\context\resources\stylesheets\upgrade-skinconf.xsl

copy-status:
Copying 1 file to C:\develop\workspace\de.escnet.net4j.docs\build\webapp

site:
Created dir: C:\develop\workspace\de.escnet.net4j.docs\build\tmp\cocoon-work
Copying 260 files to C:\develop\workspace\de.escnet.net4j.docs\build\site
------------------------------------------------------------------------ 
cocoon 2.1.5
Copyright (c) 1999-2004 Apache Software Foundation. All rights reserved.
------------------------------------------------------------------------ 
CatalogManager.properties: catalogs not found.
22.06.2004 10:21:38 org.apache.jcs.engine.control.CompositeCacheConfigurator setDefaultAuxValues
INFO: setting defaults to DC
22.06.2004 10:21:38 org.apache.jcs.engine.control.CompositeCacheConfigurator setDefaultCompositeCacheAttributes
INFO: setting defaultCompositeCacheAttributes to [ useLateral = true, useRemote = true, useDisk = true, maxObjs = 100,
maxSpoolPerRun = -1 ]
22.06.2004 10:21:38 org.apache.jcs.config.OptionConverter instantiateByKey
WARNUNG: Could not find value for key jcs.default.elementattributes
22.06.2004 10:21:38 org.apache.jcs.engine.control.CompositeCacheConfigurator parseElementAttributes
WARNUNG: Could not instantiate eAttr named 'jcs.default.elementattributes', using defaults.
22.06.2004 10:21:38 org.apache.jcs.engine.control.CompositeCacheConfigurator setDefaultElementAttributes
INFO: setting defaultElementAttributes to [ IS_LATERAL = false, IS_SPOOL = false, IS_REMOTE = false, IS_ETERNAL = true,
MaxLifeSeconds = -1, IdleTime = -1, CreateTime = 1087892498890, LastAccessTime = 1087892498890, getTimeToLiveSeconds() = -1000,
createTime = 1087892498890 ]
22.06.2004 10:21:38 org.apache.jcs.config.OptionConverter instantiateByKey
WARNUNG: Could not find value for key jcs.system.groupIdCache.elementattributes
22.06.2004 10:21:38 org.apache.jcs.engine.control.CompositeCacheConfigurator parseElementAttributes
WARNUNG: Could not instantiate eAttr named 'jcs.system.groupIdCache.elementattributes', using defaults.
22.06.2004 10:21:38 org.apache.jcs.engine.memory.lru.LRUMemoryCache initialize
INFO: initialized LRUMemoryCache for groupIdCache
22.06.2004 10:21:38 org.apache.jcs.engine.control.CompositeCache <init>
INFO: Constructed cache with name: groupIdCache
22.06.2004 10:21:39 org.apache.jcs.auxiliary.disk.indexed.IndexedDiskCache <init>
INFO: Cache file root directory: C:\develop\workspace\de.escnet.net4j.docs\build\webapp\..\tmp\cocoon-work
22.06.2004 10:21:39 org.apache.jcs.config.OptionConverter instantiateByKey
WARNUNG: Could not find value for key jcs.region.main.elementattributes
22.06.2004 10:21:39 org.apache.jcs.engine.control.CompositeCacheConfigurator parseElementAttributes
WARNUNG: Could not instantiate eAttr named 'jcs.region.main.elementattributes', using defaults.
22.06.2004 10:21:39 org.apache.jcs.engine.memory.lru.LRUMemoryCache initialize
INFO: initialized LRUMemoryCache for main
22.06.2004 10:21:39 org.apache.jcs.engine.control.CompositeCache <init>
INFO: Constructed cache with name: main
22.06.2004 10:21:39 org.apache.jcs.auxiliary.disk.indexed.IndexedDiskCache <init>
INFO: Cache file root directory: C:\develop\workspace\de.escnet.net4j.docs\build\webapp\..\tmp\cocoon-work
^                                    docs/
* [1/23]    [23/26]   4.125s 11.5Kb  index.html
* [2/22]    [0/0]     0.047s 8.1Kb   docs/Multiplexing.gif
^                                    docs/
* [3/21]    [0/21]    1.094s 5.9Kb   download.html
^                                    docs/
* [4/21]    [1/23]    1.828s 9.1Kb   links.html
^                                    docs/
* [5/20]    [0/21]    0.828s 5.8Kb   docs/implementation.html
* [6/19]    [0/0]     0.281s 817b    skin/print.css
* [7/18]    [0/0]     0.047s 4.2Kb   images/net4j.gif
^                                    docs/
* [8/17]    [0/21]    1.234s 33.0Kb  license.html
* [9/16]    [0/0]     0.453s 5.5Kb   skin/forrest.css
* [10/15]   [0/0]     0.078s 1.7Kb   skin/menu.js
* [11/14]   [0/0]     0.031s 6.4Kb   skin/breadcrumbs.js
^                                    docs/
* [12/18]   [5/30]    1.078s 14.5Kb  docs/index.html
* [13/17]   [0/0]     0.047s 26.2Kb  docs/api/de/escnet/net4j/impl/SocketConnector.html
* [14/16]   [0/0]     0.016s 17.8Kb  /docs/api/de/escnet/net4j/Connector.html
^                                    docs/
* [15/21]   [6/27]    0.812s 11.2Kb  docs/architecture.html
* [16/20]   [0/0]     0.016s 12.3Kb  docs/SystemDecomposition.gif
* [17/19]   [0/0]     0.031s 3.1Kb   docs/Executors.gif
* [18/18]   [0/0]     0.016s 3.0Kb   docs/Acceptors.gif
* [19/17]   [0/0]     0.047s 20.2Kb  docs/ConnectorHierarchy.gif
* [20/16]   [0/0]     0.015s 3.1Kb   docs/Protocols.gif
* [21/15]   [0/0]     0.031s 11.6Kb  images/berlios.bmp
^                                    docs/
* [22/14]   [0/21]    1.391s 11.5Kb  docs/glossary.html
* [23/13]   [0/0]     0.031s 4.9Kb   docs/Connectors.gif
* [24/12]   [0/0]     0.032s 1.8Kb   images/built-with-forrest-button.png
* [25/11]   [0/0]     0.015s 7.6Kb   docs/PushService.gif
* [26/10]   [0/0]     0.016s 1.1Kb   skin/images/vcss.png
* [27/9]    [0/0]     0.0s   923b    docs/api/index.html
* [28/8]    [0/0]     0.032s 21.8Kb  docs/api/de/escnet/net4j/impl/EmbeddedConnector.html
* [29/7]    [0/0]     0.015s 1.6Kb   images/eclipse_bckgr_logo_fc_xsm.jpg
* [30/6]    [0/0]     0.032s 9.0Kb   docs/SocketAndEmbedded.gif
* [31/5]    [0/0]     0.015s 2.5Kb   skin/tigris.js
* [32/4]    [0/0]     0.047s 11.8Kb  docs/ContainerSetup.gif
^                                    docs/
* [33/3]    [0/21]    0.781s 6.2Kb   faq.html
Copying 19 files to C:\develop\workspace\de.escnet.net4j.docs\build\site\skin\images
* [34/2]    [0/0]     0.422s 10.1Kb  docs/api/de/escnet/net4j/merlin/MerlinEmbedder.html
* [35/1]    [0/0]     0.047s 2.8Kb   skin/images/valid-html401.png
* [36/0]    [0/0]     0.016s 3.6Kb   images/esc.gif
Copying 62 files to C:\develop\workspace\de.escnet.net4j.docs\build\site\skin\images
22.06.2004 10:21:55 org.apache.jcs.engine.CacheEventQueue destroy
INFO: Cache event queue destroyed: listenerId=118, cacheName=main
22.06.2004 10:21:55 org.apache.jcs.auxiliary.disk.indexed.IndexedDiskCache doUpdate
SCHWERWIEGEND: Failure updating element, cacheName: main, key:
PK_G-file-cocoon://abs-linkmap?pipelinehash=278467903521696551_T-xslt-file:/C:/develop/tools/forrest/src/core/context/resources/styl
esheets/relativize-linkmap.xsl;site-root=http://net4j.berlios.de;path=docs/index.html
java.lang.InterruptedException
 at java.lang.Object.wait(Native Method)
 at org.apache.jcs.utils.locking.ReadWriteLock.writeLock(ReadWriteLock.java:127)
 at org.apache.jcs.auxiliary.disk.indexed.IndexedDiskCache.doUpdate(IndexedDiskCache.java:252)
 at org.apache.jcs.auxiliary.disk.AbstractDiskCache$MyCacheListener.handlePut(AbstractDiskCache.java:417)
 at org.apache.jcs.engine.CacheEventQueue$PutEvent.doRun(CacheEventQueue.java:440)
 at org.apache.jcs.engine.CacheEventQueue$AbstractCacheEvent.run(CacheEventQueue.java:358)
 at org.apache.jcs.engine.CacheEventQueue$QProcessor.run(CacheEventQueue.java:327)
22.06.2004 10:21:55 org.apache.jcs.engine.CacheEventQueue$QProcessor run
INFO: QProcessor exiting for listenerId=118, cacheName=main
22.06.2004 10:21:55 org.apache.jcs.auxiliary.disk.indexed.IndexedDiskCache optimizeFile
INFO: Optomizing file keyHash.size()=0
22.06.2004 10:21:55 org.apache.jcs.auxiliary.disk.indexed.IndexedDiskCache doDispose
WARNUNG: Closing files, base filename: main
22.06.2004 10:21:55 org.apache.jcs.engine.control.CompositeCache dispose
WARNUNG: Called close for main
22.06.2004 10:21:55 org.apache.jcs.engine.CacheEventQueue$QProcessor run
INFO: QProcessor exiting for listenerId=118, cacheName=groupIdCache
22.06.2004 10:21:55 org.apache.jcs.engine.CacheEventQueue destroy
INFO: Cache event queue destroyed: listenerId=118, cacheName=groupIdCache
22.06.2004 10:21:55 org.apache.jcs.auxiliary.disk.indexed.IndexedDiskCache optimizeFile
INFO: Optomizing file keyHash.size()=0
22.06.2004 10:21:55 org.apache.jcs.auxiliary.disk.indexed.IndexedDiskCache doDispose
WARNUNG: Closing files, base filename: groupIdCache
22.06.2004 10:21:55 org.apache.jcs.engine.control.CompositeCache dispose
WARNUNG: Called close for groupIdCache
Total time: 0 minutes 18 seconds,  Site size: 321.666 Site pages: 36
Warning: C:\develop\workspace\de.escnet.net4j.docs\src\skins\common\images not found.
Warning: C:\develop\workspace\de.escnet.net4j.docs\src\skins\tigris-style\images not found.
Copying 6 files to C:\develop\workspace\de.escnet.net4j.docs\build\site\skin
Copied 3 empty directories to 2 empty directories under C:\develop\workspace\de.escnet.net4j.docs\build\site\skin
Copying 8 files to C:\develop\workspace\de.escnet.net4j.docs\build\site\skin
Warning: C:\develop\workspace\de.escnet.net4j.docs\src\skins\common not found.
Warning: C:\develop\workspace\de.escnet.net4j.docs\src\skins\tigris-style not found.

Static site will be generated at:
C:\develop\workspace\de.escnet.net4j.docs\build\site

Note that there are various reasons for "build failed" messages.
* Cocoon will report the status of each document:
  - in column 1: *=okay X=brokenLink ^=pageSkipped (see FAQ).
* Even if only one link is broken, you will still get "failed".
* Your site would still be generated, but some pages would be broken.
* Please check the file:
C:\develop\workspace\de.escnet.net4j.docs\build\brokenlinks.xml
for any broken links in the generated site.

------------------------------
Static site was successfully generated at:
C:\develop\workspace\de.escnet.net4j.docs\build\site
------------------------------


BUILD SUCCESSFUL
Total time: 25 seconds


here is an example with a NPE:

[...]
22.06.2004 10:41:09 org.apache.jcs.engine.CacheEventQueue destroy
INFO: Cache event queue destroyed: listenerId=-56, cacheName=main
22.06.2004 10:41:09 org.apache.jcs.auxiliary.disk.indexed.IndexedDiskCache optimizeFile
INFO: Optomizing file keyHash.size()=0
22.06.2004 10:41:09 org.apache.jcs.auxiliary.disk.indexed.IndexedDiskCache doDispose
WARNUNG: Closing files, base filename: main
22.06.2004 10:41:09 org.apache.jcs.engine.control.CompositeCache dispose
WARNUNG: Called close for main
22.06.2004 10:41:09 org.apache.jcs.engine.CacheEventQueue$QProcessor run
INFO: QProcessor exiting for listenerId=-56, cacheName=groupIdCache
22.06.2004 10:41:09 org.apache.jcs.engine.CacheEventQueue destroy
INFO: Cache event queue destroyed: listenerId=-56, cacheName=groupIdCache
22.06.2004 10:41:10 org.apache.jcs.auxiliary.disk.indexed.IndexedDiskCache doUpdate
SCHWERWIEGEND: Failure updating element, cacheName: main, key:
PK_G-file-cocoon://docs/book-glossary.html?pipelinehash=6515063387014845322
java.lang.NullPointerException
 at org.apache.jcs.auxiliary.disk.indexed.IndexedDiskCache.doUpdate(IndexedDiskCache.java:249)
 at org.apache.jcs.auxiliary.disk.AbstractDiskCache$MyCacheListener.handlePut(AbstractDiskCache.java:417)
 at org.apache.jcs.engine.CacheEventQueue$PutEvent.doRun(CacheEventQueue.java:440)
 at org.apache.jcs.engine.CacheEventQueue$AbstractCacheEvent.run(CacheEventQueue.java:358)
 at org.apache.jcs.engine.CacheEventQueue$QProcessor.run(CacheEventQueue.java:327)
22.06.2004 10:41:10 org.apache.jcs.engine.CacheEventQueue$QProcessor run
INFO: QProcessor exiting for listenerId=-56, cacheName=main
22.06.2004 10:41:10 org.apache.jcs.auxiliary.disk.indexed.IndexedDiskCache optimizeFile
INFO: Optomizing file keyHash.size()=0
22.06.2004 10:41:10 org.apache.jcs.auxiliary.disk.indexed.IndexedDiskCache doDispose
WARNUNG: Closing files, base filename: groupIdCache
22.06.2004 10:41:10 org.apache.jcs.engine.control.CompositeCache dispose
WARNUNG: Called close for groupIdCache
Total time: 0 minutes 16 seconds,  Site size: 118.351 Site pages: 11
------------------------------
Static site was successfully generated at:
C:\develop\workspace\de.escnet.net4j.docs\build\site
------------------------------


BUILD SUCCESSFUL
Total time: 21 seconds


ciao
/eike