dotCMS 3.1 Not all assets loading in backend

195 views

Skip to first unread message

Umair Abbasi

unread,

Mar 19, 2015, 10:37:51 AM3/19/15

to dot...@googlegroups.com

Some assets are loading in the front-end for instance main.css. In the backend admin interface when I browse to that location in Website Editor all I get is an infinite loading. Never loads the main.css file in the back-end for me to view. And in some cases the assets are not loading in the front-end or the back-end for instance missing *.jpg files. I have tried:

Re-upgrading from 2.5.2
Flush all caches
Flush browser cache
Re-index content

Jason Tesser

unread,

Mar 19, 2015, 10:46:07 AM3/19/15

to dot...@googlegroups.com

i haven't seen this. That is weird. Seems like some network or
browser cache even though I see you said u cleared it.

> --
> You received this message because you are subscribed to the Google Groups
> "dotCMS User Group" group.
> To unsubscribe from this group and stop receiving emails from it, send an
> email to dotcms+un...@googlegroups.com.
> To post to this group, send email to dot...@googlegroups.com.
> Visit this group at http://groups.google.com/group/dotcms.
> For more options, visit https://groups.google.com/d/optout.

--

3250 Mary Street
Suite 405
Miami, FL 33133
Main: 305-900-2001 | Direct: 305.209.8104

jason....@dotcms.com | dotcms.com

Umair Abbasi

unread,

Mar 19, 2015, 10:54:39 AM3/19/15

to dot...@googlegroups.com

Not seeing any error in catalina.out either except for "ERROR java.lang.String - substring" on every page load. Gets even weirder where I am able to pull up main.css from content tab->file asset structure. Able to open it etc. But not able to browse to it under website editor.

Umair Abbasi

unread,

Mar 19, 2015, 5:24:44 PM3/19/15

to dot...@googlegroups.com

After trying quite a few things still not getting assets to co-operate. What I have realized is the index size is really small. The actual index on prod 2.5.7 is around 3GB. On 3.1 test its only 300mb.

On Thursday, March 19, 2015 at 9:37:51 AM UTC-5, Umair Abbasi wrote:

Will Ezell

unread,

Mar 19, 2015, 5:34:37 PM3/19/15

to dot...@googlegroups.com

Are you seeing any errors in the logs?

--

Umair Abbasi

unread,

Mar 19, 2015, 6:26:47 PM3/19/15

to dot...@googlegroups.com

Here is a dump of the entire log on first start-up with database and assets in place.

Using DOTCMS_HOME = /mnt/dotcms/dotserver/tomcat-7.0.54/webapps/ROOT

Using DOTSERVER = dotcms

Using CATALINA_PID = /tmp/dotcms.pid

Using JAVA_OPTS = -Djava.awt.headless=true -Xverify:none -Dfile.encoding=UTF8 -server -Xmx4G -XX:MaxPermSize=512m -XX:+DisableExplicitGC -XX:+UseConcMarkSweepGC -javaagent:/mnt/dotcms/dotserver/tomcat-7.0.54/webapps/ROOT/WEB-INF/lib/dot.jamm-0.2.5_1.jar -Ddotserver=dotcms

Using CATALINA_BASE: /mnt/dotcms/dotserver/tomcat-7.0.54

Using CATALINA_HOME: /mnt/dotcms/dotserver/tomcat-7.0.54

Using CATALINA_TMPDIR: /mnt/dotcms/dotserver/tomcat-7.0.54/temp

Using JRE_HOME: /usr/lib/jvm/java-7-oracle/

Using CLASSPATH: /mnt/dotcms/dotserver/tomcat-7.0.54/bin/bootstrap.jar:/mnt/dotcms/dotserver/tomcat-7.0.54/bin/tomcat-juli.jar

Using CATALINA_PID: /tmp/dotcms.pid

Tomcat started.

root@sandbox:/mnt/dotcms# tail -f dotserver/tomc*/logs/catalina.out

Mar 19, 2015 5:11:33 PM org.apache.coyote.AbstractProtocol init

INFO: Initializing ProtocolHandler ["http-bio-80"]

Mar 19, 2015 5:11:33 PM org.apache.catalina.startup.Catalina load

INFO: Initialization processed in 2155 ms

Mar 19, 2015 5:11:33 PM org.apache.catalina.core.StandardService startInternal

INFO: Starting service Catalina

Mar 19, 2015 5:11:33 PM org.apache.catalina.core.StandardEngine startInternal

INFO: Starting Servlet Engine: Apache Tomcat/7.0.54

Mar 19, 2015 5:11:33 PM org.apache.catalina.startup.HostConfig deployDirectory

INFO: Deploying web application directory /mnt/dotcms/dotserver/tomcat-7.0.54/webapps/ROOT

Mar 19, 2015 5:12:03 PM org.apache.catalina.startup.TaglibUriRule body

INFO: TLD skipped. URI: http://struts.apache.org/tags-html is already defined

Mar 19, 2015 5:12:03 PM org.apache.catalina.startup.TaglibUriRule body

INFO: TLD skipped. URI: http://struts.apache.org/tags-logic is already defined

Mar 19, 2015 5:12:03 PM org.apache.catalina.startup.TaglibUriRule body

INFO: TLD skipped. URI: http://struts.apache.org/tags-nested is already defined

Mar 19, 2015 5:12:03 PM org.apache.catalina.startup.TaglibUriRule body

INFO: TLD skipped. URI: http://struts.apache.org/tags-tiles is already defined

Mar 19, 2015 5:12:03 PM org.apache.catalina.startup.TaglibUriRule body

INFO: TLD skipped. URI: http://struts.apache.org/tags-nested is already defined

Mar 19, 2015 5:12:03 PM org.apache.catalina.startup.TaglibUriRule body

INFO: TLD skipped. URI: http://struts.apache.org/tags-logic is already defined

Mar 19, 2015 5:12:04 PM org.apache.catalina.startup.TaglibUriRule body

INFO: TLD skipped. URI: http://struts.apache.org/tags-html is already defined

INFO - Initializing properties reader.

INFO - Loading dotCMS [dotmarketing-config.properties] Properties...

INFO - dotCMS Properties [dotmarketing-config.properties] Loaded

INFO - Loading dotCMS [dotcms-config-cluster.properties] Properties...

INFO - dotCMS Properties [dotcms-config-cluster.properties] Loaded

INFO - Assigned default refresh: 5 minutes.

2015-03-19 17:12:05,131 INFO com.dotcms.util.AsciiArt -

2015-03-19 17:12:05,133 INFO com.dotcms.util.AsciiArt -

2015-03-19 17:12:05,133 INFO com.dotcms.util.AsciiArt - OOOO 7777777 7777 7777 77777777

2015-03-19 17:12:05,133 INFO com.dotcms.util.AsciiArt - OOOO OO 777777777 77777 77777 77777777

2015-03-19 17:12:05,133 INFO com.dotcms.util.AsciiArt - OOOO OOO 77777 777777 77777 7777

2015-03-19 17:12:05,133 INFO com.dotcms.util.AsciiArt - OOOOOOOOOO OOOOOOOO OOOOOOOOO 7777 7777777 777777 7777

2015-03-19 17:12:05,133 INFO com.dotcms.util.AsciiArt - OOOO OOOOO OOOO OOOO OOOO 7777 7777777 7777777 777777

2015-03-19 17:12:05,133 INFO com.dotcms.util.AsciiArt - OOOO OOOO OOO OOOO OOOO 7777 77777777 777 7777 777777

2015-03-19 17:12:05,133 INFO com.dotcms.util.AsciiArt - OOOO OOOO OOOO OOOO OOOO 7777 777 777 777 7777 7777

2015-03-19 17:12:05,133 INFO com.dotcms.util.AsciiArt - OOOO OOOO OOO OOOO OOOO 77777 777 777777 7777 7777

2015-03-19 17:12:05,133 INFO com.dotcms.util.AsciiArt - OOOO OOOO OOOO OOO OOOO 77777 777 7777 7777 7777

2015-03-19 17:12:05,133 INFO com.dotcms.util.AsciiArt - OOOOOOOOOO OOOOOOOO OOOOO 777777777 777 7777 7777 777777777

2015-03-19 17:12:05,133 INFO com.dotcms.util.AsciiArt -

2015-03-19 17:12:05,133 INFO com.dotcms.util.AsciiArt - Content Management System

2015-03-19 17:12:05,133 INFO com.dotcms.util.AsciiArt -

2015-03-19 17:12:06,144 INFO com.dotmarketing.util.OSGIUtil - Felix dir: /mnt/dotcms/dotserver/tomcat-7.0.54/webapps/ROOT/WEB-INF/felix

2015-03-19 17:12:06,147 INFO com.dotmarketing.util.OSGIUtil - Loading property felix.auto.deploy.action=install,start

2015-03-19 17:12:06,147 INFO com.dotmarketing.util.OSGIUtil - Loading property felix.fileinstall.start.level=1

2015-03-19 17:12:06,148 INFO com.dotmarketing.util.OSGIUtil - Loading property felix.fileinstall.log.level=3

2015-03-19 17:12:06,148 INFO com.dotmarketing.util.OSGIUtil - Loading property org.osgi.framework.startlevel.beginning=2

2015-03-19 17:12:06,148 INFO com.dotmarketing.util.OSGIUtil - Loading property org.osgi.framework.storage.clean=onFirstInit

2015-03-19 17:12:06,148 INFO com.dotmarketing.util.OSGIUtil - Loading property felix.log.level=4

2015-03-19 17:12:06,735 INFO com.dotmarketing.util.OSGIUtil - Loading Factory com.dotcms.repackage.org.apache.felix.framework.FrameworkFactory

DEBUG: WIRE: [1.0] osgi.wiring.package; (osgi.wiring.package=com.dotcms.repackage.javax.xml.stream) -> [0]

DEBUG: WIRE: [1.0] osgi.wiring.package; (&(osgi.wiring.package=com.dotcms.repackage.org.osgi.framework)(version>=1.4.0)(!(version>=2.0.0))) -> [0]

DEBUG: WIRE: [1.0] osgi.wiring.package; (&(osgi.wiring.package=com.dotcms.repackage.org.osgi.service.log)(version>=1.3.0)(!(version>=2.0.0))) -> [3.0]

DEBUG: WIRE: [1.0] osgi.wiring.package; (&(osgi.wiring.package=com.dotcms.repackage.org.osgi.service.url)(version>=1.0.0)(!(version>=2.0.0))) -> [0]

DEBUG: WIRE: [4.0] osgi.wiring.package; (osgi.wiring.package=com.dotcms.repackage.org.osgi.framework) -> [0]

DEBUG: WIRE: [4.0] osgi.wiring.package; (osgi.wiring.package=com.dotcms.repackage.org.osgi.util.tracker) -> [0]

DEBUG: WIRE: [3.0] osgi.wiring.package; (&(osgi.wiring.package=com.dotcms.repackage.org.apache.felix.service.command)(status=provisional)(version>=0.10.0)(!(version>=1.0.0))) -> [4.0]

DEBUG: WIRE: [3.0] osgi.wiring.package; (&(osgi.wiring.package=com.dotcms.repackage.org.osgi.framework)(version>=1.5.0)(!(version>=2.0.0))) -> [0]

DEBUG: WIRE: [3.0] osgi.wiring.package; (&(osgi.wiring.package=com.dotcms.repackage.org.osgi.framework.wiring)(version>=1.0.0)(!(version>=2.0.0))) -> [0]

DEBUG: WIRE: [3.0] osgi.wiring.package; (&(osgi.wiring.package=com.dotcms.repackage.org.osgi.service.packageadmin)(version>=1.2.0)(!(version>=2.0.0))) -> [0]

DEBUG: WIRE: [3.0] osgi.wiring.package; (&(osgi.wiring.package=com.dotcms.repackage.org.osgi.service.startlevel)(version>=1.1.0)(!(version>=2.0.0))) -> [0]

DEBUG: WIRE: [3.0] osgi.wiring.package; (&(osgi.wiring.package=com.dotcms.repackage.org.osgi.util.tracker)(version>=1.3.0)(!(version>=2.0.0))) -> [0]

DEBUG: WIRE: [2.0] osgi.wiring.package; (&(osgi.wiring.package=com.dotcms.repackage.org.osgi.framework)(version>=1.4.0)(!(version>=2.0.0))) -> [0]

