Video Screencast Help
Symantec to Separate Into Two Focused, Industry-Leading Technology Companies. Learn more.

Database upgrade failure 12.1.1.1 to 12.1.2.2

Created: 26 Nov 2012 | 8 comments
Bulbous's picture

Error is "File associated with given page id is invalid or not open -- transaction rolled back"

Complete log file is below:

2012-11-26 20:20:32.189 THREAD 1 SEVERE: ================== Server Environment ===================
2012-11-26 20:20:32.189 THREAD 1 SEVERE: os.name = Windows Server 2008 R2
2012-11-26 20:20:32.189 THREAD 1 SEVERE: os.version = 6.1
2012-11-26 20:20:32.189 THREAD 1 SEVERE: os.arch = x64
2012-11-26 20:20:32.189 THREAD 1 SEVERE: java.version = 1.7.0_09
2012-11-26 20:20:32.189 THREAD 1 SEVERE: java.vendor = Oracle Corporation
2012-11-26 20:20:32.189 THREAD 1 SEVERE: java.vm.name = Java HotSpot(TM) Client VM
2012-11-26 20:20:32.189 THREAD 1 SEVERE: java.vm.version = 23.5-b02
2012-11-26 20:20:32.189 THREAD 1 SEVERE: java.home = C:\Program Files (x86)\Symantec\Symantec Endpoint Protection Manager\jre
2012-11-26 20:20:32.189 THREAD 1 SEVERE: catalina.home = C:\Program Files (x86)\Symantec\Symantec Endpoint Protection Manager\tomcat
2012-11-26 20:20:32.189 THREAD 1 SEVERE: java.user = null
2012-11-26 20:20:32.189 THREAD 1 SEVERE: user.language = en
2012-11-26 20:20:32.189 THREAD 1 SEVERE: user.country = US
2012-11-26 20:20:32.189 THREAD 1 SEVERE: scm.server.version = 12.1.2015.2015
2012-11-26 20:20:32.189 THREAD 1 INFO: Main>> Main> Upgrade parameters
2012-11-26 20:20:32.189 THREAD 1 INFO: Main>> Main> Upgrade args length = 0
2012-11-26 20:20:32.189 THREAD 1 INFO: Main>> Main> Unable to get the command-line arguments
2012-11-26 20:20:32.189 THREAD 1 INFO: Main>> Main> Server Home: C:\Program Files (x86)\Symantec\Symantec Endpoint Protection Manager\tomcat
2012-11-26 20:20:32.532 THREAD 1 INFO: DatabaseUtilities>initDataSource: Found 12.x driver
2012-11-26 20:20:32.532 THREAD 1 INFO: initDatasource dbport:2638
2012-11-26 20:20:32.532 THREAD 1 INFO: Datasource set in sqlanywhere>>ds:sybase.jdbc4.sqlanywhere.ASADataSource@b99636
2012-11-26 20:20:32.547 THREAD 1 INFO: Checking whether the service is running: SQLANYs_sem5
2012-11-26 20:20:32.547 THREAD 1 INFO: Retrieve status for service SQLANYs_sem5
2012-11-26 20:20:32.579 THREAD 1 INFO: The status for SQLANYs_sem5' service is 4
2012-11-26 20:20:32.735 THREAD 1 INFO: Has valid SAV license
2012-11-26 20:20:32.750 THREAD 1 INFO: Info>> No SNAC license file in C:\Program Files (x86)\Symantec\Symantec Endpoint Protection Manager\tomcat\etc\license
2012-11-26 20:20:34.107 THREAD 1 INFO: Main>> executePreLaunchSteps> Config schema format is upgraded from (schema version from db): 12.1.1.1
2012-11-26 20:20:34.544 THREAD 1 INFO: Saving disaster recovery data to: C:\Program Files (x86)\Symantec\Symantec Endpoint Protection Manager\tomcat\..\Server Private Key Backup\recovery_2012-11-26-20-20-34.zip
2012-11-26 20:20:34.653 THREAD 1 INFO: Main>> executePreLaunchSteps> DbVersion: 12.1.1.1 schemaVersionFromDB: 12.1.1.1 isSpm51Mr7: false hasOtherOSAgents: false dbcompanySize: 3 dbConnected: true
2012-11-26 20:20:34.653 THREAD 1 INFO: Main>> checkUpgradeFeasibility> Checking for upgrade feasibility, current schema version = 12.1.2.2, schema version from db = 12.1.1.1
2012-11-26 20:20:34.653 THREAD 1 INFO: VersionToBeSupported: 12.1.1.1
2012-11-26 20:20:34.653 THREAD 1 INFO: SchemaVersion>> isSupported> versionToBeSupported '12.1.1.1  is supported for this release
2012-11-26 20:20:34.653 THREAD 1 INFO: Main>> displayOnlineServerListIfAny> Checking online servers... siteId = 54B1D594C0A83702014F1C6739E4091D
2012-11-26 20:20:34.669 THREAD 1 INFO: SELECT CONTENT FROM SYSTEM_STATE WHERE OWNER = '9F992319C0A837020177357D681A5D3F'
2012-11-26 20:20:34.731 THREAD 1 INFO: SYSOUT : Checking onlist status for server WRIDSV01
2012-11-26 20:20:34.731 THREAD 1 INFO: SYSOUT : Not checking status. offline status detected
2012-11-26 20:20:34.731 THREAD 1 INFO: SYSOUT : [name=WRIDSV01,id=9F992319C0A837020177357D681A5D3F] is offline
2012-11-26 20:20:34.731 THREAD 1 INFO: Main>> displayOnlineServerListIfAny> Checking online servers... exclude local server id = 9F992319C0A837020177357D681A5D3F
2012-11-26 20:20:34.731 THREAD 1 INFO: Main>> displayOnlineServerListIfAny> Online servers:[]
2012-11-26 20:20:34.731 THREAD 1 INFO: Main>> launchMainFrame> Launching the UI
2012-11-26 20:20:35.012 THREAD 1 INFO: isLicenseInstallationValid:  sep.slf =true  OD file=true
2012-11-26 20:20:37.898 THREAD 15 INFO: scm.server.port is found in conf.properties
2012-11-26 20:20:37.898 THREAD 15 INFO: scm.http.port is found in conf.properties
2012-11-26 20:20:37.898 THREAD 15 INFO: scm.webserver.http.port is found in conf.properties
2012-11-26 20:20:37.898 THREAD 15 INFO: scm.webserver.https.port is not found in conf.properties
2012-11-26 20:20:37.898 THREAD 15 INFO: scm.shutdown.port is found in conf.properties
2012-11-26 20:20:37.898 THREAD 15 INFO: scm.console.reporting.https.port is found in conf.properties
2012-11-26 20:20:37.898 THREAD 15 INFO: scm.webservices.port is found in conf.properties
2012-11-26 20:20:37.898 THREAD 15 INFO: scm.iis.http.port is not found in conf.properties
2012-11-26 20:20:37.898 THREAD 15 INFO: scm.iis.https.port is not found in conf.properties
2012-11-26 20:20:37.898 THREAD 15 INFO: scm.iisproxy.http.port is not found in conf.properties
2012-11-26 20:20:37.898 THREAD 15 INFO: scm.iisproxy.https.port is not found in conf.properties
2012-11-26 20:20:38.928 THREAD 19 INFO: Initializing ...
2012-11-26 20:20:38.928 THREAD 19 INFO: UpgradeStep >> checkUpgradeStatus.
2012-11-26 20:20:38.928 THREAD 19 INFO: Executing command - stop semsrv
2012-11-26 20:20:38.959 THREAD 19 INFO: The Symantec Endpoint Protection Manager service is not started.
2012-11-26 20:20:38.959 THREAD 19 INFO:
2012-11-26 20:20:38.959 THREAD 19 INFO: More help is available by typing NET HELPMSG 3521.
2012-11-26 20:20:38.959 THREAD 19 INFO:
2012-11-26 20:20:38.959 THREAD 19 INFO: Waiting for service termination: semsrv
2012-11-26 20:20:38.959 THREAD 19 INFO: Checking whether the service is stopped: semsrv
2012-11-26 20:20:38.959 THREAD 19 INFO: Retrieve status for service semsrv
2012-11-26 20:20:39.006 THREAD 19 INFO: The status for semsrv' service is 1
2012-11-26 20:20:39.006 THREAD 19 INFO: Service is stopped.
2012-11-26 20:20:39.006 THREAD 19 INFO: Executing command - stop semwebsrv
2012-11-26 20:20:39.037 THREAD 19 INFO: The Symantec Endpoint Protection Manager Webserver service is not started.
2012-11-26 20:20:39.037 THREAD 19 INFO:
2012-11-26 20:20:39.037 THREAD 19 INFO: More help is available by typing NET HELPMSG 3521.
2012-11-26 20:20:39.037 THREAD 19 INFO:
2012-11-26 20:20:39.037 THREAD 19 INFO: Stop SemSrv done.
2012-11-26 20:20:39.037 THREAD 19 INFO: Action Start:0
2012-11-26 20:20:39.037 THREAD 19 INFO: DatabaseUtilities>initDataSource: Found 12.x driver
2012-11-26 20:20:39.037 THREAD 19 INFO: initDatasource dbport:2638
2012-11-26 20:20:39.037 THREAD 19 INFO: Datasource set in sqlanywhere>>ds:sybase.jdbc4.sqlanywhere.ASADataSource@1201208
2012-11-26 20:20:39.053 THREAD 19 INFO: initDataSource
2012-11-26 20:20:39.053 THREAD 19 INFO: DatabaseUtilities>initDataSource: Found 12.x driver
2012-11-26 20:20:39.053 THREAD 19 INFO: initDatasource dbport:2638
2012-11-26 20:20:39.053 THREAD 19 INFO: Datasource set in sqlanywhere>>ds:sybase.jdbc4.sqlanywhere.ASADataSource@4d0325
2012-11-26 20:20:40.301 THREAD 19 INFO: Try to reinstall Embedded DB service.
2012-11-26 20:20:40.301 THREAD 19 INFO: Running net stop SQLANYs_sem5......
2012-11-26 20:20:42.843 THREAD 19 INFO: The Symantec Embedded Database service is stopping.The Symantec Embedded Database service was stopped successfully.
2012-11-26 20:20:42.843 THREAD 19 INFO: Checking whether the service is running: SQLANYs_sem5
2012-11-26 20:20:42.843 THREAD 19 INFO: Retrieve status for service SQLANYs_sem5
2012-11-26 20:20:42.875 THREAD 19 INFO: The status for SQLANYs_sem5' service is 1
2012-11-26 20:20:42.875 THREAD 19 INFO: Running dbsvc.exe -d sem5 -q -y
2012-11-26 20:20:45.012 THREAD 19 INFO: SQL Anywhere Service Utility Version 12.0.1.3554Service "sem5" was created successfully.
2012-11-26 20:20:45.012 THREAD 19 INFO: C:\Program Files (x86)\Symantec\Symantec Endpoint Protection Manager\tomcat\..\bin\ServiceUtil.exe
2012-11-26 20:20:45.012 THREAD 19 INFO: -service
2012-11-26 20:20:45.012 THREAD 19 INFO: SQLANYs_sem5
2012-11-26 20:20:45.012 THREAD 19 INFO: -setservicerecovery
2012-11-26 20:20:45.012 THREAD 19 INFO:
2012-11-26 20:20:46.041 THREAD 19 INFO: Service Recovery options for SQLANYs_sem5 have been successfully configured.
2012-11-26 20:20:46.041 THREAD 19 INFO: Executing command - start SQLANYs_sem5
2012-11-26 20:20:50.628 THREAD 19 INFO: The Symantec Embedded Database service is starting..
2012-11-26 20:20:50.628 THREAD 19 INFO: The Symantec Embedded Database service was started successfully.
2012-11-26 20:20:50.628 THREAD 19 INFO:
2012-11-26 20:20:50.628 THREAD 19 INFO: Waiting for service running: SQLANYs_sem5
2012-11-26 20:20:50.628 THREAD 19 INFO: Checking whether the service is running: SQLANYs_sem5
2012-11-26 20:20:50.628 THREAD 19 INFO: Retrieve status for service SQLANYs_sem5
2012-11-26 20:20:50.659 THREAD 19 INFO: The status for SQLANYs_sem5' service is 4
2012-11-26 20:20:50.659 THREAD 19 INFO: The service SQLANYs_sem5 has already been started.
2012-11-26 20:20:50.659 THREAD 19 INFO: UpgradeStep >> checkUpgradeStatus.
2012-11-26 20:20:50.659 THREAD 19 INFO: UpgradeStep >> checkUpgradeStatus.
2012-11-26 20:20:50.753 THREAD 19 INFO: updateEmbeddedStatementCount done
2012-11-26 20:20:50.846 THREAD 19 INFO: Config schema format is upgraded from: 12.1.1.1
2012-11-26 20:20:50.862 THREAD 19 INFO: Upgrade schema started ...
2012-11-26 20:20:50.877 THREAD 19 INFO: Process SQL script file:EmbeddedAmberRU1MP1ToJaguarPFC.sql
2012-11-26 20:20:50.877 THREAD 19 INFO: Process SQL InputStream sqlis:sun.net.www.protocol.jar.JarURLConnection$JarURLInputStream@6affa7
2012-11-26 20:20:50.877 THREAD 19 INFO: DatabaseUtilities>>execCommandFromScript>>cmdSeperator:;;
2012-11-26 20:20:50.877 THREAD 19 INFO: DatabaseUtilities>>execCommandFromScript>>sqlStr:ALTER TABLE BASIC_METADATA  ALTER DESCRIPTION nvarchar(2048) NULL
2012-11-26 20:20:50.877 THREAD 19 INFO: ALTER TABLE BASIC_METADATA  ALTER DESCRIPTION nvarchar(2048) NULL
2012-11-26 20:20:52.125 THREAD 19 INFO:   IF NOT EXISTS (SELECT TECH_ID FROM DATA_HANDLER WHERE IDX = '966665E10AB4F6D4000ECE6523320426' )  INSERT INTO DATA_HANDLER (IDX, TECH_ID, LF_EXT, LF_SORT, STATE_HANDLER) VALUES ('966665E10AB4F6D4000ECE6523320426', 'ElamMan',  '.dat',       0,   'com.sygate.scm.server.statereader.elam.StateHandler')
2012-11-26 20:20:52.188 THREAD 19 INFO:  IF NOT EXISTS (SELECT C.NAME FROM SYSOBJECTS S, SYSCOLUMNS C          WHERE C.ID = S.ID AND S.NAME = 'SEM_AGENT' AND C.NAME='ELAM_ONOFF')  BEGIN     ALTER TABLE SEM_AGENT ADD ELAM_ONOFF TINYINT NOT NULL DEFAULT 127  END
2012-11-26 20:20:53.311 THREAD 19 SEVERE: SQL Exception:
2012-11-26 20:20:53.311 THREAD 19 SEVERE: SQL Command:  IF NOT EXISTS (SELECT C.NAME FROM SYSOBJECTS S, SYSCOLUMNS C          WHERE C.ID = S.ID AND S.NAME = 'SEM_AGENT' AND C.NAME='ELAM_ONOFF')  BEGIN     ALTER TABLE SEM_AGENT ADD ELAM_ONOFF TINYINT NOT NULL DEFAULT 127  END
2012-11-26 20:20:53.311 THREAD 19 SEVERE: SQLState:  HY000
2012-11-26 20:20:53.311 THREAD 19 SEVERE: Message:  [Sybase][JDBC Driver][SQL Anywhere]Internal database error *** ERROR *** Assertion failed: 102300 (12.0.1.3554)[sem5]
File associated with given page id is invalid or not open -- transaction rolled back
2012-11-26 20:20:53.311 THREAD 19 SEVERE: Vendor:  -301
2012-11-26 20:20:53.311 THREAD 19 SEVERE: java.sql.SQLException: [Sybase][JDBC Driver][SQL Anywhere]Internal database error *** ERROR *** Assertion failed: 102300 (12.0.1.3554)[sem5]
File associated with given page id is invalid or not open -- transaction rolled back
2012-11-26 20:20:53.311 THREAD 19 SEVERE:     at sybase.jdbc4.sqlanywhere.IIStatement.execute(Native Method)
2012-11-26 20:20:53.311 THREAD 19 SEVERE:     at sybase.jdbc4.sqlanywhere.IStatement.execute(IStatement.java:309)
2012-11-26 20:20:53.311 THREAD 19 SEVERE:     at com.sygate.scm.server.db.util.DatabaseUtilities.execCommandFromScript(DatabaseUtilities.java:1950)
2012-11-26 20:20:53.311 THREAD 19 SEVERE:     at com.sygate.scm.server.db.util.DbHelper.execCommandFromScript(DbHelper.java:199)
2012-11-26 20:20:53.311 THREAD 19 SEVERE:     at com.sygate.scm.server.db.util.EmbededDbHelper.upgrade(EmbededDbHelper.java:284)
2012-11-26 20:20:53.311 THREAD 19 SEVERE:     at com.sygate.scm.server.upgrade.Upgrade.upgradeDatabaseSchema(Upgrade.java:2031)
2012-11-26 20:20:53.311 THREAD 19 SEVERE:     at com.sygate.scm.server.upgrade.Upgrade.doUpgrade(Upgrade.java:523)
2012-11-26 20:20:53.311 THREAD 19 SEVERE:     at com.sygate.scm.server.upgrade.ui.UpgradeTask.go(UpgradeTask.java:127)
2012-11-26 20:20:53.311 THREAD 19 SEVERE:     at com.sygate.scm.server.upgrade.ui.UpgradeProgressPanel$2.construct(UpgradeProgressPanel.java:138)
2012-11-26 20:20:53.311 THREAD 19 SEVERE:     at com.sygate.scm.util.SwingWorker$2.run(SwingWorker.java:145)
2012-11-26 20:20:53.311 THREAD 19 SEVERE:     at java.lang.Thread.run(Thread.java:722)
2012-11-26 20:20:53.311 THREAD 19 SEVERE: java.sql.SQLException: [Sybase][JDBC Driver][SQL Anywhere]Connection was terminated
2012-11-26 20:20:53.311 THREAD 19 SEVERE:     at sybase.jdbc4.sqlanywhere.IConnection.rollback(Native Method)
2012-11-26 20:20:53.311 THREAD 19 SEVERE:     at com.sygate.scm.server.db.util.EmbededDbHelper.upgrade(EmbededDbHelper.java:306)
2012-11-26 20:20:53.311 THREAD 19 SEVERE:     at com.sygate.scm.server.upgrade.Upgrade.upgradeDatabaseSchema(Upgrade.java:2031)
2012-11-26 20:20:53.311 THREAD 19 SEVERE:     at com.sygate.scm.server.upgrade.Upgrade.doUpgrade(Upgrade.java:523)
2012-11-26 20:20:53.311 THREAD 19 SEVERE:     at com.sygate.scm.server.upgrade.ui.UpgradeTask.go(UpgradeTask.java:127)
2012-11-26 20:20:53.311 THREAD 19 SEVERE:     at com.sygate.scm.server.upgrade.ui.UpgradeProgressPanel$2.construct(UpgradeProgressPanel.java:138)
2012-11-26 20:20:53.311 THREAD 19 SEVERE:     at com.sygate.scm.util.SwingWorker$2.run(SwingWorker.java:145)
2012-11-26 20:20:53.311 THREAD 19 SEVERE:     at java.lang.Thread.run(Thread.java:722)
2012-11-26 20:20:53.311 THREAD 19 SEVERE: Upgrade.doUpgrade java.sql.SQLException: [Sybase][JDBC Driver][SQL Anywhere]Connection was terminated
2012-11-26 20:21:37.381 THREAD 15 INFO: UpgradeFinalPanel >> saveStage > Launching log file...
 

