[opencms-dev] OpenCms won't start any more: CmsVfsResourceNotFoundException

[sub1 at elucid.org]

Hi folks,

I've been building a site in OpenCms (and greatly enjoying it - it's a
wonderful tool!).

But now I am getting this when I try to start Tomcat (I have included some
of the startup log lines but I've snipped out most of it to show just the
system config, the fact that everything's fine for most of the startup,
and then the errors at the end, followed by a system shutdown):

It seems like there are some spurious VFS entries that OpenCms is trying
to process and can't: for example, '[B at 351b05' and similar...

<snip>
22 Nov 2005 20:05:46,670 INFO [ org.OpenCms.main.OpenCmsCore:1103] .
OpenCms version : 6.0.2
22 Nov 2005 20:05:46,676 INFO [ org.OpenCms.main.OpenCmsCore:1106] .
Servlet container : Apache Tomcat/5.5.12
22 Nov 2005 20:05:46,678 INFO [ org.OpenCms.main.OpenCmsCore:1107] .
OpenCms webapp name : ROOT
22 Nov 2005 20:05:46,682 INFO [ org.OpenCms.main.OpenCmsCore:1108] .
OpenCms servlet path : /OpenCms
22 Nov 2005 20:05:46,691 INFO [ org.OpenCms.main.OpenCmsCore:1109] .
OpenCms context : /OpenCms
22 Nov 2005 20:05:46,709 INFO [ org.OpenCms.main.OpenCmsCore:1110] .
OpenCms WEB-INF path : /usr/local/tomcat/webapps/ROOT/WEB-INF/
22 Nov 2005 20:05:46,716 INFO [ org.OpenCms.main.OpenCmsCore:1111] .
OpenCms property file:
/usr/local/tomcat/webapps/ROOT/WEB-INF/config/OpenCms.properties
22 Nov 2005 20:05:46,734 INFO [ org.OpenCms.main.OpenCmsCore:1114] .
OpenCms log file :
/usr/local/apache-tomcat-5.5.12/webapps/ROOT/WEB-INF/logs/OpenCms.log
22 Nov 2005 20:05:46,740 INFO [ org.OpenCms.main.OpenCmsCore: 798] .
System file.encoding : MacRoman
22 Nov 2005 20:05:46,796 INFO [ org.OpenCms.main.OpenCmsCore: 804] .
Ethernet address used: 00:30:65:b0:8d:62
22 Nov 2005 20:05:46,799 INFO [org.OpenCms.main.CmsSystemInfo: 594] .
Server name is : OpenCmsServer
22 Nov 2005 20:05:46,831 INFO [ org.OpenCms.main.OpenCmsCore: 822] . Java
VM in use : Java HotSpot(TM) Client VM 1.5.0_02-36 mixed mode, sharing
"Apple Computer, Inc."
22 Nov 2005 20:05:46,834 INFO [ org.OpenCms.main.OpenCmsCore: 826] .
Operating sytem : Mac OS X 10.4.3 ppc
<snip>
22 Nov 2005 20:06:07,576 INFO [.workplace.CmsWorkplaceManager: 297] .
Adding type setting : bookmark
22 Nov 2005 20:06:08,098 INFO [.workplace.CmsWorkplaceManager: 297] .
Adding type setting : microsite
22 Nov 2005 20:06:08,610 INFO [.workplace.CmsWorkplaceManager: 297] .
Adding type setting : emailform
22 Nov 2005 20:06:09,579 ERROR [.workplace.CmsWorkplaceManager:1210] Error
reading view folder: [B at 3b386/
org.OpenCms.file.CmsVfsResourceNotFoundException: Error reading resource
from path "/[B at 3b386/".
at
org.OpenCms.file.CmsVfsResourceNotFoundException.createException(CmsVfsResourceNotFoundException.java:78)
at org.OpenCms.db.CmsDbContext.throwException(CmsDbContext.java:213)
at org.OpenCms.db.CmsDbContext.report(CmsDbContext.java:197)
at
org.OpenCms.db.CmsSecurityManager.readResource(CmsSecurityManager.java:3838)
<snip>
22 Nov 2005 20:06:09,618 ERROR [.workplace.CmsWorkplaceManager:1210] Error
reading view folder: [B at 878286/
org.OpenCms.file.CmsVfsResourceNotFoundException: Error reading resource
from path "/[B at 878286/".
at
org.OpenCms.file.CmsVfsResourceNotFoundException.createException(CmsVfsResourceNotFoundException.java:78)
at org.OpenCms.db.CmsDbContext.throwException(CmsDbContext.java:213)
at org.OpenCms.db.CmsDbContext.report(CmsDbContext.java:197)
at
org.OpenCms.db.CmsSecurityManager.readResource(CmsSecurityManager.java:3838)
<snip>
22 Nov 2005 20:06:09,636 ERROR [.workplace.CmsWorkplaceManager:1210] Error
reading view folder: [B at 8a4240/
org.OpenCms.file.CmsVfsResourceNotFoundException: Error reading resource
from path "/[B at 8a4240/".
at
org.OpenCms.file.CmsVfsResourceNotFoundException.createException(CmsVfsResourceNotFoundException.java:78)
at org.OpenCms.db.CmsDbContext.throwException(CmsDbContext.java:213)
at org.OpenCms.db.CmsDbContext.report(CmsDbContext.java:197)
at
org.OpenCms.db.CmsSecurityManager.readResource(CmsSecurityManager.java:3838)
<snip>
22 Nov 2005 20:06:09,652 ERROR [.workplace.CmsWorkplaceManager:1210] Error
reading view folder: [B at ff3358/
org.OpenCms.file.CmsVfsResourceNotFoundException: Error reading resource
from path "/[B at ff3358/".
at
org.OpenCms.file.CmsVfsResourceNotFoundException.createException(CmsVfsResourceNotFoundException.java:78)
at org.OpenCms.db.CmsDbContext.throwException(CmsDbContext.java:213)
at org.OpenCms.db.CmsDbContext.report(CmsDbContext.java:197)
at
org.OpenCms.db.CmsSecurityManager.readResource(CmsSecurityManager.java:3838)
<snip>
22 Nov 2005 20:06:09,775 INFO [.workplace.CmsWorkplaceManager: 741] .
Workplace config : vfs access initialized
22 Nov 2005 20:06:09,915 INFO [workplace.tools.CmsToolManager: 113] . Tool
Manager config : Tool Manager is being initialized
22 Nov 2005 20:06:10,105 ERROR [workplace.tools.CmsToolManager: 164] .
Tool Manager config : unknown error during initialization
org.OpenCms.file.CmsVfsResourceNotFoundException: Error reading resource
from path "/[B at 351b05".
at
org.OpenCms.file.CmsVfsResourceNotFoundException.createException(CmsVfsResourceNotFoundException.java:78)
at org.OpenCms.db.CmsDbContext.throwException(CmsDbContext.java:213)
at org.OpenCms.db.CmsDbContext.report(CmsDbContext.java:197)
at
org.OpenCms.db.CmsSecurityManager.readResource(CmsSecurityManager.java:3838)
<snip>
22 Nov 2005 20:06:10,114 INFO [ org.OpenCms.main.OpenCmsCore:2056] .
Runlevel change : Switching from 2 to 4
22 Nov 2005 20:06:10,196 INFO [ org.OpenCms.main.OpenCmsCore: 360] . Added
RequestHandler : 404 (org.OpenCms.main.OpenCmsServlet)
22 Nov 2005 20:06:10,198 INFO [ org.OpenCms.main.OpenCmsCore:1273] .
OpenCms is running! : Total startup time was 00:00:24
<snip
22 Nov 2005 20:06:15,393 INFO [ org.OpenCms.main.OpenCmsCore:1362] .
Performing shutdown : 6.0.2
22 Nov 2005 20:06:15,394 INFO [ org.OpenCms.main.OpenCmsCore:1365] .
Current runlevel : 4
22 Nov 2005 20:06:15,402 INFO [ org.OpenCms.main.OpenCmsCore:1366] .
Shutdown time : Nov 22, 2005 8:06:15 PM
22 Nov 2005 20:06:15,404 INFO [ org.OpenCms.main.OpenCmsCore:2056] .
Runlevel change : Switching from 4 to 0
22 Nov 2005 20:06:15,414 INFO [cexport.CmsStaticExportManager:1741] .
Shutting down : org.OpenCms.staticexport.CmsStaticExportManager ... ok!
22 Nov 2005 20:06:15,430 INFO [pencms.module.CmsModuleManager: 700] .
Module configuration : shutting down module class
com.OpenCms.legacy.CmsLegacyModuleAction
22 Nov 2005 20:06:15,432 INFO [pencms.module.CmsModuleManager: 715] .
Module configuration : 1 module classes have been shut down
22 Nov 2005 20:06:15,434 INFO [pencms.module.CmsModuleManager: 719] .
Shutting down : org.OpenCms.module.CmsModuleManager ... ok!
<snip>
22 Nov 2005 20:06:15,498 INFO [ org.OpenCms.main.OpenCmsCore:1423] .
OpenCms stopped! : Total uptime was 00:00:29

Any help very much appreciated!

:(

elucid