DEBUG: WIRE: [2.0] osgi.wiring.package; (&(osgi.wiring.package=com.dotcms.repackage.org.osgi.service.log)(version>=1.3.0)(!(version>=2.0.0))) -> [3.0]

DEBUG: WIRE: [2.0] osgi.wiring.package; (&(osgi.wiring.package=com.dotcms.repackage.org.osgi.service.packageadmin)(version>=1.2.0)(!(version>=2.0.0))) -> [0]

DEBUG: WIRE: [2.0] osgi.wiring.package; (&(osgi.wiring.package=com.dotcms.repackage.org.osgi.service.startlevel)(version>=1.1.0)(!(version>=2.0.0))) -> [0]

DEBUG: WIRE: [2.0] osgi.wiring.package; (&(osgi.wiring.package=com.dotcms.repackage.org.osgi.service.url)(version>=1.0.0)(!(version>=2.0.0))) -> [0]

DEBUG: WIRE: [2.0] osgi.wiring.package; (&(osgi.wiring.package=com.dotcms.repackage.org.osgi.util.tracker)(version>=1.4.0)(!(version>=2.0.0))) -> [0]

DEBUG: DYNAMIC WIRE: [3.0] osgi.wiring.package; (osgi.wiring.package=com.dotcms.repackage.org.apache.felix.bundlerepository) -> [1.0]

DEBUG: WIRE: [5.0] osgi.wiring.package; (&(osgi.wiring.package=com.dotcms.repackage.org.apache.felix.service.command)(status=provisional)(version>=0.10.0)) -> [4.0]

DEBUG: WIRE: [5.0] osgi.wiring.package; (osgi.wiring.package=com.dotcms.repackage.org.osgi.framework) -> [0]

DEBUG: WIRE: [5.0] osgi.wiring.package; (osgi.wiring.package=com.dotcms.repackage.org.osgi.service.startlevel) -> [0]

DEBUG: WIRE: [5.0] osgi.wiring.package; (osgi.wiring.package=com.dotcms.repackage.org.osgi.util.tracker) -> [0]

DEBUG: WIRE: [6.0] osgi.wiring.package; (osgi.wiring.package=javax.net.ssl) -> [0]

DEBUG: WIRE: [6.0] osgi.wiring.package; (osgi.wiring.package=javax.security.cert) -> [0]

DEBUG: WIRE: [6.0] osgi.wiring.package; (&(osgi.wiring.package=javax.servlet)(version>=2.5.0)) -> [0]

DEBUG: WIRE: [6.0] osgi.wiring.package; (&(osgi.wiring.package=javax.servlet.http)(version>=2.5.0)) -> [0]

DEBUG: WIRE: [6.0] osgi.wiring.package; (osgi.wiring.package=com.dotcms.repackage.javax.xml.parsers) -> [0]

DEBUG: WIRE: [6.0] osgi.wiring.package; (&(osgi.wiring.package=com.dotcms.repackage.org.osgi.framework)(version>=1.3.0)) -> [0]

DEBUG: WIRE: [6.0] osgi.wiring.package; (&(osgi.wiring.package=com.dotcms.repackage.org.osgi.service.log)(version>=1.3.0)) -> [3.0]

DEBUG: WIRE: [6.0] osgi.wiring.package; (&(osgi.wiring.package=com.dotcms.repackage.org.osgi.util.tracker)(version>=1.3.0)) -> [0]

DEBUG: WIRE: [6.0] osgi.wiring.package; (osgi.wiring.package=com.dotcms.repackage.org.slf4j) -> [0]

DEBUG: WIRE: [6.0] osgi.wiring.package; (osgi.wiring.package=com.dotcms.repackage.org.xml.sax) -> [0]

DEBUG: WIRE: [6.0] osgi.wiring.package; (osgi.wiring.package=com.dotcms.repackage.org.xml.sax.helpers) -> [0]

[INFO] Started bridged http service

2015-03-19 17:12:07,752 INFO com.dotmarketing.util.OSGIUtil - osgi felix framework started

2015-03-19 17:12:07,769 INFO com.dotcms.enterprise.cmis.server.CMISServiceFactoryImpl - Initializing in-memory repository...

2015-03-19 17:12:07,808 INFO com.dotcms.enterprise.cmis.server.CMISServiceFactoryImpl - ...initialized in-memory repository.

2015-03-19 17:12:07,808 INFO com.dotcms.repackage.org.apache.chemistry.opencmis.server.impl.CmisRepositoryContextListener - Initialized Services Factory: com.dotcms.enterprise.cmis.server.CMISServiceFactoryImpl

2015-03-19 17:12:07,852 INFO com.liferay.util.SystemProperties - Loading file:/mnt/dotcms/dotserver/tomcat-7.0.54/webapps/ROOT/WEB-INF/classes/system.properties

2015-03-19 17:12:07,865 INFO com.liferay.util.SystemProperties - Loading file:/mnt/dotcms/dotserver/tomcat-7.0.54/webapps/ROOT/WEB-INF/classes/system-ext.properties

2015-03-19 17:12:07,888 INFO com.liferay.portal.util.PropsLoader - Loading file:/mnt/dotcms/dotserver/tomcat-7.0.54/webapps/ROOT/WEB-INF/classes/portal.properties

2015-03-19 17:12:07,889 INFO com.liferay.portal.util.PropsLoader - Loading file:/mnt/dotcms/dotserver/tomcat-7.0.54/webapps/ROOT/WEB-INF/classes/portal-ext.properties

2015-03-19 17:12:08,092 INFO com.dotmarketing.business.CacheLocator - loading cache administrator: com.dotmarketing.business.DotGuavaCacheAdministratorImpl

2015-03-19 17:12:08,364 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : default: 1000

2015-03-19 17:12:08,364 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : livecache: 1000

2015-03-19 17:12:08,365 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : workingcache: 1000

2015-03-19 17:12:08,365 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : adminconfigpool: 100

2015-03-19 17:12:08,365 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : blockdirectivecache: 1000

2015-03-19 17:12:08,366 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : categorybykeycache: 1000

2015-03-19 17:12:08,366 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : categorycache: 1000

2015-03-19 17:12:08,366 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : categorychildrencache: 1000

2015-03-19 17:12:08,367 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : categoryparentscache: 1000

2015-03-19 17:12:08,367 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : companypool: 10

2015-03-19 17:12:08,368 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : contentletcache: 5000

2015-03-19 17:12:08,368 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : fileassetmetadatacache: 200

2015-03-19 17:12:08,368 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : dotcmslayoutcache: 1000

2015-03-19 17:12:08,369 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : dotcmsrolecache: 1000

2015-03-19 17:12:08,369 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : dotcmsrolekeycache: 1000

2015-03-19 17:12:08,376 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : dotcmsuserrolecache: 1000

2015-03-19 17:12:08,376 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : fieldscache: 1000

2015-03-19 17:12:08,376 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : filecache: 1000

2015-03-19 17:12:08,376 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : foldercache: 1000

2015-03-19 17:12:08,376 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : hostaliascache: 1000

2015-03-19 17:12:08,376 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : hostcache: 1000

2015-03-19 17:12:08,376 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : hostvariablescache: 1000

2015-03-19 17:12:08,376 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : htmlpagecache: 1000

2015-03-19 17:12:08,376 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : identifiercache: 50000

2015-03-19 17:12:08,376 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : languagecacheimpl: 1000

2015-03-19 17:12:08,376 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : navcache: 1000

2015-03-19 17:12:08,376 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : parentpermissionablecache: 10000

2015-03-19 17:12:08,376 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : permissioncache: 50000

2015-03-19 17:12:08,376 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : plugincache: 1000

2015-03-19 17:12:08,376 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : portletpool: 100

2015-03-19 17:12:08,376 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : structurecache: 500

2015-03-19 17:12:08,376 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : templatecache: 500

2015-03-19 17:12:08,376 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : userdotcmscache: 1000

2015-03-19 17:12:08,376 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : useremaildotcmscache: 1000

2015-03-19 17:12:08,376 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : userproxycache: 1000

2015-03-19 17:12:08,376 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : velocitycache: 1000

2015-03-19 17:12:08,376 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : velocitymenucache: 1000

2015-03-19 17:12:08,376 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : velocitymisscache: 1000

2015-03-19 17:12:08,376 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : versioncache: 50000

2015-03-19 17:12:08,376 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : versioninfocache: 50000

2015-03-19 17:12:08,376 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : virtuallinkscache: 1000

2015-03-19 17:12:08,376 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : workflowcache: 1000

2015-03-19 17:12:08,376 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : workflowstepcache: 1000

2015-03-19 17:12:08,376 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : workflowtaskcache: 10000

2015-03-19 17:12:08,377 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : indiciescache: 8

2015-03-19 17:12:08,377 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : publishingendpointcache: 100

2015-03-19 17:12:08,377 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : workflowactioncache: 10000

2015-03-19 17:12:08,377 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : logmappercache: 10

2015-03-19 17:12:08,377 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : translatedquerycache: 5000

2015-03-19 17:12:08,377 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : csscache: 100

2015-03-19 17:12:08,377 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Disk : csscache: true

2015-03-19 17:12:08,377 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : dotcmsrootrolescache: 1000

2015-03-19 17:12:08,377 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : identifier404cache: 1000

2015-03-19 17:12:08,377 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : fieldsvarcache: 1000

2015-03-19 17:12:08,377 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : relationshipcachebyname: 1000

2015-03-19 17:12:08,377 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : relationshipcachebyinode: 1000

2015-03-19 17:12:08,377 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : propertycache: 1000

2015-03-19 17:12:08,377 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : containercache: 1000

2015-03-19 17:12:08,377 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : newnotificationcache: 1000

2015-03-19 17:12:08,377 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Memory : containerstructurecache: 1000

2015-03-19 17:12:08,377 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Disk : contentletcache: true

2015-03-19 17:12:08,377 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Cache Config Disk : velocitycache: true

2015-03-19 17:12:08,382 INFO com.dotmarketing.cache.H2CacheLoader - Starting Disk Cache

2015-03-19 17:12:09,097 INFO com.dotmarketing.cache.H2CacheLoader - Disk Cache Started

2015-03-19 17:12:09,148 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : structurecache, size:500, toDisk:false,Concurrency:32

Mar 19, 2015 5:12:09 PM com.dotcms.repackage.com.sun.jersey.server.impl.application.WebApplicationImpl _initiate

INFO: Initiating Jersey application, version 'Jersey: 1.12 02/15/2012 04:51 PM'

Mar 19, 2015 5:12:09 PM com.dotcms.repackage.com.sun.jersey.server.impl.application.DeferredResourceConfig$ApplicationHolder <init>

INFO: Instantiated the Application class com.dotcms.rest.config.DotRestApplication

Mar 19, 2015 5:12:10 PM com.dotcms.repackage.com.sun.jersey.spi.inject.Errors processErrorMessages

WARNING: The following warnings have been detected with resource and/or provider classes:

WARNING: A HTTP GET method, public com.dotcms.repackage.javax.ws.rs.core.Response com.dotcms.rest.elasticsearch.ESContentResourcePortlet.search(javax.servlet.http.HttpServletRequest,com.dotcms.repackage.org.codehaus.jettison.json.JSONObject) throws com.dotmarketing.exception.DotDataException,com.dotmarketing.exception.DotSecurityException, should not consume any entity.

2015-03-19 17:12:11,728 INFO com.dotcms.repackage.org.apache.struts.tiles.TilesPlugin - Tiles definition factory loaded for module ''.

2015-03-19 17:12:11,731 INFO com.dotcms.repackage.org.apache.struts.validator.ValidatorPlugIn - Loading validation rules file from '/WEB-INF/validator-rules.xml'

2015-03-19 17:12:11,732 INFO com.dotcms.repackage.org.apache.struts.validator.ValidatorPlugIn - Loading validation rules file from '/WEB-INF/validation.xml'

2015-03-19 17:12:12,166 INFO com.dotmarketing.startup.StartupTasksExecutor - Starting startup tasks.

2015-03-19 17:12:12,173 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Environment - Hibernate 2.1.8

2015-03-19 17:12:12,174 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Environment - hibernate.properties not found

2015-03-19 17:12:12,175 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Environment - using JDK 1.4 java.sql.Timestamp handling

2015-03-19 17:12:12,177 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Configuration - configuring from resource: /hibernate.cfg.xml

2015-03-19 17:12:12,177 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Configuration - Configuration resource: /hibernate.cfg.xml