Comments 8 CommentsJump to latest comment

Mohan Babu's picture

As per the Log it seems to be Database corrupted and need to perform disaster recovery with a known good backup of the database.

2012-11-26 20:20:53.311 THREAD 19 SEVERE: java.sql.SQLException: [Sybase][JDBC Driver][SQL Anywhere]Internal database error *** ERROR *** Assertion failed: 102300 (12.0.1.3554)[sem5]
File associated with given page id is invalid or not open -- transaction rolled back

https://www-secure.symantec.com/connect/forums/emb...

https://www-secure.symantec.com/connect/forums/sep...

Symantec Endpoint Protection 12.1: Best Practices for Disaster Recovery with the Symantec Endpoint Protection Manager

http://www.symantec.com/docs/TECH160736

Kindly mark the thread accordingly

Mohan Babu

moglie20@gmail.com

+91 9884382160

Your satisfaction is very important to us.If you find above information helpful or it has resolved your issue...please mark it accordingly :)

Mithun Sanghavi's picture

Hello,

Uninstall / Reinstall SEPM server.

Use Disaster Recovery procedure to restore the Server Key Private Backup in the Management Server Configuration Wizard, then restore database by

Symantec Endpoint Protection 12.1: Best Practices for Disaster Recovery with the Symantec Endpoint Protection Manager 

