Solved: Unable to initialize and start system: Failed to i...

JK_10565232 · ‎Mar 20, 2023

Hello,

I'm having trouble resuming TWX 9.3. While running, I couldn't save changes to mashups. The message was (unfortunately I don't have Application Logs anymore) that I can't save changes to the database.

I restarted Tomcat and can't open ThingWorx again.

How to deal with this bug?

2023-03-20 10:24:38.863+0000 [L: INFO] [O: c.t.s.ThingWorxServer] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] OS: Windows Server 2022
2023-03-20 10:24:38.863+0000 [L: INFO] [O: c.t.s.ThingWorxServer] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] OS arch: amd64
2023-03-20 10:24:38.863+0000 [L: INFO] [O: c.t.s.ThingWorxServer] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] OS version: 10.0
2023-03-20 10:24:38.863+0000 [L: INFO] [O: c.t.s.ThingWorxServer] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] Total Processors: 4
2023-03-20 10:24:38.863+0000 [L: INFO] [O: c.t.s.ThingWorxServer] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] Default encoding: UTF-8
2023-03-20 10:24:38.863+0000 [L: INFO] [O: c.t.s.ThingWorxServer] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] JAVA vendor: Oracle Corporation
2023-03-20 10:24:38.863+0000 [L: INFO] [O: c.t.s.ThingWorxServer] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] JAVA version: 11.0.17
2023-03-20 10:24:38.863+0000 [L: INFO] [O: c.t.s.ThingWorxServer] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] JAVA install location: D:\Program Files\Java\jdk-11.0.17
2023-03-20 10:24:38.863+0000 [L: INFO] [O: c.t.s.ThingWorxServer] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] JVM Max Memory: 4096 (MB)
2023-03-20 10:24:38.863+0000 [L: INFO] [O: c.t.s.ThingWorxServer] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] ========================================
2023-03-20 10:24:38.863+0000 [L: INFO] [O: c.t.s.ThingWorxServer] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] WebApp starting...
2023-03-20 10:24:39.660+0000 [L: INFO] [O: c.t.s.ThingWorxPersistenceHandler] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] Default Persistence Provider Name = ThingworxPersistenceProvider
2023-03-20 10:24:39.660+0000 [L: INFO] [O: c.t.s.ThingWorxPersistenceHandler] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] Default Persistence Provider Package Name = MssqlPersistenceProviderPackage
2023-03-20 10:24:39.674+0000 [L: INFO] [O: c.t.p.m.MssqlDatasource] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] Reading configuration from configTableCol
2023-03-20 10:24:39.972+0000 [L: INFO] [O: c.t.p.m.MssqlDatasource] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] INITIALIZED network settings on datasource - networkTimeout=900000 milliseconds, networkTimeoutExecutorThreads=10 
2023-03-20 10:24:40.457+0000 [L: INFO] [O: c.t.s.ThingWorxServer] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] Datastore database...INITIALIZED
2023-03-20 10:24:40.457+0000 [L: INFO] [O: c.t.s.ThingWorxServer] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] Server Mode is STANDALONE
2023-03-20 10:24:40.504+0000 [L: WARN] [O: c.t.s.s.l.LicenseID] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] License ID is f9d6e874-c265-4243-a99d-5684bf18567d and Installation Date is 2023-03-20T10:06:07.506Z.
2023-03-20 10:24:40.535+0000 [L: INFO] [O: c.t.s.ThingWorxServer] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] >>>>>>>>>> Start loading model in: 
2023-03-20 10:24:40.535+0000 [L: INFO] [O: c.t.s.ChangeWatcher] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] Model change watcher will not run, not in cluster mode
2023-03-20 10:24:40.738+0000 [L: INFO] [O: c.t.s.ThingWorxServer] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] Managers...INITIALIZED
2023-03-20 10:24:40.754+0000 [L: INFO] [O: c.t.s.ThingWorxServer] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] Database initialization started...
2023-03-20 10:24:40.941+0000 [L: INFO] [O: c.t.s.ThingWorxServer] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] Initial MetricsUser password was not found in the Platform Settings, skipping user creation.
2023-03-20 10:24:40.957+0000 [L: INFO] [O: c.t.s.ThingWorxServer] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] Database initialization complete
2023-03-20 10:24:40.957+0000 [L: INFO] [O: c.t.s.ThingWorxServer] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] Load model with ContextType: NONE
2023-03-20 10:24:40.957+0000 [L: INFO] [O: c.t.s.ThingWorxServer] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] Initialize...
2023-03-20 10:24:40.972+0000 [L: INFO] [O: c.t.s.ThingWorxServer] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] Subscriptions Store initialized.
2023-03-20 10:24:40.972+0000 [L: INFO] [O: c.t.s.ThingWorxServer] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] Initializing Collections...
2023-03-20 10:24:40.972+0000 [L: INFO] [O: c.t.s.m.BaseManager] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] Initializing ModelTags collection. 
2023-03-20 10:24:41.082+0000 [L: INFO] [O: c.t.s.m.BaseManager] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] Initializing DataTags collection. 
2023-03-20 10:24:41.082+0000 [L: INFO] [O: c.t.s.m.BaseManager] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] Initializing Groups collection. 
2023-03-20 10:24:41.113+0000 [L: INFO] [O: c.t.s.m.BaseManager] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] Initializing Users collection. 
2023-03-20 10:24:41.160+0000 [L: INFO] [O: c.t.s.m.BaseManager] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] Initializing Organizations collection. 
2023-03-20 10:24:41.176+0000 [L: INFO] [O: c.t.s.m.BaseManager] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] Initializing Logs collection. 
2023-03-20 10:24:41.519+0000 [L: ERROR] [O: c.t.p.d.DocumentModel] [I: ] [U: ] [S: ] [P: ] [T: ForkJoinPool-12-worker-19] Error decoding application key keyId KepServerKey
2023-03-20 10:24:41.941+0000 [L: WARN] [O: c.t.e.RootEntity] [I: ] [U: ] [S: ] [P: ] [T: ForkJoinPool-22-worker-19] Cannot set Project on Entity PTCDefaultProject:Project. Ignoring value.
2023-03-20 10:24:42.722+0000 [L: INFO] [O: c.t.s.ThingWorxServer] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] Initializing Scheduler Engine...
2023-03-20 10:24:42.722+0000 [L: INFO] [O: c.t.s.ThingWorxServer] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] Initializing Entities...
2023-03-20 10:24:43.254+0000 [L: WARN] [O: c.t.c.u.ConfigurationTableUtilities] [I: ] [U: SuperUser] [S: ] [P: ] [T: ForkJoinPool-1-worker-5] ConfigurationTableDefinition not found for table ReportingConfiguration in ThingTemplate IntegrationRuntime so removing the configuration Table!
2023-03-20 10:24:43.254+0000 [L: WARN] [O: c.t.c.u.ConfigurationTableUtilities] [I: ] [U: SuperUser] [S: ] [P: ] [T: ForkJoinPool-1-worker-1] ConfigurationTableDefinition not found for table ReportingConfiguration in ThingTemplate BrowserGateway so removing the configuration Table!
2023-03-20 10:24:43.426+0000 [L: WARN] [O: c.t.e.RootEntity] [I: ] [U: SuperUser] [S: ] [P: ] [T: ForkJoinPool-1-worker-3] Cannot set Project on Entity PTCDefaultProject:Project. Ignoring value.
2023-03-20 10:24:43.879+0000 [L: INFO] [O: c.t.s.ThingWorxServer] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] Cleaning up legacy entities...
2023-03-20 10:24:43.879+0000 [L: INFO] [O: c.t.s.ThingWorxServer] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] Checking default permissions...
2023-03-20 10:24:43.972+0000 [L: ERROR] [O: c.t.p.m.MssqlDataExceptionTranslator] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] Failed to insert Permission: Administrators:Group isPermitted:true Administrators:Group isPermitted:true ComposerUsers:Group isPermitted:true Administrators:Group isPermitted:true Administrators:Group isPermitted:true 
2023-03-20 10:24:43.972+0000 [L: ERROR] [O: c.t.s.ThingWorxServer] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] Failed to insert Permission: Administrators:Group isPermitted:true Administrators:Group isPermitted:true ComposerUsers:Group isPermitted:true Administrators:Group isPermitted:true Administrators:Group isPermitted:true 
2023-03-20 10:24:43.972+0000 [L: ERROR] [O: c.t.s.ThingWorxBootstrapper] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] *** CRITICAL ERROR ON STARTUP: Unable to initialize and start system: Failed to insert Permission: Administrators:Group isPermitted:true Administrators:Group isPermitted:true ComposerUsers:Group isPermitted:true Administrators:Group isPermitted:true Administrators:Group isPermitted:true 
2023-03-20 10:24:43.972+0000 [L: ERROR] [O: c.t.s.ThingWorxBootstrapper] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] *** Web Application STATE is being set to ERROR! ***
2023-03-20 10:24:43.972+0000 [L: INFO] [O: c.t.s.ThingWorxServer] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] >>>>>>> PLATFORM SHUTDOWN START <<<<<<<<<