2015-03-19 17:12:12,235 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Configuration - Configured SessionFactory: null

2015-03-19 17:12:12,235 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Configuration - Mapping resource: com/dotmarketing/beans/DotCMSSeq.hbm.xml

2015-03-19 17:12:12,378 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.beans.Inode -> inode

2015-03-19 17:12:12,444 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping joined-subclass: com.dotmarketing.portlets.categories.model.Category -> category

2015-03-19 17:12:12,445 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping joined-subclass: com.dotmarketing.portlets.files.model.File -> file_asset

2015-03-19 17:12:12,449 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping joined-subclass: com.dotmarketing.portlets.contentlet.business.Contentlet -> contentlet

2015-03-19 17:12:12,459 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping joined-subclass: com.dotmarketing.portlets.containers.model.Container -> containers

2015-03-19 17:12:12,461 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping joined-subclass: com.dotmarketing.portlets.folders.model.Folder -> folder

2015-03-19 17:12:12,462 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping joined-subclass: com.dotmarketing.portlets.templates.model.Template -> template

2015-03-19 17:12:12,464 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping joined-subclass: com.dotmarketing.portlets.htmlpages.model.HTMLPage -> htmlpage

2015-03-19 17:12:12,466 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping joined-subclass: com.dotmarketing.portlets.links.model.Link -> links

2015-03-19 17:12:12,468 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping joined-subclass: com.dotmarketing.portlets.mailinglists.model.MailingList -> mailing_list

2015-03-19 17:12:12,469 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping joined-subclass: com.dotmarketing.portlets.campaigns.model.Campaign -> campaign

2015-03-19 17:12:12,470 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping joined-subclass: com.dotmarketing.portlets.campaigns.model.Recipient -> recipient

2015-03-19 17:12:12,471 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping joined-subclass: com.dotmarketing.portlets.campaigns.model.Click -> click

2015-03-19 17:12:12,471 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping joined-subclass: com.dotmarketing.portlets.communications.model.Communication -> communication

2015-03-19 17:12:12,473 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping joined-subclass: com.dotmarketing.beans.UserProxy -> user_proxy

2015-03-19 17:12:12,475 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping joined-subclass: com.dotmarketing.portlets.virtuallinks.model.VirtualLink -> virtual_link

2015-03-19 17:12:12,475 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping joined-subclass: com.dotmarketing.portlets.structure.model.Structure -> structure

2015-03-19 17:12:12,476 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping joined-subclass: com.dotmarketing.portlets.structure.model.Relationship -> relationship

2015-03-19 17:12:12,477 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping joined-subclass: com.dotmarketing.portlets.structure.model.Field -> field

2015-03-19 17:12:12,478 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping joined-subclass: com.dotmarketing.portlets.user.model.UserComment -> user_comments

2015-03-19 17:12:12,480 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping joined-subclass: com.dotmarketing.portlets.userfilter.model.UserFilter -> user_filter

2015-03-19 17:12:12,482 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping joined-subclass: com.dotmarketing.portlets.report.model.Report -> report_asset

2015-03-19 17:12:12,482 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping joined-subclass: com.dotmarketing.portlets.report.model.ReportParameter -> report_parameter

2015-03-19 17:12:12,483 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.portlets.workflows.model.WorkflowTask -> workflow_task

2015-03-19 17:12:12,484 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.portlets.workflows.model.WorkflowComment -> workflow_comment

2015-03-19 17:12:12,485 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.portlets.workflows.model.WorkflowHistory -> workflow_history

2015-03-19 17:12:12,486 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.portlets.workflows.model.WorkFlowTaskFiles -> workflowtask_files

2015-03-19 17:12:12,487 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.beans.Permission -> permission

2015-03-19 17:12:12,487 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.beans.PermissionReference -> permission_reference

2015-03-19 17:12:12,488 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.beans.Tree -> tree

2015-03-19 17:12:12,544 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.beans.MultiTree -> multi_tree

2015-03-19 17:12:12,549 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.portlets.user.model.UserPreference -> user_preferences

2015-03-19 17:12:12,549 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.portlets.languagesmanager.model.Language -> language

2015-03-19 17:12:12,550 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.beans.Clickstream -> clickstream

2015-03-19 17:12:12,557 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.beans.ClickstreamRequest -> clickstream_request

2015-03-19 17:12:12,558 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.beans.Clickstream404 -> clickstream_404

2015-03-19 17:12:12,559 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.portlets.webforms.model.WebForm -> web_form

2015-03-19 17:12:12,560 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.beans.Rating -> content_rating

2015-03-19 17:12:12,561 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.tag.model.Tag -> tag

2015-03-19 17:12:12,562 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.tag.model.TagInode -> tag_inode

2015-03-19 17:12:12,565 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.beans.ChallengeQuestion -> challenge_question

2015-03-19 17:12:12,568 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.beans.Trackback -> trackback

2015-03-19 17:12:12,569 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.beans.UsersToDelete -> users_to_delete

2015-03-19 17:12:12,570 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.portlets.calendar.model.CalendarReminder -> calendar_reminder

2015-03-19 17:12:12,573 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.portlets.chains.model.Chain -> chain

2015-03-19 17:12:12,574 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.portlets.chains.model.ChainState -> chain_state

2015-03-19 17:12:12,575 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.portlets.chains.model.ChainLinkCode -> chain_link_code

2015-03-19 17:12:12,575 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.portlets.chains.model.ChainStateParameter -> chain_state_parameter

2015-03-19 17:12:12,576 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.plugin.model.Plugin -> plugin

2015-03-19 17:12:12,577 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.business.Role -> cms_role

2015-03-19 17:12:12,578 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.business.UsersRoles -> users_cms_roles

2015-03-19 17:12:12,579 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.business.LayoutsRoles -> layouts_cms_roles

2015-03-19 17:12:12,579 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.business.Layout -> cms_layout

2015-03-19 17:12:12,580 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.business.PortletsLayouts -> cms_layouts_portlets

2015-03-19 17:12:12,581 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.portlets.hostvariable.model.HostVariable -> host_variable

2015-03-19 17:12:12,582 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.beans.FixAudit -> fixes_audit

2015-03-19 17:12:12,583 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.beans.Identifier -> identifier

2015-03-19 17:12:12,583 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.beans.TemplateContainers -> template_containers

2015-03-19 17:12:12,584 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.beans.ContainerStructure -> container_structures

2015-03-19 17:12:12,585 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.portlets.dashboard.model.DashboardWorkStream -> analytic_summary_workstream

2015-03-19 17:12:12,586 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.portlets.dashboard.model.DashboardSummaryPeriod -> analytic_summary_period

2015-03-19 17:12:12,587 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.portlets.dashboard.model.DashboardSummaryVisits -> analytic_summary_visits

2015-03-19 17:12:12,588 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.portlets.dashboard.model.DashboardSummary404 -> analytic_summary_404

2015-03-19 17:12:12,590 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.portlets.dashboard.model.DashboardUserPreferences -> dashboard_user_preferences

2015-03-19 17:12:12,591 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.portlets.dashboard.model.DashboardSummary -> analytic_summary

2015-03-19 17:12:12,592 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.portlets.dashboard.model.DashboardSummaryReferer -> analytic_summary_referer

2015-03-19 17:12:12,592 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.portlets.dashboard.model.DashboardSummaryPage -> analytic_summary_pages

2015-03-19 17:12:12,593 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.portlets.dashboard.model.DashboardSummaryContent -> analytic_summary_content

2015-03-19 17:12:12,595 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.portlets.files.model.FileAssetVersionInfo -> fileasset_version_info

2015-03-19 17:12:12,596 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.portlets.contentlet.model.ContentletVersionInfo -> contentlet_version_info

2015-03-19 17:12:12,601 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.portlets.templates.model.TemplateVersionInfo -> template_version_info

2015-03-19 17:12:12,602 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.portlets.htmlpages.model.HTMLPageVersionInfo -> htmlpage_version_info

2015-03-19 17:12:12,603 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.portlets.containers.model.ContainerVersionInfo -> container_version_info

2015-03-19 17:12:12,603 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.portlets.links.model.LinkVersionInfo -> link_version_info

2015-03-19 17:12:12,604 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.portlets.structure.model.FieldVariable -> field_variable

2015-03-19 17:12:12,604 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Configuration - Mapping resource: com/dotmarketing/beans/DotCMSSeq_NOSQLGEN.hbm.xml

2015-03-19 17:12:12,624 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotmarketing.plugin.model.PluginProperty -> plugin_property

2015-03-19 17:12:12,643 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Configuration - processing one-to-many association mappings

2015-03-19 17:12:12,643 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping collection: com.dotmarketing.beans.Clickstream.clickstreamRequests -> clickstream_request

2015-03-19 17:12:12,643 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping collection: com.dotmarketing.portlets.dashboard.model.DashboardSummary404.userPreferences -> dashboard_user_preferences

2015-03-19 17:12:12,643 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Configuration - processing one-to-one association property references

2015-03-19 17:12:12,643 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Configuration - processing foreign key constraints

2015-03-19 17:12:12,661 INFO com.dotcms.repackage.net.sf.hibernate.dialect.Dialect - Using dialect: com.dotcms.repackage.net.sf.hibernate.dialect.PostgreSQLDialect

2015-03-19 17:12:12,666 INFO com.dotcms.repackage.net.sf.hibernate.cfg.SettingsFactory - Use outer join fetching: true

2015-03-19 17:12:12,668 INFO com.dotcms.repackage.net.sf.hibernate.connection.ConnectionProviderFactory - Initializing connection provider: com.liferay.util.dao.hibernate.DSConnectionProvider

2015-03-19 17:12:12,671 INFO com.dotcms.repackage.net.sf.hibernate.transaction.TransactionManagerLookupFactory - No TransactionManagerLookup configured (in JTA environment, use of process level read-write cache is not recommended)

2015-03-19 17:12:12,696 INFO com.dotcms.repackage.net.sf.hibernate.cfg.SettingsFactory - Use scrollable result sets: true

2015-03-19 17:12:12,696 INFO com.dotcms.repackage.net.sf.hibernate.cfg.SettingsFactory - Use JDBC3 getGeneratedKeys(): true

2015-03-19 17:12:12,696 INFO com.dotcms.repackage.net.sf.hibernate.cfg.SettingsFactory - Optimize cache for minimal puts: false

2015-03-19 17:12:12,696 INFO com.dotcms.repackage.net.sf.hibernate.cfg.SettingsFactory - Query language substitutions: {}

2015-03-19 17:12:12,696 INFO com.dotcms.repackage.net.sf.hibernate.cfg.SettingsFactory - cache provider: com.dotcms.repackage.net.sf.hibernate.cache.EhCacheProvider

2015-03-19 17:12:12,698 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Configuration - instantiating and configuring caches

Mar 19, 2015 5:12:12 PM com.dotcms.repackage.net.sf.ehcache.config.ConfigurationFactory parseConfiguration

WARNING: No configuration found. Configuring ehcache from ehcache-failsafe.xml found in the classpath: jar:file:/mnt/dotcms/dotserver/tomcat-7.0.54/webapps/ROOT/WEB-INF/lib/dot.ehcache-1.6.1_1.jar!/ehcache-failsafe.xml

2015-03-19 17:12:12,823 INFO com.dotcms.repackage.net.sf.hibernate.impl.SessionFactoryImpl - building session factory

2015-03-19 17:12:13,665 INFO com.dotcms.repackage.net.sf.hibernate.impl.SessionFactoryObjectFactory - Not binding factory to JNDI, no JNDI name configured

2015-03-19 17:12:14,758 INFO com.dotmarketing.startup.StartupTasksExecutor - Not running: Task00001LoadSchema

2015-03-19 17:12:14,760 INFO com.dotmarketing.startup.StartupTasksExecutor - Running: Task00003CreateSystemRoles

2015-03-19 17:12:15,174 INFO com.dotmarketing.startup.StartupTasksExecutor - Not running: Task00004LoadStarter

2015-03-19 17:12:15,176 INFO com.dotmarketing.startup.StartupTasksExecutor - Not running: Task00005LoadFixassets

2015-03-19 17:12:15,177 INFO com.dotmarketing.startup.StartupTasksExecutor - Running: Task00006CreateSystemLayout

2015-03-19 17:12:15,245 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : dotcmslayoutcache, size:1000, toDisk:false,Concurrency:32

