Jan 8, 2013 9:17:05 AM org.apache.catalina.core.AprLifecycleListener init INFO: Loaded APR based Apache Tomcat Native library 1.1.20. Jan 8, 2013 9:17:05 AM org.apache.catalina.core.AprLifecycleListener init INFO: APR capabilities: IPv6 [true], sendfile [true], accept filters [false], random [true]. Jan 8, 2013 9:17:05 AM org.apache.coyote.http11.Http11AprProtocol init INFO: Initializing Coyote HTTP/1.1 on http-127.0.0.1-8080 Jan 8, 2013 9:17:05 AM org.apache.coyote.ajp.AjpAprProtocol init INFO: Initializing Coyote AJP/1.3 on ajp-127.0.0.1-8009 Jan 8, 2013 9:17:05 AM org.apache.catalina.startup.Catalina load INFO: Initialization processed in 1879 ms Jan 8, 2013 9:17:06 AM org.apache.catalina.core.StandardService start INFO: Starting service Catalina Jan 8, 2013 9:17:06 AM org.apache.catalina.core.StandardEngine start INFO: Starting Servlet Engine: Apache Tomcat/6.0.26 Jan 8, 2013 9:17:06 AM org.apache.catalina.startup.HostConfig deployDirectory INFO: Deploying web application directory xwiki 2013-01-08 09:17:18,468 [main] WARN o.x.e.i.ServletEnvironment - No permanent directory configured. Using temporary directory [/var/cache/tomcat6/temp]. 2013-01-08 09:17:27,995 [main] INFO istributionInitializerListener - Distribution state: NEW Jan 8, 2013 9:17:28 AM org.apache.coyote.http11.Http11AprProtocol start INFO: Starting Coyote HTTP/1.1 on http-127.0.0.1-8080 Jan 8, 2013 9:17:28 AM org.apache.coyote.ajp.AjpAprProtocol start INFO: Starting Coyote AJP/1.3 on ajp-127.0.0.1-8009 Jan 8, 2013 9:17:28 AM org.apache.catalina.startup.Catalina start INFO: Server startup in 22368 ms 2013-01-08 09:19:45,509 [http://10.100.2.66/xwiki/bin/view/Main/] INFO .HibernateDataMigrationManager - Storage schema updates and data migrations are enabled 2013-01-08 09:19:45,523 [http://10.100.2.66/xwiki/bin/view/Main/] INFO .HibernateDataMigrationManager - The following data migration(s) will be applied for database [xwiki] currently in version [15429]: 2013-01-08 09:19:45,523 [http://10.100.2.66/xwiki/bin/view/Main/] INFO .HibernateDataMigrationManager - R35100XWIKI7564 - See http://jira.xwiki.org/browse/XWIKI-7564 2013-01-08 09:19:45,523 [http://10.100.2.66/xwiki/bin/view/Main/] INFO .HibernateDataMigrationManager - R35102XWIKI7771 - See http://jira.xwiki.org/browse/XWIKI-7771 2013-01-08 09:19:45,523 [http://10.100.2.66/xwiki/bin/view/Main/] INFO .HibernateDataMigrationManager - R40000XWIKI6990 - Convert document IDs to use the new improved hash algorithm. 2013-01-08 09:19:45,523 [http://10.100.2.66/xwiki/bin/view/Main/] INFO .HibernateDataMigrationManager - R40001XWIKI7540 - See http://jira.xwiki.org/browse/XWIKI-7540 2013-01-08 09:19:45,523 [http://10.100.2.66/xwiki/bin/view/Main/] INFO .HibernateDataMigrationManager - R43000XWIKI6691 - Reduce the size of the ASE_REQUESTID column to 48-chars 2013-01-08 09:19:45,524 [http://10.100.2.66/xwiki/bin/view/Main/] INFO .HibernateDataMigrationManager - Running early schema updates (using liquibase) for database [xwiki] 2013-01-08 09:19:47,939 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - Successfully acquired change log lock 2013-01-08 09:19:48,142 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - Creating database history table with name: databasechangelog 2013-01-08 09:19:48,181 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - Reading from databasechangelog 2013-01-08 09:19:48,186 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - Reading from databasechangelog 2013-01-08 09:19:49,031 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R43000::xwikiorg ran successfully in 835ms 2013-01-08 09:19:49,060 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - Successfully released change log lock 2013-01-08 09:19:49,061 [http://10.100.2.66/xwiki/bin/view/Main/] INFO .HibernateDataMigrationManager - Checking Hibernate mapping and updating schema if needed for database [xwiki] 2013-01-08 09:19:57,666 [http://10.100.2.66/xwiki/bin/view/Main/] INFO h.R40000XWIKI6990DataMigration - [R40000XWIKI6990] - 41 schema updates required. 2013-01-08 09:19:57,667 [http://10.100.2.66/xwiki/bin/view/Main/] INFO .HibernateDataMigrationManager - Running additional schema updates (using liquibase) for database [xwiki] 2013-01-08 09:19:57,690 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - Successfully acquired change log lock 2013-01-08 09:19:57,908 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - Reading from databasechangelog 2013-01-08 09:19:57,922 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - Reading from databasechangelog 2013-01-08 09:19:58,408 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-000::sdumitriu ran successfully in 5ms 2013-01-08 09:19:58,417 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-001::sdumitriu ran successfully in 2ms 2013-01-08 09:19:58,422 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-002::sdumitriu ran successfully in 2ms 2013-01-08 09:19:58,427 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-003::sdumitriu ran successfully in 2ms 2013-01-08 09:19:58,432 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-004::sdumitriu ran successfully in 2ms 2013-01-08 09:19:58,436 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-005::sdumitriu ran successfully in 2ms 2013-01-08 09:19:58,442 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-006::sdumitriu ran successfully in 3ms 2013-01-08 09:19:58,447 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-007::sdumitriu ran successfully in 2ms 2013-01-08 09:19:58,458 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-008::sdumitriu ran successfully in 8ms 2013-01-08 09:19:58,684 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-009::dgervalle ran successfully in 220ms 2013-01-08 09:19:58,734 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-010::dgervalle ran successfully in 36ms 2013-01-08 09:19:58,767 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-011::dgervalle ran successfully in 28ms 2013-01-08 09:19:58,823 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-012::dgervalle ran successfully in 51ms 2013-01-08 09:19:58,866 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-013::dgervalle ran successfully in 38ms 2013-01-08 09:19:58,908 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-014::dgervalle ran successfully in 38ms 2013-01-08 09:19:58,984 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-015::dgervalle ran successfully in 70ms 2013-01-08 09:19:59,067 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-016::dgervalle ran successfully in 78ms 2013-01-08 09:19:59,102 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-017::dgervalle ran successfully in 31ms 2013-01-08 09:19:59,233 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-018::dgervalle ran successfully in 127ms 2013-01-08 09:19:59,406 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-019::dgervalle ran successfully in 169ms 2013-01-08 09:19:59,496 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-020::dgervalle ran successfully in 86ms 2013-01-08 09:19:59,579 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-021::dgervalle ran successfully in 72ms 2013-01-08 09:19:59,725 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-022::dgervalle ran successfully in 142ms 2013-01-08 09:19:59,738 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-023::sdumitriu ran successfully in 3ms 2013-01-08 09:19:59,785 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-024::dgervalle ran successfully in 44ms 2013-01-08 09:19:59,807 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-025::dgervalle ran successfully in 14ms 2013-01-08 09:19:59,824 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-026::sdumitriu ran successfully in 9ms 2013-01-08 09:19:59,856 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-027::dgervalle ran successfully in 22ms 2013-01-08 09:19:59,874 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-028::dgervalle ran successfully in 14ms 2013-01-08 09:19:59,905 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-029::dgervalle ran successfully in 25ms 2013-01-08 09:19:59,969 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-030::sdumitriu ran successfully in 52ms 2013-01-08 09:19:59,983 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-031::sdumitriu ran successfully in 8ms 2013-01-08 09:19:59,996 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-032::sdumitriu ran successfully in 4ms 2013-01-08 09:20:00,012 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-033::sdumitriu ran successfully in 4ms 2013-01-08 09:20:00,022 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-034::sdumitriu ran successfully in 3ms 2013-01-08 09:20:00,037 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-035::sdumitriu ran successfully in 11ms 2013-01-08 09:20:00,045 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-036::sdumitriu ran successfully in 3ms 2013-01-08 09:20:00,056 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-037::sdumitriu ran successfully in 6ms 2013-01-08 09:20:00,064 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-038::sdumitriu ran successfully in 4ms 2013-01-08 09:20:00,072 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-039::sdumitriu ran successfully in 3ms 2013-01-08 09:20:00,087 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - ChangeSet liquibase.xml::R40000-040::sdumitriu ran successfully in 11ms 2013-01-08 09:20:00,096 [http://10.100.2.66/xwiki/bin/view/Main/] INFO c.x.x.s.m.liquibase - Successfully released change log lock 2013-01-08 09:20:00,097 [http://10.100.2.66/xwiki/bin/view/Main/] INFO .HibernateDataMigrationManager - Starting data migration [R35100XWIKI7564] with version [35100] on database [xwiki] 2013-01-08 09:31:26,331 [http://10.100.2.66/xwiki/bin/view/Main/] INFO .HibernateDataMigrationManager - Data migration [R35100XWIKI7564] applied successfully, database [xwiki] upgraded to version [35100] 2013-01-08 09:31:26,388 [http://10.100.2.66/xwiki/bin/view/Main/] INFO .HibernateDataMigrationManager - Starting data migration [R35102XWIKI7771] with version [35102] on database [xwiki] 2013-01-08 09:32:12,186 [http://10.100.2.66/xwiki/bin/view/Main/] INFO .HibernateDataMigrationManager - Data migration [R35102XWIKI7771] applied successfully, database [xwiki] upgraded to version [35102] 2013-01-08 09:32:12,187 [http://10.100.2.66/xwiki/bin/view/Main/] INFO .HibernateDataMigrationManager - Starting data migration [R40000XWIKI6990] with version [40000] on database [xwiki] 2013-01-08 09:32:12,740 [http://10.100.2.66/xwiki/bin/view/Main/] INFO h.R40000XWIKI6990DataMigration - [R40000XWIKI6990] - Retrieved 957 document IDs to be converted. 2013-01-08 09:32:13,603 [http://10.100.2.66/xwiki/bin/view/Main/] INFO h.R40000XWIKI6990DataMigration - [R40000XWIKI6990] - Retrieved 4403 object IDs to be converted. 2013-01-08 09:32:13,745 [http://10.100.2.66/xwiki/bin/view/Main/] INFO h.R40000XWIKI6990DataMigration - [R40000XWIKI6990] - Retrieved 3 custom mapped classes to be processed. 2013-01-08 09:32:13,789 [http://10.100.2.66/xwiki/bin/view/Main/] INFO h.R40000XWIKI6990DataMigration - [R40000XWIKI6990] - Retrieved 0 document statistics IDs to be converted. 2013-01-08 09:32:13,796 [http://10.100.2.66/xwiki/bin/view/Main/] INFO h.R40000XWIKI6990DataMigration - [R40000XWIKI6990] - Retrieved 0 referer statistics IDs to be converted. 2013-01-08 09:32:13,803 [http://10.100.2.66/xwiki/bin/view/Main/] INFO h.R40000XWIKI6990DataMigration - [R40000XWIKI6990] - Retrieved 0 visit statistics IDs to be converted. 2013-01-08 09:32:14,160 [http://10.100.2.66/xwiki/bin/view/Main/] INFO h.R40000XWIKI6990DataMigration - [R40000XWIKI6990] - Converting 957 document IDs in 5 tables... 2013-01-08 09:32:15,510 [http://10.100.2.66/xwiki/bin/view/Main/] WARN o.h.u.JDBCExceptionReporter - SQL Error: 0, SQLState: 23505 2013-01-08 09:32:15,510 [http://10.100.2.66/xwiki/bin/view/Main/] ERROR o.h.u.JDBCExceptionReporter - ERROR: duplicate key value violates unique constraint "xwikidoc_pkey" 2013-01-08 09:32:15,611 [http://10.100.2.66/xwiki/bin/view/Main/] INFO .HibernateDataMigrationManager - Failed to migrate database [xwiki]... com.xpn.xwiki.store.migration.DataMigrationException: Data migration R40000XWIKI6990 failed at com.xpn.xwiki.store.migration.hibernate.AbstractHibernateDataMigration.migrate(AbstractHibernateDataMigration.java:111) ~[xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.migration.AbstractDataMigrationManager.startMigrations(AbstractDataMigrationManager.java:636) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.migration.AbstractDataMigrationManager.startMigrationsForDatabase(AbstractDataMigrationManager.java:546) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.migration.AbstractDataMigrationManager.startMigrations(AbstractDataMigrationManager.java:493) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.migration.hibernate.HibernateDataMigrationManager.startMigrations(HibernateDataMigrationManager.java:343) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.migration.AbstractDataMigrationManager.checkDatabase(AbstractDataMigrationManager.java:421) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.XWikiHibernateBaseStore.setDatabase(XWikiHibernateBaseStore.java:665) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.XWikiHibernateBaseStore.beginTransaction(XWikiHibernateBaseStore.java:840) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.XWikiHibernateBaseStore.beginTransaction(XWikiHibernateBaseStore.java:772) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.XWikiHibernateStore.loadXWikiDoc(XWikiHibernateStore.java:750) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.XWikiCacheStore.loadXWikiDoc(XWikiCacheStore.java:290) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.XWiki.getDocument(XWiki.java:1404) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.XWiki.getDocument(XWiki.java:1447) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.XWiki.getXWikiPreference(XWiki.java:2179) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.XWiki.getXWikiPreference(XWiki.java:2211) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.render.XWikiMacrosMappingRenderer.loadPreferences(XWikiMacrosMappingRenderer.java:107) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.render.XWikiMacrosMappingRenderer.(XWikiMacrosMappingRenderer.java:83) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.render.DefaultXWikiRenderingEngine.(DefaultXWikiRenderingEngine.java:72) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.XWiki.resetRenderingEngine(XWiki.java:1080) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.XWiki.initXWiki(XWiki.java:787) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.XWiki.(XWiki.java:735) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.XWiki.getMainXWiki(XWiki.java:394) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.XWiki.getXWiki(XWiki.java:483) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.web.XWikiAction.execute(XWikiAction.java:136) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.web.XWikiAction.execute(XWikiAction.java:116) [xwiki-platform-legacy-oldcore-4.4.jar:na] at org.apache.struts.action.RequestProcessor.processActionPerform(RequestProcessor.java:431) [struts-1.2.9.jar:1.2.9] at org.apache.struts.action.RequestProcessor.process(RequestProcessor.java:236) [struts-1.2.9.jar:1.2.9] at org.apache.struts.action.ActionServlet.process(ActionServlet.java:1196) [struts-1.2.9.jar:1.2.9] at org.apache.struts.action.ActionServlet.doGet(ActionServlet.java:414) [struts-1.2.9.jar:1.2.9] at javax.servlet.http.HttpServlet.service(HttpServlet.java:617) [tomcat6-servlet-2.5-api-6.0.26.jar:na] at javax.servlet.http.HttpServlet.service(HttpServlet.java:717) [tomcat6-servlet-2.5-api-6.0.26.jar:na] at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:290) [catalina-6.0.26.jar:6.0.26] at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206) [catalina-6.0.26.jar:6.0.26] at com.xpn.xwiki.web.ActionFilter.doFilter(ActionFilter.java:120) [xwiki-platform-legacy-oldcore-4.4.jar:na] at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235) [catalina-6.0.26.jar:6.0.26] at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206) [catalina-6.0.26.jar:6.0.26] at org.xwiki.wysiwyg.server.filter.ConversionFilter.doFilter(ConversionFilter.java:144) [xwiki-platform-wysiwyg-server-4.4.jar:na] at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235) [catalina-6.0.26.jar:6.0.26] at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206) [catalina-6.0.26.jar:6.0.26] at com.xpn.xwiki.plugin.webdav.XWikiDavFilter.doFilter(XWikiDavFilter.java:66) [xwiki-platform-webdav-server-4.4.jar:na] at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235) [catalina-6.0.26.jar:6.0.26] at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206) [catalina-6.0.26.jar:6.0.26] at org.xwiki.container.servlet.filters.internal.SavedRequestRestorerFilter.doFilter(SavedRequestRestorerFilter.java:208) [xwiki-platform-container-servlet-4.4.jar:na] at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235) [catalina-6.0.26.jar:6.0.26] at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206) [catalina-6.0.26.jar:6.0.26] at org.xwiki.container.servlet.filters.internal.SetCharacterEncodingFilter.doFilter(SetCharacterEncodingFilter.java:111) [xwiki-platform-container-servlet-4.4.jar:na] at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235) [catalina-6.0.26.jar:6.0.26] at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206) [catalina-6.0.26.jar:6.0.26] at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:233) [catalina-6.0.26.jar:6.0.26] at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:191) [catalina-6.0.26.jar:6.0.26] at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127) [catalina-6.0.26.jar:6.0.26] at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:102) [catalina-6.0.26.jar:6.0.26] at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109) [catalina-6.0.26.jar:6.0.26] at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:298) [catalina-6.0.26.jar:6.0.26] at org.apache.coyote.ajp.AjpAprProcessor.process(AjpAprProcessor.java:429) [tomcat-coyote-6.0.26.jar:6.0.26] at org.apache.coyote.ajp.AjpAprProtocol$AjpConnectionHandler.process(AjpAprProtocol.java:384) [tomcat-coyote-6.0.26.jar:6.0.26] at org.apache.tomcat.util.net.AprEndpoint$Worker.run(AprEndpoint.java:1555) [tomcat-coyote-6.0.26.jar:6.0.26] at java.lang.Thread.run(Thread.java:636) [na:1.6.0_20] Caused by: com.xpn.xwiki.XWikiException: Error number 3005 in 3: R40000XWIKI6990 migration failed Wrapped Exception: Error number 0 in 3: Exception while hibernate execute Wrapped Exception: could not execute native bulk manipulation query at com.xpn.xwiki.store.migration.hibernate.R40000XWIKI6990DataMigration.hibernateMigrate(R40000XWIKI6990DataMigration.java:1076) ~[xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.migration.hibernate.AbstractHibernateDataMigration.migrate(AbstractHibernateDataMigration.java:109) ~[xwiki-platform-legacy-oldcore-4.4.jar:na] ... 57 common frames omitted Caused by: com.xpn.xwiki.XWikiException: Error number 0 in 3: Exception while hibernate execute Wrapped Exception: could not execute native bulk manipulation query at com.xpn.xwiki.store.XWikiHibernateBaseStore.execute(XWikiHibernateBaseStore.java:1235) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.XWikiHibernateBaseStore.executeWrite(XWikiHibernateBaseStore.java:1343) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.migration.hibernate.R40000XWIKI6990DataMigration.hibernateMigrate(R40000XWIKI6990DataMigration.java:1063) ~[xwiki-platform-legacy-oldcore-4.4.jar:na] ... 58 common frames omitted Caused by: org.hibernate.exception.ConstraintViolationException: could not execute native bulk manipulation query at org.hibernate.exception.SQLStateConverter.convert(SQLStateConverter.java:96) ~[hibernate-core-3.6.9.Final.jar:3.6.9.Final] at org.hibernate.exception.JDBCExceptionHelper.convert(JDBCExceptionHelper.java:66) ~[hibernate-core-3.6.9.Final.jar:3.6.9.Final] at org.hibernate.engine.query.NativeSQLQueryPlan.performExecuteUpdate(NativeSQLQueryPlan.java:219) ~[hibernate-core-3.6.9.Final.jar:3.6.9.Final] at org.hibernate.impl.SessionImpl.executeNativeUpdate(SessionImpl.java:1310) ~[hibernate-core-3.6.9.Final.jar:3.6.9.Final] at org.hibernate.impl.SQLQueryImpl.executeUpdate(SQLQueryImpl.java:396) ~[hibernate-core-3.6.9.Final.jar:3.6.9.Final] at com.xpn.xwiki.store.migration.hibernate.R40000XWIKI6990DataMigration$AbstractBulkIdConversionHibernateCallback.executeSqlIdUpdate(R40000XWIKI6990DataMigration.java:531) ~[xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.migration.hibernate.R40000XWIKI6990DataMigration$3.doBulkIdUpdate(R40000XWIKI6990DataMigration.java:1071) ~[xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.migration.hibernate.R40000XWIKI6990DataMigration$AbstractBulkIdConversionHibernateCallback.doUpdate(R40000XWIKI6990DataMigration.java:356) ~[xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.migration.hibernate.R40000XWIKI6990DataMigration$AbstractUpdateHibernateCallback.doInHibernate(R40000XWIKI6990DataMigration.java:218) ~[xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.XWikiHibernateBaseStore.execute(XWikiHibernateBaseStore.java:1229) [xwiki-platform-legacy-oldcore-4.4.jar:na] ... 60 common frames omitted Caused by: org.postgresql.util.PSQLException: ERROR: duplicate key value violates unique constraint "xwikidoc_pkey" at org.postgresql.core.v3.QueryExecutorImpl.receiveErrorResponse(QueryExecutorImpl.java:2062) ~[postgresql-jdbc.jar:na] at org.postgresql.core.v3.QueryExecutorImpl.processResults(QueryExecutorImpl.java:1795) ~[postgresql-jdbc.jar:na] at org.postgresql.core.v3.QueryExecutorImpl.execute(QueryExecutorImpl.java:257) ~[postgresql-jdbc.jar:na] at org.postgresql.jdbc2.AbstractJdbc2Statement.execute(AbstractJdbc2Statement.java:479) ~[postgresql-jdbc.jar:na] at org.postgresql.jdbc2.AbstractJdbc2Statement.executeWithFlags(AbstractJdbc2Statement.java:367) ~[postgresql-jdbc.jar:na] at org.postgresql.jdbc2.AbstractJdbc2Statement.executeUpdate(AbstractJdbc2Statement.java:321) ~[postgresql-jdbc.jar:na] at org.apache.commons.dbcp.DelegatingPreparedStatement.executeUpdate(DelegatingPreparedStatement.java:105) ~[commons-dbcp-1.3.jar:1.3] at org.apache.commons.dbcp.DelegatingPreparedStatement.executeUpdate(DelegatingPreparedStatement.java:105) ~[commons-dbcp-1.3.jar:1.3] at org.apache.commons.dbcp.DelegatingPreparedStatement.executeUpdate(DelegatingPreparedStatement.java:105) ~[commons-dbcp-1.3.jar:1.3] at org.hibernate.engine.query.NativeSQLQueryPlan.performExecuteUpdate(NativeSQLQueryPlan.java:210) ~[hibernate-core-3.6.9.Final.jar:3.6.9.Final] ... 67 common frames omitted 2013-01-08 09:32:15,615 [http://10.100.2.66/xwiki/bin/view/Main/] ERROR .HibernateDataMigrationManager - Main database migration failed, it is not safe to continue! com.xpn.xwiki.store.migration.DataMigrationException: Failed to migrate database [xwiki]... at com.xpn.xwiki.store.migration.AbstractDataMigrationManager.startMigrationsForDatabase(AbstractDataMigrationManager.java:550) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.migration.AbstractDataMigrationManager.startMigrations(AbstractDataMigrationManager.java:493) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.migration.hibernate.HibernateDataMigrationManager.startMigrations(HibernateDataMigrationManager.java:343) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.migration.AbstractDataMigrationManager.checkDatabase(AbstractDataMigrationManager.java:421) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.XWikiHibernateBaseStore.setDatabase(XWikiHibernateBaseStore.java:665) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.XWikiHibernateBaseStore.beginTransaction(XWikiHibernateBaseStore.java:840) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.XWikiHibernateBaseStore.beginTransaction(XWikiHibernateBaseStore.java:772) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.XWikiHibernateStore.loadXWikiDoc(XWikiHibernateStore.java:750) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.XWikiCacheStore.loadXWikiDoc(XWikiCacheStore.java:290) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.XWiki.getDocument(XWiki.java:1404) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.XWiki.getDocument(XWiki.java:1447) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.XWiki.getXWikiPreference(XWiki.java:2179) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.XWiki.getXWikiPreference(XWiki.java:2211) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.render.XWikiMacrosMappingRenderer.loadPreferences(XWikiMacrosMappingRenderer.java:107) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.render.XWikiMacrosMappingRenderer.(XWikiMacrosMappingRenderer.java:83) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.render.DefaultXWikiRenderingEngine.(DefaultXWikiRenderingEngine.java:72) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.XWiki.resetRenderingEngine(XWiki.java:1080) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.XWiki.initXWiki(XWiki.java:787) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.XWiki.(XWiki.java:735) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.XWiki.getMainXWiki(XWiki.java:394) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.XWiki.getXWiki(XWiki.java:483) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.web.XWikiAction.execute(XWikiAction.java:136) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.web.XWikiAction.execute(XWikiAction.java:116) [xwiki-platform-legacy-oldcore-4.4.jar:na] at org.apache.struts.action.RequestProcessor.processActionPerform(RequestProcessor.java:431) [struts-1.2.9.jar:1.2.9] at org.apache.struts.action.RequestProcessor.process(RequestProcessor.java:236) [struts-1.2.9.jar:1.2.9] at org.apache.struts.action.ActionServlet.process(ActionServlet.java:1196) [struts-1.2.9.jar:1.2.9] at org.apache.struts.action.ActionServlet.doGet(ActionServlet.java:414) [struts-1.2.9.jar:1.2.9] at javax.servlet.http.HttpServlet.service(HttpServlet.java:617) [tomcat6-servlet-2.5-api-6.0.26.jar:na] at javax.servlet.http.HttpServlet.service(HttpServlet.java:717) [tomcat6-servlet-2.5-api-6.0.26.jar:na] at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:290) [catalina-6.0.26.jar:6.0.26] at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206) [catalina-6.0.26.jar:6.0.26] at com.xpn.xwiki.web.ActionFilter.doFilter(ActionFilter.java:120) [xwiki-platform-legacy-oldcore-4.4.jar:na] at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235) [catalina-6.0.26.jar:6.0.26] at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206) [catalina-6.0.26.jar:6.0.26] at org.xwiki.wysiwyg.server.filter.ConversionFilter.doFilter(ConversionFilter.java:144) [xwiki-platform-wysiwyg-server-4.4.jar:na] at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235) [catalina-6.0.26.jar:6.0.26] at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206) [catalina-6.0.26.jar:6.0.26] at com.xpn.xwiki.plugin.webdav.XWikiDavFilter.doFilter(XWikiDavFilter.java:66) [xwiki-platform-webdav-server-4.4.jar:na] at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235) [catalina-6.0.26.jar:6.0.26] at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206) [catalina-6.0.26.jar:6.0.26] at org.xwiki.container.servlet.filters.internal.SavedRequestRestorerFilter.doFilter(SavedRequestRestorerFilter.java:208) [xwiki-platform-container-servlet-4.4.jar:na] at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235) [catalina-6.0.26.jar:6.0.26] at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206) [catalina-6.0.26.jar:6.0.26] at org.xwiki.container.servlet.filters.internal.SetCharacterEncodingFilter.doFilter(SetCharacterEncodingFilter.java:111) [xwiki-platform-container-servlet-4.4.jar:na] at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235) [catalina-6.0.26.jar:6.0.26] at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206) [catalina-6.0.26.jar:6.0.26] at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:233) [catalina-6.0.26.jar:6.0.26] at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:191) [catalina-6.0.26.jar:6.0.26] at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127) [catalina-6.0.26.jar:6.0.26] at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:102) [catalina-6.0.26.jar:6.0.26] at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109) [catalina-6.0.26.jar:6.0.26] at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:298) [catalina-6.0.26.jar:6.0.26] at org.apache.coyote.ajp.AjpAprProcessor.process(AjpAprProcessor.java:429) [tomcat-coyote-6.0.26.jar:6.0.26] at org.apache.coyote.ajp.AjpAprProtocol$AjpConnectionHandler.process(AjpAprProtocol.java:384) [tomcat-coyote-6.0.26.jar:6.0.26] at org.apache.tomcat.util.net.AprEndpoint$Worker.run(AprEndpoint.java:1555) [tomcat-coyote-6.0.26.jar:6.0.26] at java.lang.Thread.run(Thread.java:636) [na:1.6.0_20] Caused by: com.xpn.xwiki.store.migration.DataMigrationException: Data migration R40000XWIKI6990 failed at com.xpn.xwiki.store.migration.hibernate.AbstractHibernateDataMigration.migrate(AbstractHibernateDataMigration.java:111) ~[xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.migration.AbstractDataMigrationManager.startMigrations(AbstractDataMigrationManager.java:636) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.migration.AbstractDataMigrationManager.startMigrationsForDatabase(AbstractDataMigrationManager.java:546) [xwiki-platform-legacy-oldcore-4.4.jar:na] ... 55 common frames omitted Caused by: com.xpn.xwiki.XWikiException: Error number 3005 in 3: R40000XWIKI6990 migration failed Wrapped Exception: Error number 0 in 3: Exception while hibernate execute Wrapped Exception: could not execute native bulk manipulation query at com.xpn.xwiki.store.migration.hibernate.R40000XWIKI6990DataMigration.hibernateMigrate(R40000XWIKI6990DataMigration.java:1076) ~[xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.migration.hibernate.AbstractHibernateDataMigration.migrate(AbstractHibernateDataMigration.java:109) ~[xwiki-platform-legacy-oldcore-4.4.jar:na] ... 57 common frames omitted Caused by: com.xpn.xwiki.XWikiException: Error number 0 in 3: Exception while hibernate execute Wrapped Exception: could not execute native bulk manipulation query at com.xpn.xwiki.store.XWikiHibernateBaseStore.execute(XWikiHibernateBaseStore.java:1235) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.XWikiHibernateBaseStore.executeWrite(XWikiHibernateBaseStore.java:1343) [xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.migration.hibernate.R40000XWIKI6990DataMigration.hibernateMigrate(R40000XWIKI6990DataMigration.java:1063) ~[xwiki-platform-legacy-oldcore-4.4.jar:na] ... 58 common frames omitted Caused by: org.hibernate.exception.ConstraintViolationException: could not execute native bulk manipulation query at org.hibernate.exception.SQLStateConverter.convert(SQLStateConverter.java:96) ~[hibernate-core-3.6.9.Final.jar:3.6.9.Final] at org.hibernate.exception.JDBCExceptionHelper.convert(JDBCExceptionHelper.java:66) ~[hibernate-core-3.6.9.Final.jar:3.6.9.Final] at org.hibernate.engine.query.NativeSQLQueryPlan.performExecuteUpdate(NativeSQLQueryPlan.java:219) ~[hibernate-core-3.6.9.Final.jar:3.6.9.Final] at org.hibernate.impl.SessionImpl.executeNativeUpdate(SessionImpl.java:1310) ~[hibernate-core-3.6.9.Final.jar:3.6.9.Final] at org.hibernate.impl.SQLQueryImpl.executeUpdate(SQLQueryImpl.java:396) ~[hibernate-core-3.6.9.Final.jar:3.6.9.Final] at com.xpn.xwiki.store.migration.hibernate.R40000XWIKI6990DataMigration$AbstractBulkIdConversionHibernateCallback.executeSqlIdUpdate(R40000XWIKI6990DataMigration.java:531) ~[xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.migration.hibernate.R40000XWIKI6990DataMigration$3.doBulkIdUpdate(R40000XWIKI6990DataMigration.java:1071) ~[xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.migration.hibernate.R40000XWIKI6990DataMigration$AbstractBulkIdConversionHibernateCallback.doUpdate(R40000XWIKI6990DataMigration.java:356) ~[xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.migration.hibernate.R40000XWIKI6990DataMigration$AbstractUpdateHibernateCallback.doInHibernate(R40000XWIKI6990DataMigration.java:218) ~[xwiki-platform-legacy-oldcore-4.4.jar:na] at com.xpn.xwiki.store.XWikiHibernateBaseStore.execute(XWikiHibernateBaseStore.java:1229) [xwiki-platform-legacy-oldcore-4.4.jar:na] ... 60 common frames omitted Caused by: org.postgresql.util.PSQLException: ERROR: duplicate key value violates unique constraint "xwikidoc_pkey" at org.postgresql.core.v3.QueryExecutorImpl.receiveErrorResponse(QueryExecutorImpl.java:2062) ~[postgresql-jdbc.jar:na] at org.postgresql.core.v3.QueryExecutorImpl.processResults(QueryExecutorImpl.java:1795) ~[postgresql-jdbc.jar:na] at org.postgresql.core.v3.QueryExecutorImpl.execute(QueryExecutorImpl.java:257) ~[postgresql-jdbc.jar:na] at org.postgresql.jdbc2.AbstractJdbc2Statement.execute(AbstractJdbc2Statement.java:479) ~[postgresql-jdbc.jar:na] at org.postgresql.jdbc2.AbstractJdbc2Statement.executeWithFlags(AbstractJdbc2Statement.java:367) ~[postgresql-jdbc.jar:na] at org.postgresql.jdbc2.AbstractJdbc2Statement.executeUpdate(AbstractJdbc2Statement.java:321) ~[postgresql-jdbc.jar:na] at org.apache.commons.dbcp.DelegatingPreparedStatement.executeUpdate(DelegatingPreparedStatement.java:105) ~[commons-dbcp-1.3.jar:1.3] at org.apache.commons.dbcp.DelegatingPreparedStatement.executeUpdate(DelegatingPreparedStatement.java:105) ~[commons-dbcp-1.3.jar:1.3] at org.apache.commons.dbcp.DelegatingPreparedStatement.executeUpdate(DelegatingPreparedStatement.java:105) ~[commons-dbcp-1.3.jar:1.3] at org.hibernate.engine.query.NativeSQLQueryPlan.performExecuteUpdate(NativeSQLQueryPlan.java:210) ~[hibernate-core-3.6.9.Final.jar:3.6.9.Final] ... 67 common frames omitted