Best regards,

Jan Kruszewski

JK_10565232 · ‎Mar 21, 2023

I found solution. Database server had set up properties 'no count' = true. It removed update permissions.

Thank you for your answers.

Have a great day,

Jan Kruszewski

View solution in original post

JK_10565232 · ‎Mar 20, 2023

I want to add first error message 'Unable to update mashup: [1.018] Data store unknown error: [Error occurred while accessing the model provider.' Why it appears?

PaiChung · ‎Mar 20, 2023

It seems that perhaps TWX is unable to properly connect to the persistent provider?

Maybe a database corruption?

2023-03-20 10:24:43.972+0000 [L: ERROR] [O: c.t.p.m.MssqlDataExceptionTranslator] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] Failed to insert Permission: Administrators:Group isPermitted:true Administrators:Group isPermitted:true ComposerUsers:Group isPermitted:true Administrators:Group isPermitted:true Administrators:Group isPermitted:true 
2023-03-20 10:24:43.972+0000 [L: ERROR] [O: c.t.s.ThingWorxServer] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] Failed to insert Permission: Administrators:Group isPermitted:true Administrators:Group isPermitted:true ComposerUsers:Group isPermitted:true Administrators:Group isPermitted:true Administrators:Group isPermitted:true 
2023-03-20 10:24:43.972+0000 [L: ERROR] [O: c.t.s.ThingWorxBootstrapper] [I: ] [U: SuperUser] [S: ] [P: ] [T: main] *** CRITICAL ERROR ON STARTUP: Unable to initialize and start system: Failed to insert Permission: Administrators:Group isPermitted:true Administrators:Group isPermitted:true ComposerUsers:Group isPermitted:true Administrators:Group isPermitted:true Administrators:Group isPermitted:true