2015-03-19 17:12:15,381 INFO com.dotmarketing.startup.StartupTasksExecutor - Not running: Task00007RemoveSitesearchQuartzJob

2015-03-19 17:12:15,406 WARN com.dotmarketing.startup.runalways.Task00009ClusterInitialize - Autowire Cluster is not initializing as this looks like the system is upgrading or the sitelic table cannot be found

2015-03-19 17:12:15,406 INFO com.dotmarketing.startup.StartupTasksExecutor - Not running: Task00009ClusterInitialize

2015-03-19 17:12:15,407 INFO com.dotmarketing.startup.StartupTasksExecutor - Finishing startup tasks.

2015-03-19 17:12:15,407 INFO com.dotmarketing.startup.StartupTasksExecutor - Starting upgrade tasks.

2015-03-19 17:12:15,407 INFO com.dotmarketing.startup.StartupTasksExecutor - Database version: 1075

2015-03-19 17:12:15,409 ERROR com.dotmarketing.common.reindex.ReindexThread - No ContentIndexationThread available

2015-03-19 17:12:15,410 INFO com.dotmarketing.startup.StartupTasksExecutor - Running: Task01080CreateModDateForMissingObjects

2015-03-19 17:12:15,410 INFO com.dotmarketing.common.db.DotConnect - Executing alter table folder add mod_date timestamp

2015-03-19 17:12:15,463 INFO com.dotmarketing.common.db.DotConnect - Executing alter table structure add mod_date timestamp

2015-03-19 17:12:15,492 INFO com.dotmarketing.common.db.DotConnect - Executing alter table category add mod_date timestamp

2015-03-19 17:12:15,568 INFO com.dotmarketing.common.db.DotConnect - Executing update folder set mod_date = now();

2015-03-19 17:12:15,918 INFO com.dotmarketing.common.db.DotConnect - Executing update structure set mod_date = now();

2015-03-19 17:12:16,037 INFO com.dotmarketing.common.db.DotConnect - Executing update category set mod_date = now();

2015-03-19 17:12:16,087 INFO com.dotmarketing.common.db.DotConnect - Executing update workflow_scheme set mod_date = now();

2015-03-19 17:12:16,099 INFO com.dotmarketing.startup.StartupTasksExecutor - Database upgraded to version: 1080

2015-03-19 17:12:16,100 INFO com.dotmarketing.startup.StartupTasksExecutor - Running: Task01085CreateBundleTablesIfNotExists

2015-03-19 17:12:16,106 INFO com.dotmarketing.startup.StartupTasksExecutor - Database upgraded to version: 1085

2015-03-19 17:12:16,107 INFO com.dotmarketing.startup.StartupTasksExecutor - Running: Task01090AddWorkflowSchemeUniqueNameContraint

2015-03-19 17:12:16,107 INFO com.dotmarketing.common.db.DotConnect - Executing alter table workflow_scheme add constraint unique_workflow_scheme_name unique (name)

2015-03-19 17:12:16,266 INFO com.dotmarketing.startup.StartupTasksExecutor - Database upgraded to version: 1090

2015-03-19 17:12:16,267 INFO com.dotmarketing.startup.StartupTasksExecutor - Running: Task01095CreateIntegrityCheckerResultTables

2015-03-19 17:12:16,268 INFO com.dotmarketing.common.db.DotConnect - Executing create table folders_ir(folder varchar(255), local_inode varchar(36), remote_inode varchar(36), local_identifier varchar(36), remote_identifier varchar(36), endpoint_id varchar(36), PRIMARY KEY (local_inode, endpoint_id))

2015-03-19 17:12:16,349 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create table folders_ir(folder varchar(255), local_inode varchar(36), remote_inode varchar(36), local_identifier varchar(36), remote_identifier varchar(36), endpoint_id varchar(36), PRIMARY KEY (local_inode, endpoint_id))

2015-03-19 17:12:16,349 INFO com.dotmarketing.common.db.DotConnect - Executing create table structures_ir(velocity_name varchar(255), local_inode varchar(36), remote_inode varchar(36), endpoint_id varchar(36), PRIMARY KEY (local_inode, endpoint_id))

2015-03-19 17:12:16,352 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create table structures_ir(velocity_name varchar(255), local_inode varchar(36), remote_inode varchar(36), endpoint_id varchar(36), PRIMARY KEY (local_inode, endpoint_id))

2015-03-19 17:12:16,352 INFO com.dotmarketing.common.db.DotConnect - Executing create table schemes_ir(name varchar(255), local_inode varchar(36), remote_inode varchar(36), endpoint_id varchar(36), PRIMARY KEY (local_inode, endpoint_id))

2015-03-19 17:12:16,367 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create table schemes_ir(name varchar(255), local_inode varchar(36), remote_inode varchar(36), endpoint_id varchar(36), PRIMARY KEY (local_inode, endpoint_id))

2015-03-19 17:12:16,370 INFO com.dotmarketing.startup.StartupTasksExecutor - Database upgraded to version: 1095

2015-03-19 17:12:16,371 INFO com.dotmarketing.startup.StartupTasksExecutor - Running: Task01096CreateContainerStructuresTable

2015-03-19 17:12:16,372 INFO com.dotmarketing.common.db.DotConnect - Executing drop table container_structures

2015-03-19 17:12:16,372 INFO com.dotmarketing.startup.runonce.Task01096CreateContainerStructuresTable - container_structures table does not exist. Will be created.

2015-03-19 17:12:16,372 INFO com.dotmarketing.common.db.DotConnect - Executing Create table container_structures(id varchar(36) NOT NULL primary key,container_id varchar(36) NOT NULL,structure_id varchar(36) NOT NULL, code text)

2015-03-19 17:12:16,381 INFO com.dotmarketing.startup.StartupTasksExecutor - Database upgraded to version: 1096

2015-03-19 17:12:16,382 INFO com.dotmarketing.startup.StartupTasksExecutor - Running: Task03000CreateContainertStructures

2015-03-19 17:12:16,382 INFO com.dotmarketing.common.db.DotConnect - Executing drop table container_structures

2015-03-19 17:12:16,415 INFO com.dotmarketing.common.db.DotConnect - Executing Create table container_structures(id varchar(36) NOT NULL primary key,container_id varchar(36) NOT NULL,structure_id varchar(36) NOT NULL, code text)

2015-03-19 17:12:16,420 INFO com.dotmarketing.common.db.DotConnect - Executing alter table container_structures add constraint FK_cs_container_id foreign key (container_id) references identifier(id)

2015-03-19 17:12:16,642 INFO com.dotmarketing.common.db.DotConnect - Executing create index idx_container_id on container_structures(container_id)

2015-03-19 17:12:17,328 INFO com.dotmarketing.common.db.DotConnect - Executing update containers set code='' where max_contentlets > 0

2015-03-19 17:12:17,385 INFO com.dotmarketing.common.db.DotConnect - Executing alter table containers drop constraint structure_fk

2015-03-19 17:12:17,394 INFO com.dotmarketing.common.db.DotConnect - Executing alter table containers drop column structure_inode

2015-03-19 17:12:17,420 INFO com.dotmarketing.common.db.DotConnect - Executing alter table containers drop column for_metadata

2015-03-19 17:12:17,448 INFO com.dotmarketing.startup.StartupTasksExecutor - Database upgraded to version: 3000

2015-03-19 17:12:17,450 INFO com.dotmarketing.startup.StartupTasksExecutor - Running: Task03005CreateModDateForFieldIfNeeded

2015-03-19 17:12:17,451 INFO com.dotmarketing.common.db.DotConnect - Executing alter table field add mod_date timestamp

2015-03-19 17:12:17,452 INFO com.dotmarketing.common.db.DotConnect - Finished Executing alter table field add mod_date timestamp

2015-03-19 17:12:17,452 INFO com.dotmarketing.common.db.DotConnect - Executing update field set mod_date = now()

2015-03-19 17:12:18,086 INFO com.dotmarketing.common.db.DotConnect - Finished Executing update field set mod_date = now()

2015-03-19 17:12:18,147 INFO com.dotmarketing.startup.StartupTasksExecutor - Database upgraded to version: 3005

2015-03-19 17:12:18,148 INFO com.dotmarketing.startup.StartupTasksExecutor - Running: Task03010AddContentletIdentifierIndex

2015-03-19 17:12:18,149 INFO com.dotmarketing.common.db.DotConnect - Executing CREATE INDEX idx_contentlet_identifier ON contentlet (identifier)

2015-03-19 17:12:30,236 INFO com.dotmarketing.common.db.DotConnect - Finished Executing CREATE INDEX idx_contentlet_identifier ON contentlet (identifier)

2015-03-19 17:12:30,239 INFO com.dotmarketing.startup.StartupTasksExecutor - Database upgraded to version: 3010

2015-03-19 17:12:30,240 INFO com.dotmarketing.startup.StartupTasksExecutor - Running: Task03015CreateClusterConfigModel

2015-03-19 17:12:30,241 INFO com.dotmarketing.common.db.DotConnect - Executing CREATE TABLE dot_cluster(cluster_id varchar(36), PRIMARY KEY (cluster_id) );

2015-03-19 17:12:30,243 INFO com.dotmarketing.common.db.DotConnect - Executing CREATE TABLE cluster_server(server_id varchar(36), cluster_id varchar(36) NOT NULL, name varchar(100), ip_address varchar(39) NOT NULL, host varchar(36), cache_port SMALLINT, es_transport_tcp_port SMALLINT, es_network_port SMALLINT, es_http_port SMALLINT, key_ varchar(100), PRIMARY KEY (server_id));

2015-03-19 17:12:30,246 INFO com.dotmarketing.common.db.DotConnect - Executing ALTER TABLE cluster_server add constraint fk_cluster_id foreign key (cluster_id) REFERENCES dot_cluster(cluster_id);

2015-03-19 17:12:30,248 INFO com.dotmarketing.common.db.DotConnect - Executing CREATE TABLE cluster_server_uptime(id varchar(36),server_id varchar(36) references cluster_server(server_id), startup timestamp without time zone null, heartbeat timestamp without time zone null, PRIMARY KEY (id));

2015-03-19 17:12:30,261 INFO com.dotmarketing.common.db.DotConnect - Executing ALTER TABLE cluster_server_uptime add constraint fk_cluster_server_id foreign key (server_id) REFERENCES cluster_server(server_id);

2015-03-19 17:12:30,281 INFO com.dotcms.enterprise.license.b -

2015-03-19 17:12:30,282 INFO com.dotcms.enterprise.license.b -

2015-03-19 17:12:30,283 INFO com.dotcms.enterprise.license.b -

2015-03-19 17:12:30,284 INFO com.dotcms.enterprise.license.b -

2015-03-19 17:12:30,285 INFO com.dotcms.enterprise.license.b -

2015-03-19 17:12:30,353 ERROR com.dotcms.enterprise.cluster.ClusterFactory - Error trying to wire node to the Cluster

com.dotmarketing.exception.DotDataException: ERROR: relation "sitelic" does not exist

Position: 22

at com.dotmarketing.common.db.DotConnect.loadResult(DotConnect.java:234)

at com.dotmarketing.common.db.DotConnect.loadObjectResults(DotConnect.java:859)

at com.dotcms.enterprise.license.a.b(SourceFile:143)

at com.dotcms.enterprise.license.a.c(SourceFile:147)

at com.dotcms.enterprise.license.LicenseManager.isLicenseOnRepo(SourceFile:65)

at com.dotcms.enterprise.LicenseUtil.setUpLicenseRepo(SourceFile:195)

at com.dotcms.enterprise.cluster.ClusterFactory.addNodeToCluster(SourceFile:304)

at com.dotcms.enterprise.cluster.ClusterFactory.addNodeToCluster(SourceFile:197)

at com.dotcms.enterprise.cluster.ClusterFactory.initialize(SourceFile:111)

at com.dotmarketing.startup.runonce.Task03015CreateClusterConfigModel.executeUpgrade(Task03015CreateClusterConfigModel.java:59)

at com.dotmarketing.startup.StartupTasksExecutor.executeUpgrades(StartupTasksExecutor.java:273)

at com.liferay.portal.servlet.MainServlet.init(MainServlet.java:116)

at org.apache.catalina.core.StandardWrapper.initServlet(StandardWrapper.java:1284)

at org.apache.catalina.core.StandardWrapper.loadServlet(StandardWrapper.java:1197)