http://www.symantec.com/business/support/index?page=content&id=TECH160736

Reference:

SEPM Embedded Database Service will not stay Started. 

http://www.symantec.com/docs/TECH173988

Hope that helps!!

Mithun Sanghavi
Senior Consultant
MIM | MCSA | MCTS | STS | SSE | SSE+ | ITIL v3

Don't forget to mark your thread as 'SOLVED' with the answer that best helped you.

Mohan Babu's picture

Any update on this...

Mohan Babu

moglie20@gmail.com

+91 9884382160

Your satisfaction is very important to us.If you find above information helpful or it has resolved your issue...please mark it accordingly :)

Bulbous's picture

How am I supposed to determine what was a "known good" backup of the database? It was functioning/operational before the attempted migration and showed no signs of corruption.

I can't start guessing - it would be faster to blow away and recreate. Unless someone has a suggestion as to how I can tell if the database is corrupt or not.

Mohan Babu's picture

How to use the Database Validation tool (DBValidator.bat) for Symantec Endpoint Protection Manager

http://www.symantec.com/docs/HOWTO39461

 
 
If you encounter a problem with your Symantec Endpoint Protection Manager (SEPM) database, Symantec Support may ask you to run the Database Validation tool to assist in diagnosing the problem.

Mohan Babu

moglie20@gmail.com

+91 9884382160

Your satisfaction is very important to us.If you find above information helpful or it has resolved your issue...please mark it accordingly :)

Mohan Babu's picture

Any update on this

Mohan Babu

moglie20@gmail.com

+91 9884382160

Your satisfaction is very important to us.If you find above information helpful or it has resolved your issue...please mark it accordingly :)

Bulbous's picture

That user had a different error message.

There was no resolution to this problem. I ended up blowing away the database and creating a new one.