JK_10565232 · ‎Mar 20, 2023

Hi PaiChung,

Thank you for your response,

I checked the database and it worked without any problem from SQL Server Management Studio. The ThingWorx platform is working without any problems today it was unable to assign administrator rights to the group. Does this happen often in ThingWorx 9.3? I uninstalled 9.3, installed 9.1 but I still get an error about the problem with saving changes when editing Mashups.

JK_10565232 · ‎Mar 21, 2023

After investigation I saw i can create mashup/thing I can delete it but I cannot update it... Have you ever meet this issues?

PaiChung · ‎Mar 21, 2023

You are basically having some permissions issue, not too sure though how you would fix it.

But your user seems to have 'Create' 'Modify' rights but not 'Full' as the creator or 'Delete'

Since it gave you that strange initial error, even assigning Delete permission to your user/user group might not fix that issue.

JK_10565232 · ‎Mar 21, 2023

I found solution. Database server had set up properties 'no count' = true. It removed update permissions.

Thank you for your answers.

Have a great day,

Jan Kruszewski

slangley · ‎Mar 27, 2023

Hi @JK_10565232.

One thing I noticed from your screenshot is that you're running on Windows Server 2022. The version of the O/S supported for ThingWorx 9.3 is Windows Server 2019. The latest version of SQL Server supported is MS SQL Server 2019. By not adhering to the requirements, you may experience unexpected issues with ThingWorx.

You didn't indicate the full release of ThingWorx you're running, but here is a link to the Server Requirements for ThingWorx 9.3.7--the latest release available.

Regards.

--Sharon

JK_10565232 · ‎Mar 30, 2023

Hi Sharon,

Thank you for your response.

I have one question. This lines means than I cannot write my own extension in Java?

Best regards,

Jan

slangley · ‎Mar 30, 2023

Hi @JK_10565232.

I think there may be something wrong with the Product Calendar. I am following up to clarify.

Regards.

--Sharon

slangley · ‎May 01, 2023

Hi @JK_10565232.

The product calendar has been corrected. The latest supported release of the java SDK is 7.0.1.

Regards.

--Sharon