at org.apache.catalina.core.StandardWrapper.load(StandardWrapper.java:1087)

at org.apache.catalina.core.StandardContext.loadOnStartup(StandardContext.java:5210)

at org.apache.catalina.core.StandardContext.startInternal(StandardContext.java:5493)

at org.apache.catalina.util.LifecycleBase.start(LifecycleBase.java:150)

at org.apache.catalina.core.ContainerBase.addChildInternal(ContainerBase.java:901)

at org.apache.catalina.core.ContainerBase.addChild(ContainerBase.java:877)

at org.apache.catalina.core.StandardHost.addChild(StandardHost.java:632)

at org.apache.catalina.startup.HostConfig.deployDirectory(HostConfig.java:1247)

at org.apache.catalina.startup.HostConfig$DeployDirectory.run(HostConfig.java:1898)

at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)

at java.util.concurrent.FutureTask.run(FutureTask.java:262)

at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)

at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)

at java.lang.Thread.run(Thread.java:745)

Caused by: org.postgresql.util.PSQLException: ERROR: relation "sitelic" does not exist

Position: 22

at org.postgresql.core.v3.QueryExecutorImpl.receiveErrorResponse(QueryExecutorImpl.java:2102)

at org.postgresql.core.v3.QueryExecutorImpl.processResults(QueryExecutorImpl.java:1835)

at org.postgresql.core.v3.QueryExecutorImpl.execute(QueryExecutorImpl.java:257)

at org.postgresql.jdbc2.AbstractJdbc2Statement.execute(AbstractJdbc2Statement.java:500)

at org.postgresql.jdbc2.AbstractJdbc2Statement.executeWithFlags(AbstractJdbc2Statement.java:388)

at org.postgresql.jdbc2.AbstractJdbc2Statement.executeQuery(AbstractJdbc2Statement.java:273)

at org.apache.tomcat.dbcp.dbcp.DelegatingPreparedStatement.executeQuery(DelegatingPreparedStatement.java:96)

at com.dotmarketing.common.db.DotConnect.executeQuery(DotConnect.java:574)

at com.dotmarketing.common.db.DotConnect.executeQuery(DotConnect.java:486)

at com.dotmarketing.common.db.DotConnect.loadResult(DotConnect.java:232)

... 27 more

2015-03-19 17:12:30,358 INFO com.dotmarketing.startup.StartupTasksExecutor - Database upgraded to version: 3015

2015-03-19 17:12:30,393 INFO com.dotmarketing.startup.StartupTasksExecutor - Running: Task03020PostgresqlIndiciesFK

2015-03-19 17:12:30,396 INFO com.dotmarketing.common.db.DotConnect - Executing create index idx_fileasset_vi_live on fileasset_version_info(live_inode)

2015-03-19 17:12:31,389 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create index idx_fileasset_vi_live on fileasset_version_info(live_inode)

2015-03-19 17:12:31,390 INFO com.dotmarketing.common.db.DotConnect - Executing create index idx_fileasset_vi_working on fileasset_version_info(working_inode)

2015-03-19 17:12:31,480 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create index idx_fileasset_vi_working on fileasset_version_info(working_inode)

2015-03-19 17:12:31,481 INFO com.dotmarketing.common.db.DotConnect - Executing create index idx_link_vi_live on link_version_info(live_inode)

2015-03-19 17:12:31,630 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create index idx_link_vi_live on link_version_info(live_inode)

2015-03-19 17:12:31,631 INFO com.dotmarketing.common.db.DotConnect - Executing create index idx_link_vi_working on link_version_info(working_inode)

2015-03-19 17:12:31,640 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create index idx_link_vi_working on link_version_info(working_inode)

2015-03-19 17:12:31,640 INFO com.dotmarketing.common.db.DotConnect - Executing create index idx_container_vi_live on container_version_info(live_inode)

2015-03-19 17:12:31,666 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create index idx_container_vi_live on container_version_info(live_inode)

2015-03-19 17:12:31,666 INFO com.dotmarketing.common.db.DotConnect - Executing create index idx_container_vi_working on container_version_info(working_inode)

2015-03-19 17:12:31,669 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create index idx_container_vi_working on container_version_info(working_inode)

2015-03-19 17:12:31,669 INFO com.dotmarketing.common.db.DotConnect - Executing create index idx_template_vi_live on template_version_info(live_inode)

2015-03-19 17:12:31,829 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create index idx_template_vi_live on template_version_info(live_inode)

2015-03-19 17:12:31,830 INFO com.dotmarketing.common.db.DotConnect - Executing create index idx_template_vi_working on template_version_info(working_inode)

2015-03-19 17:12:31,832 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create index idx_template_vi_working on template_version_info(working_inode)

2015-03-19 17:12:31,833 INFO com.dotmarketing.common.db.DotConnect - Executing create index idx_contentlet_vi_live on contentlet_version_info(live_inode)

2015-03-19 17:12:35,381 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create index idx_contentlet_vi_live on contentlet_version_info(live_inode)

2015-03-19 17:12:35,381 INFO com.dotmarketing.common.db.DotConnect - Executing create index idx_contentlet_vi_working on contentlet_version_info(working_inode)

2015-03-19 17:12:44,672 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create index idx_contentlet_vi_working on contentlet_version_info(working_inode)

2015-03-19 17:12:44,673 INFO com.dotmarketing.common.db.DotConnect - Executing create index idx_htmlpage_vi_live on htmlpage_version_info(live_inode)

2015-03-19 17:12:44,912 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create index idx_htmlpage_vi_live on htmlpage_version_info(live_inode)

2015-03-19 17:12:44,912 INFO com.dotmarketing.common.db.DotConnect - Executing create index idx_htmlpage_vi_working on htmlpage_version_info(working_inode)

2015-03-19 17:12:44,943 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create index idx_htmlpage_vi_working on htmlpage_version_info(working_inode)

2015-03-19 17:12:44,944 INFO com.dotmarketing.common.db.DotConnect - Executing create index folder_ident on folder (identifier)

2015-03-19 17:12:44,963 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create index folder_ident on folder (identifier)

2015-03-19 17:12:44,964 INFO com.dotmarketing.common.db.DotConnect - Executing create index contentlet_ident on contentlet (identifier)

2015-03-19 17:12:51,894 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create index contentlet_ident on contentlet (identifier)

2015-03-19 17:12:51,895 INFO com.dotmarketing.common.db.DotConnect - Executing create index links_ident on links (identifier)

2015-03-19 17:12:52,005 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create index links_ident on links (identifier)

2015-03-19 17:12:52,005 INFO com.dotmarketing.common.db.DotConnect - Executing create index htmlpage_ident on htmlpage (identifier)

2015-03-19 17:12:52,249 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create index htmlpage_ident on htmlpage (identifier)

2015-03-19 17:12:52,249 INFO com.dotmarketing.common.db.DotConnect - Executing create index containers_ident on containers (identifier)

2015-03-19 17:12:52,280 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create index containers_ident on containers (identifier)

2015-03-19 17:12:52,281 INFO com.dotmarketing.common.db.DotConnect - Executing create index template_ident on template (identifier)

2015-03-19 17:12:52,404 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create index template_ident on template (identifier)

2015-03-19 17:12:52,405 INFO com.dotmarketing.common.db.DotConnect - Executing create index contentlet_moduser on contentlet (mod_user)

2015-03-19 17:13:08,326 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create index contentlet_moduser on contentlet (mod_user)

2015-03-19 17:13:08,326 INFO com.dotmarketing.common.db.DotConnect - Executing create index contentlet_lang on contentlet (language_id)

2015-03-19 17:13:09,400 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create index contentlet_lang on contentlet (language_id)

2015-03-19 17:13:09,403 INFO com.dotmarketing.startup.StartupTasksExecutor - Database upgraded to version: 3020

2015-03-19 17:13:09,405 INFO com.dotmarketing.startup.StartupTasksExecutor - Running: Task03025CreateFoundationForNotificationSystem

2015-03-19 17:13:09,406 INFO com.dotmarketing.common.db.DotConnect - Executing create table notification(id varchar(36) NOT NULL,message text NOT NULL, notification_type varchar(100), notification_level varchar(100), user_id varchar(255) NOT NULL, time_sent TIMESTAMP NOT NULL, was_read bool default false, PRIMARY KEY (id))

2015-03-19 17:13:09,436 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create table notification(id varchar(36) NOT NULL,message text NOT NULL, notification_type varchar(100), notification_level varchar(100), user_id varchar(255) NOT NULL, time_sent TIMESTAMP NOT NULL, was_read bool default false, PRIMARY KEY (id))

2015-03-19 17:13:09,436 INFO com.dotmarketing.common.db.DotConnect - Executing create index idx_not_user ON notification (user_id)

2015-03-19 17:13:09,437 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create index idx_not_user ON notification (user_id)

2015-03-19 17:13:09,438 INFO com.dotmarketing.common.db.DotConnect - Executing create index idx_not_read ON notification (was_read)

2015-03-19 17:13:09,439 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create index idx_not_read ON notification (was_read)

2015-03-19 17:13:09,443 INFO com.dotmarketing.startup.StartupTasksExecutor - Database upgraded to version: 3025

2015-03-19 17:13:09,444 INFO com.dotmarketing.startup.StartupTasksExecutor - Running: Task03030CreateIndicesForVersionTables

2015-03-19 17:13:09,445 INFO com.dotmarketing.common.db.DotConnect - Executing create index idx_contentlet_vi_version_ts on contentlet_version_info(version_ts)

2015-03-19 17:13:09,978 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create index idx_contentlet_vi_version_ts on contentlet_version_info(version_ts)

2015-03-19 17:13:09,978 INFO com.dotmarketing.common.db.DotConnect - Executing create index idx_container_vi_version_ts on container_version_info(version_ts)

2015-03-19 17:13:09,980 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create index idx_container_vi_version_ts on container_version_info(version_ts)

2015-03-19 17:13:09,981 INFO com.dotmarketing.common.db.DotConnect - Executing create index idx_template_vi_version_ts on template_version_info(version_ts)

2015-03-19 17:13:09,985 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create index idx_template_vi_version_ts on template_version_info(version_ts)

2015-03-19 17:13:09,986 INFO com.dotmarketing.common.db.DotConnect - Executing create index idx_htmlpage_vi_version_ts on htmlpage_version_info(version_ts)

2015-03-19 17:13:10,023 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create index idx_htmlpage_vi_version_ts on htmlpage_version_info(version_ts)

2015-03-19 17:13:10,024 INFO com.dotmarketing.common.db.DotConnect - Executing create index idx_fileasset_vi_version_ts on fileasset_version_info(version_ts)

2015-03-19 17:13:10,059 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create index idx_fileasset_vi_version_ts on fileasset_version_info(version_ts)

2015-03-19 17:13:10,060 INFO com.dotmarketing.common.db.DotConnect - Executing create index idx_link_vi_version_ts on link_version_info(version_ts)

2015-03-19 17:13:10,062 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create index idx_link_vi_version_ts on link_version_info(version_ts)

2015-03-19 17:13:10,065 INFO com.dotmarketing.startup.StartupTasksExecutor - Database upgraded to version: 3030

2015-03-19 17:13:10,066 INFO com.dotmarketing.startup.StartupTasksExecutor - Database upgraded to version: 3035

2015-03-19 17:13:10,066 INFO com.dotmarketing.startup.StartupTasksExecutor - Running: Task03040AddIndexesToStructureFields

2015-03-19 17:13:10,067 INFO com.dotmarketing.common.db.DotConnect - Executing create index idx_structure_host on structure (host)

2015-03-19 17:13:10,080 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create index idx_structure_host on structure (host)

2015-03-19 17:13:10,081 INFO com.dotmarketing.common.db.DotConnect - Executing create index idx_structure_folder on structure (folder)

2015-03-19 17:13:10,087 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create index idx_structure_folder on structure (folder)

2015-03-19 17:13:10,090 INFO com.dotmarketing.startup.StartupTasksExecutor - Database upgraded to version: 3040

2015-03-19 17:13:10,092 INFO com.dotmarketing.startup.StartupTasksExecutor - Running: Task03042AddLicenseRepoModel

2015-03-19 17:13:10,093 INFO com.dotmarketing.common.db.DotConnect - Executing create table sitelic(id varchar(36) primary key, serverid varchar(100), license text not null, lastping timestamp not null)

2015-03-19 17:13:10,105 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create table sitelic(id varchar(36) primary key, serverid varchar(100), license text not null, lastping timestamp not null)

2015-03-19 17:13:10,107 INFO com.dotmarketing.startup.StartupTasksExecutor - Database upgraded to version: 3042

2015-03-19 17:13:10,115 INFO com.dotmarketing.startup.StartupTasksExecutor - Running: Task03045TagnameTypeChangeMSSQL

2015-03-19 17:13:10,116 INFO com.dotmarketing.startup.StartupTasksExecutor - Database upgraded to version: 3045

2015-03-19 17:13:10,118 INFO com.dotmarketing.startup.StartupTasksExecutor - Running: Task03050updateFormTabName

2015-03-19 17:13:10,119 INFO com.dotmarketing.common.db.DotConnect - Executing UPDATE cms_layout SET layout_name='Forms & Polls' WHERE id='81c3bb50-9f64-4a39-9027-46ee92192799'

2015-03-19 17:13:10,122 INFO com.dotmarketing.common.db.DotConnect - Finished Executing UPDATE cms_layout SET layout_name='Forms & Polls' WHERE id='81c3bb50-9f64-4a39-9027-46ee92192799'

2015-03-19 17:13:10,124 INFO com.dotmarketing.startup.StartupTasksExecutor - Database upgraded to version: 3050

2015-03-19 17:13:10,125 INFO com.dotmarketing.startup.StartupTasksExecutor - Running: Task03055RemoveLicenseManagerPortlet

2015-03-19 17:13:10,126 INFO com.dotmarketing.common.db.DotConnect - Executing delete from cms_layouts_portlets where portlet_id = 'EXT_LICENSE_MANAGER'

2015-03-19 17:13:10,128 INFO com.dotmarketing.common.db.DotConnect - Finished Executing delete from cms_layouts_portlets where portlet_id = 'EXT_LICENSE_MANAGER'

2015-03-19 17:13:10,130 INFO com.dotmarketing.startup.StartupTasksExecutor - Database upgraded to version: 3055

2015-03-19 17:13:10,131 INFO com.dotmarketing.startup.StartupTasksExecutor - Running: Task03060AddClusterServerAction

2015-03-19 17:13:10,132 INFO com.dotmarketing.common.db.DotConnect - Executing create table cluster_server_action(server_action_id varchar(36) not null, originator_id varchar(36) not null, server_id varchar(36) not null, failed bool, response varchar(2048), action_id varchar(1024) not null,completed bool, entered_date timestamp not null,time_out_seconds bigint not null,PRIMARY KEY (server_action_id))

2015-03-19 17:13:10,158 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create table cluster_server_action(server_action_id varchar(36) not null, originator_id varchar(36) not null, server_id varchar(36) not null, failed bool, response varchar(2048), action_id varchar(1024) not null,completed bool, entered_date timestamp not null,time_out_seconds bigint not null,PRIMARY KEY (server_action_id))

2015-03-19 17:13:10,161 INFO com.dotmarketing.startup.StartupTasksExecutor - Database upgraded to version: 3060

2015-03-19 17:13:10,163 INFO com.dotmarketing.startup.StartupTasksExecutor - Running: Task03065AddHtmlPageIR

2015-03-19 17:13:10,165 INFO com.dotmarketing.common.db.DotConnect - Executing create table htmlpages_ir(html_page varchar(255), local_working_inode varchar(36), local_live_inode varchar(36),remote_working_inode varchar(36), remote_live_inode varchar(36), local_identifier varchar(36), remote_identifier varchar(36), endpoint_id varchar(36), language_id int8 ,PRIMARY KEY (local_working_inode, language_id, endpoint_id))

2015-03-19 17:13:10,169 INFO com.dotmarketing.common.db.DotConnect - Finished Executing create table htmlpages_ir(html_page varchar(255), local_working_inode varchar(36), local_live_inode varchar(36),remote_working_inode varchar(36), remote_live_inode varchar(36), local_identifier varchar(36), remote_identifier varchar(36), endpoint_id varchar(36), language_id int8 ,PRIMARY KEY (local_working_inode, language_id, endpoint_id))

2015-03-19 17:13:10,171 INFO com.dotmarketing.startup.StartupTasksExecutor - Database upgraded to version: 3065

2015-03-19 17:13:10,174 INFO com.dotmarketing.startup.StartupTasksExecutor - Running: Task03100HTMLPageAsContentChanges

2015-03-19 17:13:10,563 INFO com.dotmarketing.startup.StartupTasksExecutor - Database upgraded to version: 3100

2015-03-19 17:13:10,565 INFO com.dotmarketing.startup.StartupTasksExecutor - Running: Task03105HTMLPageGenericPermissions

2015-03-19 17:13:10,566 INFO com.dotmarketing.common.db.DotConnect - Executing update permission_reference set permission_type = 'com.dotmarketing.portlets.htmlpageasset.model.IHTMLPage' where permission_type = 'com.dotmarketing.portlets.htmlpages.model.HTMLPage'

2015-03-19 17:13:56,860 INFO com.dotmarketing.common.db.DotConnect - Finished Executing update permission_reference set permission_type = 'com.dotmarketing.portlets.htmlpageasset.model.IHTMLPage' where permission_type = 'com.dotmarketing.portlets.htmlpages.model.HTMLPage'

2015-03-19 17:13:56,860 INFO com.dotmarketing.common.db.DotConnect - Executing update permission set permission_type = 'com.dotmarketing.portlets.htmlpageasset.model.IHTMLPage' where permission_type = 'com.dotmarketing.portlets.htmlpages.model.HTMLPage'

2015-03-19 17:13:57,769 INFO com.dotmarketing.common.db.DotConnect - Finished Executing update permission set permission_type = 'com.dotmarketing.portlets.htmlpageasset.model.IHTMLPage' where permission_type = 'com.dotmarketing.portlets.htmlpages.model.HTMLPage'

2015-03-19 17:13:59,147 INFO com.dotmarketing.startup.StartupTasksExecutor - Database upgraded to version: 3105

2015-03-19 17:13:59,147 INFO com.dotmarketing.startup.StartupTasksExecutor - Finishing upgrade tasks.

2015-03-19 17:13:59,204 INFO com.dotmarketing.common.reindex.ReindexThread - ContentIndexationThread ordered to start processing

2015-03-19 17:13:59,211 INFO com.dotcms.cluster.common.ClusterServerActionThread - ClusterServerActionThread ordered to start processing

2015-03-19 17:13:59,214 INFO com.dotcms.cluster.common.ClusterServerActionThread - ClusterServerActionThread Started with Sleep of 2000 millis.

2015-03-19 17:13:59,222 INFO com.dotmarketing.common.reindex.ReindexThread - Reindex Thread start delayed for 5000 millis.

2015-03-19 17:13:59,396 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : companypool, size:10, toDisk:false,Concurrency:32

2015-03-19 17:13:59,412 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.dotcms.repackage.com.liferay.counter.ejb.CounterHBM -> Counter

2015-03-19 17:13:59,491 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.liferay.portal.ejb.AddressHBM -> Address

2015-03-19 17:13:59,529 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.liferay.portal.ejb.CompanyHBM -> Company

2015-03-19 17:13:59,538 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.liferay.portal.ejb.ImageHBM -> Image

2015-03-19 17:13:59,545 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.liferay.portal.ejb.PasswordTrackerHBM -> PasswordTracker

2015-03-19 17:13:59,554 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.liferay.portal.ejb.PortletHBM -> Portlet

2015-03-19 17:13:59,558 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.liferay.portal.ejb.PortletPreferencesHBM -> PortletPreferences

2015-03-19 17:13:59,560 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.liferay.portal.ejb.ReleaseHBM -> Release_

2015-03-19 17:13:59,569 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.liferay.portal.ejb.UserHBM -> User_

2015-03-19 17:13:59,572 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.liferay.portal.ejb.UserTrackerHBM -> UserTracker

2015-03-19 17:13:59,573 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.liferay.portal.ejb.UserTrackerPathHBM -> UserTrackerPath

2015-03-19 17:13:59,574 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.liferay.portlet.admin.ejb.AdminConfigHBM -> AdminConfig

2015-03-19 17:13:59,574 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.liferay.portlet.polls.ejb.PollsChoiceHBM -> PollsChoice

2015-03-19 17:13:59,577 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.liferay.portlet.polls.ejb.PollsDisplayHBM -> PollsDisplay

2015-03-19 17:13:59,579 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.liferay.portlet.polls.ejb.PollsQuestionHBM -> PollsQuestion

2015-03-19 17:13:59,580 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Binder - Mapping class: com.liferay.portlet.polls.ejb.PollsVoteHBM -> PollsVote

2015-03-19 17:13:59,591 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Configuration - processing one-to-many association mappings

2015-03-19 17:13:59,591 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Configuration - processing one-to-one association property references

2015-03-19 17:13:59,591 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Configuration - processing foreign key constraints

2015-03-19 17:13:59,592 INFO com.dotcms.repackage.net.sf.hibernate.dialect.Dialect - Using dialect: null

2015-03-19 17:13:59,605 INFO com.dotcms.repackage.net.sf.hibernate.dialect.Dialect - Using dialect: com.dotcms.repackage.net.sf.hibernate.dialect.PostgreSQLDialect

2015-03-19 17:13:59,606 INFO com.dotcms.repackage.net.sf.hibernate.cfg.SettingsFactory - Use outer join fetching: true

2015-03-19 17:13:59,606 INFO com.dotcms.repackage.net.sf.hibernate.connection.ConnectionProviderFactory - Initializing connection provider: com.liferay.util.dao.hibernate.DSConnectionProvider

2015-03-19 17:13:59,606 INFO com.dotcms.repackage.net.sf.hibernate.transaction.TransactionManagerLookupFactory - No TransactionManagerLookup configured (in JTA environment, use of process level read-write cache is not recommended)

2015-03-19 17:13:59,607 INFO com.dotcms.repackage.net.sf.hibernate.cfg.SettingsFactory - Use scrollable result sets: true

2015-03-19 17:13:59,607 INFO com.dotcms.repackage.net.sf.hibernate.cfg.SettingsFactory - Use JDBC3 getGeneratedKeys(): true

2015-03-19 17:13:59,607 INFO com.dotcms.repackage.net.sf.hibernate.cfg.SettingsFactory - Optimize cache for minimal puts: false

2015-03-19 17:13:59,607 INFO com.dotcms.repackage.net.sf.hibernate.cfg.SettingsFactory - Query language substitutions: {}

2015-03-19 17:13:59,607 INFO com.dotcms.repackage.net.sf.hibernate.cfg.SettingsFactory - cache provider: com.dotcms.repackage.net.sf.hibernate.cache.EhCacheProvider

2015-03-19 17:13:59,607 INFO com.dotcms.repackage.net.sf.hibernate.cfg.Configuration - instantiating and configuring caches

2015-03-19 17:13:59,607 INFO com.dotcms.repackage.net.sf.hibernate.impl.SessionFactoryImpl - building session factory

2015-03-19 17:13:59,660 INFO com.dotcms.repackage.net.sf.hibernate.impl.SessionFactoryObjectFactory - Not binding factory to JNDI, no JNDI name configured

2015-03-19 17:13:59,721 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : userdotcmscache, size:1000, toDisk:false,Concurrency:32

2015-03-19 17:13:59,721 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : useremaildotcmscache, size:1000, toDisk:false,Concurrency:32

2015-03-19 17:13:59,929 INFO com.dotmarketing.servlets.InitServlet - InitServlet: Setting Default Timezone: Central Standard Time

2015-03-19 17:13:59,929 INFO com.dotmarketing.servlets.InitServlet -

2015-03-19 17:13:59,929 INFO com.dotmarketing.servlets.InitServlet - Initializing dotCMS

2015-03-19 17:13:59,929 INFO com.dotmarketing.servlets.InitServlet - Using database: PostgreSQL

2015-03-19 17:13:59,929 INFO com.dotmarketing.servlets.InitServlet - Using dialect : com.dotcms.repackage.net.sf.hibernate.dialect.PostgreSQLDialect

2015-03-19 17:13:59,929 INFO com.dotmarketing.servlets.InitServlet - Company Name : dotcms.org

2015-03-19 17:13:59,929 INFO com.dotmarketing.servlets.InitServlet - Clustering : Disabled

2015-03-19 17:13:59,929 INFO com.dotmarketing.servlets.InitServlet -

2015-03-19 17:14:00,145 INFO com.dotcms.repackage.org.elasticsearch.node - [c5b8bd72-9fc5-4b06-86df-a906bca1bb35] version[1.4.2], pid[1602], build[927caff/2014-12-16T14:11:12Z]

2015-03-19 17:14:00,145 INFO com.dotcms.repackage.org.elasticsearch.node - [c5b8bd72-9fc5-4b06-86df-a906bca1bb35] initializing ...

2015-03-19 17:14:00,164 INFO com.dotcms.repackage.org.elasticsearch.plugins - [c5b8bd72-9fc5-4b06-86df-a906bca1bb35] loaded [], sites []

2015-03-19 17:14:02,717 INFO com.dotcms.repackage.org.elasticsearch.node - [c5b8bd72-9fc5-4b06-86df-a906bca1bb35] initialized

2015-03-19 17:14:02,718 INFO com.dotcms.repackage.org.elasticsearch.node - [c5b8bd72-9fc5-4b06-86df-a906bca1bb35] starting ...

2015-03-19 17:14:02,863 INFO com.dotcms.repackage.org.elasticsearch.transport - [c5b8bd72-9fc5-4b06-86df-a906bca1bb35] bound_address {inet[/0:0:0:0:0:0:0:0:9309]}, publish_address {inet[/198.248.26.197:9309]}

2015-03-19 17:14:02,874 INFO com.dotcms.repackage.org.elasticsearch.discovery - [c5b8bd72-9fc5-4b06-86df-a906bca1bb35] dotCMSContentIndex_3x/DlLKF0VLR42qG45Aj6_fWA

2015-03-19 17:14:04,223 INFO com.dotmarketing.common.reindex.ReindexThread - Reindex Thread started with a sleep of 500

2015-03-19 17:14:04,308 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : indiciescache, size:8, toDisk:false,Concurrency:32

2015-03-19 17:14:05,905 INFO com.dotcms.repackage.org.elasticsearch.cluster.service - [c5b8bd72-9fc5-4b06-86df-a906bca1bb35] new_master [c5b8bd72-9fc5-4b06-86df-a906bca1bb35][DlLKF0VLR42qG45Aj6_fWA][sandbox.from-ks.com][inet[/198.248.26.197:9309]], reason: zen-disco-join (elected_as_master)

2015-03-19 17:14:05,937 INFO com.dotcms.repackage.org.elasticsearch.node - [c5b8bd72-9fc5-4b06-86df-a906bca1bb35] started

2015-03-19 17:14:05,980 WARN com.dotcms.content.elasticsearch.util.ESClient - Unable to set ES property auto_expand_replicas: [No indices found]

2015-03-19 17:14:05,982 INFO com.dotcms.repackage.org.elasticsearch.gateway - [c5b8bd72-9fc5-4b06-86df-a906bca1bb35] recovered [0] indices into cluster_state

2015-03-19 17:14:10,982 INFO com.dotmarketing.servlets.InitServlet -

2015-03-19 17:14:10,983 INFO com.dotmarketing.servlets.InitServlet -

2015-03-19 17:14:11,001 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : plugincache, size:1000, toDisk:false,Concurrency:32

2015-03-19 17:14:11,004 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : propertycache, size:1000, toDisk:false,Concurrency:32

2015-03-19 17:14:11,611 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : virtuallinkscache, size:1000, toDisk:false,Concurrency:32

2015-03-19 17:14:11,616 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : languagecacheimpl, size:1000, toDisk:false,Concurrency:32

2015-03-19 17:14:11,709 INFO com.dotmarketing.quartz.DotJobStore - Using db table-based data access locking (synchronization).

2015-03-19 17:14:11,711 INFO com.dotmarketing.quartz.DotJobStore - JobStoreCMT initialized.

2015-03-19 17:14:11,724 INFO com.dotmarketing.quartz.DotJobStore - Using db table-based data access locking (synchronization).

2015-03-19 17:14:11,724 INFO com.dotmarketing.quartz.DotJobStore - JobStoreCMT initialized.

2015-03-19 17:14:11,861 INFO com.dotmarketing.init.DotInitScheduler - Content Review Cron Thread schedule disabled on this server

2015-03-19 17:14:11,862 INFO com.dotmarketing.init.DotInitScheduler - Deleting ContentReviewJob Job

2015-03-19 17:14:11,865 INFO com.dotmarketing.init.DotInitScheduler - Automatic Content Reindexation Cron Thread schedule disabled on this server

2015-03-19 17:14:11,866 INFO com.dotmarketing.init.DotInitScheduler - Deleting ContentReindexerJob Job

2015-03-19 17:14:11,867 INFO com.dotmarketing.init.DotInitScheduler - Automatic Bounces Retrieval Cron Thread schedule disabled on this server

2015-03-19 17:14:11,867 INFO com.dotmarketing.init.DotInitScheduler - Deleting PopBouncedMailJob Job

2015-03-19 17:14:11,868 INFO com.dotmarketing.init.DotInitScheduler - Users To Delete Cron Thread schedule disabled on this server

2015-03-19 17:14:11,868 INFO com.dotmarketing.init.DotInitScheduler - Deleting UsersToDeleteJob Job

2015-03-19 17:14:11,869 INFO com.dotmarketing.init.DotInitScheduler - Calendar Reminder Cron Thread schedule disabled on this server

2015-03-19 17:14:11,869 INFO com.dotmarketing.init.DotInitScheduler - Deleting CalendarReminderJob Job

2015-03-19 17:14:11,897 INFO com.dotmarketing.init.DotInitScheduler - ReindexJournalCleanupJob Cron Job schedule disabled on this server

2015-03-19 17:14:11,898 INFO com.dotmarketing.init.DotInitScheduler - Deleting ReindexJournalCleanupJob Job

2015-03-19 17:14:11,899 INFO com.dotmarketing.init.DotInitScheduler - ReindexJournalCleanupJob2 Cron Job schedule disabled on this server

2015-03-19 17:14:11,899 INFO com.dotmarketing.init.DotInitScheduler - Deleting ReindexJournalCleanupJob2 Job

2015-03-19 17:14:11,923 INFO com.dotmarketing.init.DotInitScheduler - Content From Email Job schedule disabled on this server

2015-03-19 17:14:11,923 INFO com.dotmarketing.init.DotInitScheduler - Deleting ContentFromEmailJob Job

2015-03-19 17:14:11,955 INFO com.dotmarketing.init.DotInitScheduler - XMLSitemapJob Cron Job schedule disabled on this server

2015-03-19 17:14:11,983 INFO com.dotmarketing.quartz.DotJobStore - ClusterManager: detected 1 failed or restarted instances.

2015-03-19 17:14:11,984 INFO com.dotmarketing.quartz.DotJobStore - ClusterManager: Scanning for instance "1"'s failed in-progress jobs.

2015-03-19 17:14:11,987 INFO com.dotmarketing.quartz.DotJobStore - ClusterManager: ......Freed 1 acquired trigger(s).

2015-03-19 17:14:12,008 INFO com.dotmarketing.quartz.DotJobStore - ClusterManager: detected 1 failed or restarted instances.

2015-03-19 17:14:12,008 INFO com.dotmarketing.quartz.DotJobStore - ClusterManager: Scanning for instance "c5b8bd72-9fc5-4b06-86df-a906bca1bb35"'s failed in-progress jobs.

2015-03-19 17:14:12,016 INFO com.dotmarketing.quartz.DotJobStore - Handling 2 trigger(s) that missed their scheduled fire-time.

2015-03-19 17:14:12,091 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : dotcmsrolecache, size:1000, toDisk:false,Concurrency:32

2015-03-19 17:14:12,093 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : dotcmsrolekeycache, size:1000, toDisk:false,Concurrency:32

2015-03-19 17:14:12,122 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : dotcmsuserrolecache, size:1000, toDisk:false,Concurrency:32

2015-03-19 17:14:12,288 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : fieldscache, size:1000, toDisk:false,Concurrency:32

2015-03-19 17:14:12,623 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : contentletcache, size:5000, toDisk:true,Concurrency:32

2015-03-19 17:14:12,688 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : identifiercache, size:50000, toDisk:false,Concurrency:32

2015-03-19 17:14:12,689 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : identifier404cache, size:1000, toDisk:false,Concurrency:32

2015-03-19 17:14:12,692 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : foldercache, size:1000, toDisk:false,Concurrency:32

2015-03-19 17:14:12,888 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : velocitycache, size:1000, toDisk:true,Concurrency:32

2015-03-19 17:14:13,321 INFO com.dotmarketing.servlets.BinaryExporterServlet - Exporter "Content Image Fields Resizer" registered for path /resize-image

2015-03-19 17:14:13,322 INFO com.dotmarketing.servlets.BinaryExporterServlet - Exporter "Export Field Content" registered for path /raw-data

2015-03-19 17:14:13,323 INFO com.dotmarketing.servlets.BinaryExporterServlet - Exporter "Image Filter Exporter" registered for path /image

2015-03-19 17:14:13,324 INFO com.dotmarketing.servlets.BinaryExporterServlet - Exporter "Image Thumbnail Field Exporter" registered for path /image-thumbnail

Mar 19, 2015 5:14:13 PM org.apache.catalina.startup.HostConfig deployDirectory

INFO: Deployment of web application directory /mnt/dotcms/dotserver/tomcat-7.0.54/webapps/ROOT has finished in 159,628 ms

Mar 19, 2015 5:14:13 PM org.apache.coyote.AbstractProtocol start

INFO: Starting ProtocolHandler ["http-bio-80"]

Mar 19, 2015 5:14:13 PM org.apache.catalina.startup.Catalina start

INFO: Server startup in 159781 ms

2015-03-19 17:15:00,241 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : publishingendpointcache, size:100, toDisk:false,Concurrency:32

2015-03-19 17:22:22,503 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : hostaliascache, size:1000, toDisk:false,Concurrency:32

2015-03-19 17:22:22,504 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : hostcache, size:1000, toDisk:false,Concurrency:32

2015-03-19 17:22:22,505 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : translatedquerycache, size:5000, toDisk:false,Concurrency:32

2015-03-19 17:22:22,539 WARN com.dotmarketing.business.web.HostWebAPIImpl - Content Index is fouled up, need to try db: com.dotcms.repackage.org.elasticsearch.indices.IndexMissingException: [working_20140406155840] missing

2015-03-19 17:22:22,651 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : hostaliascache, size:1000, toDisk:false,Concurrency:32

2015-03-19 17:22:23,479 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : versioninfocache, size:50000, toDisk:false,Concurrency:32

2015-03-19 17:22:23,775 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : livecache_ae1e4ea5-ce21-4bb3-ba78-ffaabb1493ac_1, size:1000, toDisk:false,Concurrency:32

2015-03-19 17:22:23,776 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : livecache_ae1e4ea5-ce21-4bb3-ba78-ffaabb1493ac, size:1000, toDisk:false,Concurrency:32

2015-03-19 17:22:23,830 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : versioncache, size:50000, toDisk:false,Concurrency:32

2015-03-19 17:22:24,007 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : permissioncache, size:50000, toDisk:false,Concurrency:32

2015-03-19 17:22:24,297 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : templatecache, size:500, toDisk:false,Concurrency:32

2015-03-19 17:22:24,348 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : containercache, size:1000, toDisk:false,Concurrency:32

2015-03-19 17:22:25,710 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : hostvariablescache, size:1000, toDisk:false,Concurrency:32

2015-03-19 17:22:26,085 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : fileassetmetadatacache, size:200, toDisk:false,Concurrency:32

2015-03-19 17:22:26,202 ERROR java.lang.String - substring

2015-03-19 17:22:26,203 ERROR java.lang.String - substring

2015-03-19 17:22:26,204 ERROR java.lang.String - substring

2015-03-19 17:22:26,205 ERROR java.lang.String - substring

2015-03-19 17:22:26,206 ERROR java.lang.String - substring

2015-03-19 17:22:26,207 ERROR java.lang.String - substring

2015-03-19 17:22:26,267 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : velocitymisscache, size:1000, toDisk:false,Concurrency:32

2015-03-19 17:22:26,276 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : categoryparentscache, size:1000, toDisk:false,Concurrency:32

2015-03-19 17:22:26,385 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : containerstructurecache, size:1000, toDisk:false,Concurrency:32

2015-03-19 17:22:31,386 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** No Cache for : xmltoolcache, using default

2015-03-19 17:22:31,387 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : default, size:1000, toDisk:false,Concurrency:32

2015-03-19 17:22:33,982 ERROR java.lang.String - substring

2015-03-19 17:22:34,209 ERROR java.lang.String - substring

2015-03-19 17:22:34,212 ERROR java.lang.String - substring

2015-03-19 17:22:34,429 ERROR java.lang.String - substring

2015-03-19 17:22:34,430 ERROR java.lang.String - substring

2015-03-19 17:22:34,820 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : filecache, size:1000, toDisk:false,Concurrency:32

2015-03-19 17:22:34,823 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : workingcache_ae1e4ea5-ce21-4bb3-ba78-ffaabb1493ac, size:1000, toDisk:false,Concurrency:32

2015-03-19 17:22:38,869 ERROR java.lang.String - substring

2015-03-19 17:22:39,130 ERROR java.lang.String - substring

2015-03-19 17:22:41,147 ERROR java.lang.String - substring

2015-03-19 17:22:41,150 ERROR java.lang.String - substring

2015-03-19 17:22:41,151 ERROR java.lang.String - substring

2015-03-19 17:22:41,154 ERROR java.lang.String - substring

2015-03-19 17:22:41,155 ERROR java.lang.String - substring

2015-03-19 17:22:42,134 ERROR java.lang.String - substring

2015-03-19 17:22:42,138 ERROR java.lang.String - substring

2015-03-19 17:22:42,140 ERROR java.lang.String - substring

2015-03-19 17:22:42,144 ERROR java.lang.String - substring

2015-03-19 17:22:42,146 ERROR java.lang.String - substring

2015-03-19 17:22:45,958 INFO com.dotcms.repackage.org.apache.struts.tiles.TilesRequestProcessor - Tiles definition factory found for request processor ''.

2015-03-19 17:22:45,997 INFO com.dotcms.repackage.com.oroad.stxx.transform.document.SAXDocumentBuilder - Using serializer class com.dotcms.repackage.com.oroad.stxx.transform.document.DefaultSAXSerializer

2015-03-19 17:22:46,071 INFO com.dotcms.repackage.org.apache.struts.tiles.TilesRequestProcessor - Tiles definition factory found for request processor ''.

Mar 19, 2015 5:22:46 PM org.apache.jasper.compiler.TldLocationsCache tldScanJar

INFO: At least one JAR was scanned for TLDs yet contained no TLDs. Enable debug logging for this logger for a complete list of JARs that were scanned but no TLDs were found in them. Skipping unneeded JARs during scanning can improve startup time and JSP compilation time.

2015-03-19 17:22:48,270 ERROR com.dotmarketing.portlets.contentlet.business.HostAPIImpl - User dotcms.org.default does not have permission to host:www.emporia.edu

2015-03-19 17:22:48,275 ERROR com.dotmarketing.portlets.contentlet.business.HostAPIImpl - User dotcms.org.default does not have permission to host:www.emporia.edu

2015-03-19 17:22:48,567 ERROR com.dotmarketing.portlets.contentlet.business.HostAPIImpl - User dotcms.org.default does not have permission to host:www.emporia.edu

Attempting to load ESAPI.properties via file I/O.

Attempting to load ESAPI.properties as resource file via file I/O.

Not found in 'org.owasp.esapi.resources' directory or file not readable: /mnt/dotcms/dotserver/tomcat-7.0.54/webapps/ROOT/ESAPI.properties

Not found in SystemResource Directory/resourceDirectory: .esapi/ESAPI.properties

Not found in 'user.home' (/root) directory: /root/esapi/ESAPI.properties

Loading ESAPI.properties via file I/O failed. Exception was: java.io.FileNotFoundException

Attempting to load ESAPI.properties via the classpath.

SUCCESSFULLY LOADED ESAPI.properties via the CLASSPATH from '/ (root)' using current thread context class loader!

SecurityConfiguration for Validator.ConfigurationFile not found in ESAPI.properties. Using default: validation.properties

Attempting to load validation.properties via file I/O.

Attempting to load validation.properties as resource file via file I/O.

Not found in 'org.owasp.esapi.resources' directory or file not readable: /mnt/dotcms/dotserver/tomcat-7.0.54/webapps/ROOT/validation.properties

Not found in SystemResource Directory/resourceDirectory: .esapi/validation.properties

Not found in 'user.home' (/root) directory: /root/esapi/validation.properties

Loading validation.properties via file I/O failed.

Attempting to load validation.properties via the classpath.

validation.properties could not be loaded by any means. fail. Exception was: java.lang.IllegalArgumentException: Failed to load ESAPI.properties as a classloader resource.

SecurityConfiguration for Encryptor.CipherTransformation not found in ESAPI.properties. Using default: AES/CBC/PKCS5Padding

SecurityConfiguration for Logger.LogApplicationName not found in ESAPI.properties. Using default: true

SecurityConfiguration for Logger.LogServerIP not found in ESAPI.properties. Using default: true

Umair Abbasi

unread,

Mar 19, 2015, 6:29:32 PM3/19/15

to dot...@googlegroups.com

I will post another log after re-index is complete. Thanks!

On Thursday, March 19, 2015 at 9:37:51 AM UTC-5, Umair Abbasi wrote:

Umair Abbasi

unread,

Mar 23, 2015, 5:58:22 PM3/23/15

to dot...@googlegroups.com

Log during indexing.

at com.dotcms.repackage.org.elasticsearch.action.search.TransportSearchAction.doExecute(TransportSearchAction.java:103)

at com.dotcms.repackage.org.elasticsearch.action.search.TransportSearchAction.doExecute(TransportSearchAction.java:45)

at com.dotcms.repackage.org.elasticsearch.action.support.TransportAction.execute(TransportAction.java:75)

at com.dotcms.repackage.org.elasticsearch.client.node.NodeClient.execute(NodeClient.java:98)

at com.dotcms.repackage.org.elasticsearch.client.support.AbstractClient.search(AbstractClient.java:334)

at com.dotcms.repackage.org.elasticsearch.action.search.SearchRequestBuilder.doExecute(SearchRequestBuilder.java:1116)

at com.dotcms.repackage.org.elasticsearch.action.ActionRequestBuilder.execute(ActionRequestBuilder.java:91)

at com.dotcms.repackage.org.elasticsearch.action.ActionRequestBuilder.execute(ActionRequestBuilder.java:65)

at com.dotcms.content.elasticsearch.business.ESContentFactoryImpl.indexSearch(ESContentFactoryImpl.java:1296)

... 6 more

2015-03-19 17:29:00,960 INFO com.dotmarketing.portlets.cmsmaintenance.action.ViewCMSMaintenanceAction - Running Contents Index Cache

2015-03-19 17:29:00,964 INFO com.dotmarketing.portlets.cmsmaintenance.action.ViewCMSMaintenanceAction - Running Contentlet Reindex

2015-03-19 17:29:00,966 INFO com.dotcms.content.elasticsearch.business.ESIndexAPI - createIndex : Trying to create index: working_20150319172900 with shards: 0

2015-03-19 17:29:01,333 INFO com.dotcms.repackage.org.elasticsearch.cluster.metadata - [c5b8bd72-9fc5-4b06-86df-a906bca1bb35] [working_20150319172900] creating index, cause [api], shards [1]/[0], mappings []

2015-03-19 17:29:01,562 INFO com.dotcms.content.elasticsearch.business.ESIndexAPI - createIndex : Index created: working_20150319172900 with shards: 1

2015-03-19 17:29:01,701 INFO com.dotcms.repackage.org.elasticsearch.cluster.metadata - [c5b8bd72-9fc5-4b06-86df-a906bca1bb35] [working_20150319172900] create_mapping [content]

2015-03-19 17:29:01,707 INFO com.dotcms.content.elasticsearch.business.ESIndexAPI - createIndex : Trying to create index: live_20150319172900 with shards: 0

2015-03-19 17:29:01,737 INFO com.dotcms.repackage.org.elasticsearch.cluster.metadata - [c5b8bd72-9fc5-4b06-86df-a906bca1bb35] [live_20150319172900] creating index, cause [api], shards [1]/[0], mappings []

2015-03-19 17:29:01,865 INFO com.dotcms.content.elasticsearch.business.ESIndexAPI - createIndex : Index created: live_20150319172900 with shards: 1

2015-03-19 17:29:01,871 INFO com.dotcms.repackage.org.elasticsearch.cluster.metadata - [c5b8bd72-9fc5-4b06-86df-a906bca1bb35] [live_20150319172900] create_mapping [content]

2015-03-19 17:29:01,876 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : indiciescache, size:8, toDisk:false,Concurrency:32

2015-03-19 17:29:01,882 INFO com.dotcms.repackage.org.elasticsearch.cluster.metadata - [c5b8bd72-9fc5-4b06-86df-a906bca1bb35] updating number_of_replicas to [0] for indices [working_20150319172900]

2015-03-19 17:29:01,889 INFO com.dotcms.repackage.org.elasticsearch.cluster.metadata - [c5b8bd72-9fc5-4b06-86df-a906bca1bb35] updating number_of_replicas to [0] for indices [live_20150319172900]

2015-03-19 17:29:41,983 WARN com.dotmarketing.common.db.DotConnect - Somewhat slow query, total time: 30088.246ms, query preparation time: 0.050427ms, query execution time: 30088.188ms, metadata time: 0.0ms, SQL: insert into dist_reindex_journal(inode_to_index,ident_to_index, priority, dist_action, time_entered) select distinct identifier,identifier,30,1, NOW() from contentlet_version_info where identifier is not null, parameters: []

2015-03-19 17:29:42,007 INFO com.dotmarketing.business.DotGuavaCacheAdministratorImpl - *** Building Cache : indiciescache, size:8, toDisk:false,Concurrency:32

2015-03-19 17:29:42,007 INFO com.dotmarketing.portlets.cmsmaintenance.action.ViewCMSMaintenanceAction - processAction : Running Contentlet Reindex

2015-03-19 17:29:42,107 ERROR com.dotmarketing.portlets.contentlet.business.HostAPIImpl - com.dotcms.repackage.org.elasticsearch.indices.IndexMissingException: [working_20140406155840] missing

java.lang.RuntimeException: com.dotcms.repackage.org.elasticsearch.indices.IndexMissingException: [working_20140406155840] missing

at com.dotcms.content.elasticsearch.business.ESContentFactoryImpl.indexSearch(ESContentFactoryImpl.java:1305)

at com.dotcms.content.elasticsearch.business.ESContentletAPIImpl.searchIndex(ESContentletAPIImpl.java:668)

at com.dotcms.content.elasticsearch.business.ESContentletAPIImpl.search(ESContentletAPIImpl.java:540)

at com.dotcms.content.elasticsearch.business.ESContentletAPIImpl.search(ESContentletAPIImpl.java:532)

at com.dotmarketing.portlets.contentlet.business.ContentletAPIInterceptor.search(ContentletAPIInterceptor.java:1509)

at com.dotmarketing.portlets.contentlet.business.HostAPIImpl.getHostsWithPermission(HostAPIImpl.java:432)

at com.dotmarketing.portlets.contentlet.business.HostAPIImpl.getHostsWithPermission(HostAPIImpl.java:454)

at org.apache.jsp.html.portlet.ext.cmsmaintenance.view_005fcms_005fmaintenance_jsp._jspService(view_005fcms_005fmaintenance_jsp.java:2500)

at org.apache.jasper.runtime.HttpJspBase.service(HttpJspBase.java:70)

at javax.servlet.http.HttpServlet.service(HttpServlet.java:727)

at org.apache.jasper.servlet.JspServletWrapper.service(JspServletWrapper.java:432)

at org.apache.jasper.servlet.JspServlet.serviceJspFile(JspServlet.java:390)

at org.apache.jasper.servlet.JspServlet.service(JspServlet.java:334)

at javax.servlet.http.HttpServlet.service(HttpServlet.java:727)

at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:303)

at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)

at org.apache.catalina.core.ApplicationDispatcher.invoke(ApplicationDispatcher.java:748)

at org.apache.catalina.core.ApplicationDispatcher.doInclude(ApplicationDispatcher.java:604)

at org.apache.catalina.core.ApplicationDispatcher.include(ApplicationDispatcher.java:543)

at org.apache.jasper.runtime.JspRuntimeLibrary.include(JspRuntimeLibrary.java:954)

at org.apache.jsp.html.portal.layout_005fportal_jsp._jspService(layout_005fportal_jsp.java:470)