Sponaneous restart of TM1 server

ioscat · Post by **ioscat** » Fri Nov 16, 2012 9:50 am

Hello, TM1 Community!
We moved our tm1 server to new machine. And got headache of spontaneous restart of TM1 server. Has anybody any ideas?

TM1 cfg

Code: Select all

GroupsCreationLimit=100

[TM1S]
AllowSeparateNandCRules=T
ReevaluateConditionalFeeders=T
ServerLogging=F
SecurityPackageName=Kerberos
IntegratedSecurityMode=5
UseSSL=F
ServerName=Budget
DataBaseDirectory=D:\TM1Data\Budget\DATA
LoggingDirectory=D:\TM1Data\Budget\LOGS
AdminHost=localhost
PortNumber=10000
Language=ENG
SaveTime=
DownTime=
ProgressMessage=True
AuditLogOn=F
AuditLogMaxFileSize= 50 MB
AuditLogUpdateInterval=60
PersistentFeeders=F
ParallelInteraction=T
ServerCAMURI=http://********************************************************************************
ClientCAMURI=https://********************************************************************************

ClientPingCAMPassport=110
CAMPortalVariableFile = portal\variables_TM1.xml

#IdleConnectionTimeOutSeconds=7200
DefaultMeasureDimension=T

#Optional CAM parameters
#CAMSSLCertificate=
#CAMSSLCertRevList=
#SkipSSLCAMHostCheck=TRUE

TM1Server log

Code: Select all

[color=#888888]8600   [327]   INFO   2012-11-16 08:43:45.124   TM1.Process   Process "}tp_get_user_permissions" run from process "}tp_workflow_enter_node" by user "CAMID("AD:u:17f7d592546878429a462a9402094396")"
8600   [327]   INFO   2012-11-16 08:43:45.124   TM1.Process   Process "}tp_get_log_file_names" run from process "}tp_get_user_permissions" by user "CAMID("AD:u:17f7d592546878429a462a9402094396")"
8600   [327]   INFO   2012-11-16 08:43:45.140   TM1.Process   Процесс "}tp_get_log_file_names":  - выполнение завершено нормально, истекшее время: 0.02 сек.
8600   [327]   INFO   2012-11-16 08:43:45.140   TM1.Process   Процесс "}tp_get_user_permissions":  - выполнение завершено нормально, истекшее время: 0.02 сек.
8600   [327]   INFO   2012-11-16 08:43:45.155   TM1.Process   Процесс "}tp_workflow_enter_node":  - выполнение завершено нормально, истекшее время: 0.05 сек.
5932   [6ac]   INFO   2012-11-16 08:43:45.389   TM1.Process   Process "}tp_initialize_session" executed by user "RTRS/Саваренко Марианна Петровна"
5932   [6ac]   INFO   2012-11-16 08:43:45.405   TM1.Process   Процесс "}tp_initialize_session":  - выполнение завершено нормально, истекшее время: 0.02 сек.
9952   [68f]   ERROR   2012-11-16 08:43:52.191   TM1.Blob   CommitDeferredFileCommand - Create failed: err=5 system_err_code=123
9952   [68f]   ERROR   2012-11-16 08:43:52.191   TM1.Blob   Commit - file operation failure for blob: Budget-F_01_Append.Приложение ПД к БДиР_cc251517-7403-4b44-b8e6-a2584b7a9342_[ЦФО - Бюджет].[927].CAMID("AD:u:3a6b56d10e11cb458f8033e0f7b3adee")
5528   [68b]   INFO   2012-11-16 08:43:53.330   TM1.Process   Process "}tp_workflow_leave_node" executed by user "RTRS/Волкова Мария Юрьевна"
5528   [68b]   INFO   2012-11-16 08:43:53.330   TM1.Process   Process "}tp_get_log_file_names" run from process "}tp_workflow_leave_node" by user "CAMID("AD:u:3a6b56d10e11cb458f8033e0f7b3adee")"
5528   [68b]   INFO   2012-11-16 08:43:53.330   TM1.Process   Процесс "}tp_get_log_file_names":  - выполнение завершено нормально, истекшее время: 0.00 сек.
5528   [68b]   INFO   2012-11-16 08:43:53.330   TM1.Process   Process "}tp_get_application_attributes" run from process "}tp_workflow_leave_node" by user "CAMID("AD:u:3a6b56d10e11cb458f8033e0f7b3adee")"
5528   [68b]   INFO   2012-11-16 08:43:53.330   TM1.Process   Процесс "}tp_get_application_attributes":  - выполнение завершено нормально, истекшее время: 0.00 сек.
5528   [68b]   INFO   2012-11-16 08:43:53.330   TM1.Process   Process "}tp_get_user_permissions" run from process "}tp_workflow_leave_node" by user "CAMID("AD:u:3a6b56d10e11cb458f8033e0f7b3adee")"
5528   [68b]   INFO   2012-11-16 08:43:53.346   TM1.Process   Process "}tp_get_log_file_names" run from process "}tp_get_user_permissions" by user "CAMID("AD:u:3a6b56d10e11cb458f8033e0f7b3adee")"
5528   [68b]   INFO   2012-11-16 08:43:53.346   TM1.Process   Процесс "}tp_get_log_file_names":  - выполнение завершено нормально, истекшее время: 0.00 сек.
5528   [68b]   INFO   2012-11-16 08:43:53.361   TM1.Process   Процесс "}tp_get_user_permissions":  - выполнение завершено нормально, истекшее время: 0.02 сек.
5528   [68b]   INFO   2012-11-16 08:43:53.361   TM1.Process   Процесс "}tp_workflow_leave_node":  - выполнение завершено нормально, истекшее время: 0.03 сек.
5932   [6ac]   INFO   2012-11-16 08:43:53.876   TM1.Process   Process "}tp_workflow_enter_node" executed by user "RTRS/Саваренко Марианна Петровна"
5932   [6ac]   INFO   2012-11-16 08:43:53.876   TM1.Process   Process "}tp_get_log_file_names" run from process "}tp_workflow_enter_node" by user "CAMID("AD:u:a2e5e4b2389f5842a8b07cdf66301021")"
5932   [6ac]   INFO   2012-11-16 08:43:53.876   TM1.Process   Процесс "}tp_get_log_file_names":  - выполнение завершено нормально, истекшее время: 0.00 сек.
5932   [6ac]   INFO   2012-11-16 08:43:53.876   TM1.Process   Process "}tp_get_application_attributes" run from process "}tp_workflow_enter_node" by user "CAMID("AD:u:a2e5e4b2389f5842a8b07cdf66301021")"
5932   [6ac]   INFO   2012-11-16 08:43:53.876   TM1.Process   Процесс "}tp_get_application_attributes":  - выполнение завершено нормально, истекшее время: 0.00 сек.
5932   [6ac]   INFO   2012-11-16 08:43:53.876   TM1.Process   Process "}tp_get_user_permissions" run from process "}tp_workflow_enter_node" by user "CAMID("AD:u:a2e5e4b2389f5842a8b07cdf66301021")"
5932   [6ac]   INFO   2012-11-16 08:43:53.892   TM1.Process   Process "}tp_get_log_file_names" run from process "}tp_get_user_permissions" by user "CAMID("AD:u:a2e5e4b2389f5842a8b07cdf66301021")"
5932   [6ac]   INFO   2012-11-16 08:43:53.892   TM1.Process   Процесс "}tp_get_log_file_names":  - выполнение завершено нормально, истекшее время: 0.00 сек.
5932   [6ac]   INFO   2012-11-16 08:43:53.907   TM1.Process   Процесс "}tp_get_user_permissions":  - выполнение завершено нормально, истекшее время: 0.02 сек.
5932   [6ac]   INFO   2012-11-16 08:43:53.907   TM1.Process   Process "}tp_get_user_permissions" run from process "}tp_workflow_enter_node" by user "CAMID("AD:u:a2e5e4b2389f5842a8b07cdf66301021")"
5932   [6ac]   INFO   2012-11-16 08:43:53.907   TM1.Process   Process "}tp_get_log_file_names" run from process "}tp_get_user_permissions" by user "CAMID("AD:u:a2e5e4b2389f5842a8b07cdf66301021")"
5932   [6ac]   INFO   2012-11-16 08:43:53.923   TM1.Process   Процесс "}tp_get_log_file_names":  - выполнение завершено нормально, истекшее время: 0.00 сек.
5932   [6ac]   INFO   2012-11-16 08:43:53.938   TM1.Process   Процесс "}tp_get_user_permissions":  - выполнение завершено нормально, истекшее время: 0.03 сек.
5932   [6ac]   INFO   2012-11-16 08:43:53.938   TM1.Process   Процесс "}tp_workflow_enter_node":  - выполнение завершено нормально, истекшее время: 0.06 сек.
7024   [2ca]   ERROR   2012-11-16 08:43:58.962   TM1.Blob   CommitDeferredFileCommand - Create failed: err=5 system_err_code=123
7024   [2ca]   ERROR   2012-11-16 08:43:58.962   TM1.Blob   Commit - file operation failure for blob: Budget-FOT.Фонд оплаты труда_cc251517-7403-4b44-b8e6-a2584b7a9342_[ЦФО - Бюджет].[083].CAMID("AD:u:01db827ebf63c742811305686c4f3145")[/color]
724   []   INFO   2012-11-16 08:45:23.781   TM1.Server   Data Directory: d:\tm1data\budget\data
724   []   INFO   2012-11-16 08:45:23.781   TM1.Server   Admin Host: cpm-tm1
724   []   INFO   2012-11-16 08:45:23.781   TM1.Server   Logging Directory: d:\tm1data\budget\logs
724   []   INFO   2012-11-16 08:45:23.781   TM1.Server   Configuration Directory: d:\tm1data\budget\
724   []   INFO   2012-11-16 08:45:23.781   TM1.Server   Raw Store Directory: d:\tm1data\budget\data
724   []   INFO   2012-11-16 08:45:23.781   TM1.Server   Port: 10000
724   []   INFO   2012-11-16 08:45:23.781   TM1.Server   Client Message Port: Dynamic
724   []   INFO   2012-11-16 08:45:23.781   TM1.Server   Client Message Port does not accept Tm1Top connections.
724   []   INFO   2012-11-16 08:45:23.781   TM1.Server   Export Admin Server Certificate: 0
724   []   INFO   2012-11-16 08:45:23.781   TM1.Server   Admin Server Certificate Authority: C:\Cognos\TM1_x64\bin\ssl\applixca.pem
724   []   INFO   2012-11-16 08:45:23.781   TM1.Server   Admin Server SSL Cert ID: tm1adminserver
724   []   INFO   2012-11-16 08:45:23.781   TM1.Server   Admin Server SSL Cert ID: tm1adminserverSSL Mode: 
724   []   INFO   2012-11-16 08:45:23.781   TM1.Server   Security Mode: 
724   []   INFO   2012-11-16 08:45:23.781   TM1.Server   Server CAM URI: http://***************************************************************************************
724   []   INFO   2012-11-16 08:45:23.781   TM1.Server   Client CAM URI: https://***************************************************************************************
724   []   INFO   2012-11-16 08:45:23.781   TM1.Server   Web CAM URI: https://***************************************************************************************
724   []   INFO   2012-11-16 08:45:23.781   TM1.Server   Client Ping CAM Passport: 
724   []   INFO   2012-11-16 08:45:23.781   TM1.Server   Start time: Fri Nov 16 2012     12:45:23 PM
724   []   INFO   2012-11-16 08:45:23.781   TM1.Server    The server will use Parallel Interaction.
724   []   INFO   2012-11-16 08:45:23.781   TM1.Server    Режим потоков сервера - один поток на соединение.
724   []   INFO   2012-11-16 08:45:23.781   TM1.Server    Порт сообщений клиента не принимает соединения Tm1Top.
5640   []   INFO   2012-11-16 08:45:23.781   TM1.Server   Dynamic Client Message Port: 60561
5436   []   INFO   2012-11-16 08:45:23.781   TM1.Server   --------------------Session Start--------------------
5436   []   INFO   2012-11-16 08:45:23.781   TM1.Server   TM1 Build Number:  9.5.20200.22178
5436   []   INFO   2012-11-16 08:45:24.124   TM1.Cube    Завершена загрузка куба Admin_Security_Версии
5436   []   INFO   2012-11-16 08:45:24.124   TM1.Cube    Завершена загрузка куба Admin_Security_Этап согласования мероприятий
5436   []   INFO   2012-11-16 08:45:24.124   TM1.Cube    Завершена загрузка куба Budget-Amort
5436   []   INFO   2012-11-16 08:45:24.124   TM1.Cube    Завершена загрузка куба Budget-DDS_Do_Vzaimorascheta
5436   []   INFO   2012-11-16 08:45:24.124   TM1.Cube    Завершена загрузка куба Budget-DDS_Do_Vzaimorascheta_Kv
5436   []   INFO   2012-11-16 08:45:24.124   TM1.Cube    Завершена загрузка куба Budget-DDS_Grafik_Platezhei-Kv
5436   []   INFO   2012-11-16 08:45:24.124   TM1.Cube    Завершена загрузка куба Budget-DDS_Grafik_Platezhei
5436   []   INFO   2012-11-16 08:45:24.124   TM1.Cube    Завершена загрузка куба Budget-DDS_Grafik_Platezhei_Corr-Kv
5436   []   INFO   2012-11-16 08:45:24.124   TM1.Cube    Завершена загрузка куба Budget-DDS_Grafik_Platezhei_Corr
5436   []   INFO   2012-11-16 08:45:24.124   TM1.Cube    Завершена загрузка куба Budget-DDS_Grafik_Platezhei_Dohodi-Kv
5436   []   INFO   2012-11-16 08:45:24.124   TM1.Cube    Завершена загрузка куба Budget-DDS_Grafik_Platezhei_Dohodi
5436   []   INFO   2012-11-16 08:45:24.124   TM1.Cube    Завершена загрузка куба Budget-DDS_KZ_DZ_po_KV
5436   []   INFO   2012-11-16 08:45:24.124   TM1.Cube    Завершена загрузка куба Budget-DDS_nereal_deb
5436   []   INFO   2012-11-16 08:45:24.124   TM1.Cube    Завершена загрузка куба Budget-DDS_Posle_Vzaimorascheta-Kv
5436   []   INFO   2012-11-16 08:45:24.124   TM1.Cube    Завершена загрузка куба Budget-DDS_Posle_Vzaimorascheta
5436   []   INFO   2012-11-16 08:45:24.139   TM1.Cube    Завершена загрузка куба Budget-DDS_Rasch

qml · Post by **qml** » Fri Nov 16, 2012 10:10 am

It's trying to save a blob file with an illegal colon character (":") in it. I think there has been a discussion recently on the subject of reserved characters in object names being a result of CAM user names.

Edit: Here it is.

ioscat · Post by **ioscat** » Fri Nov 16, 2012 11:34 am

qml wrote:It's trying to save a blob file with an illegal colon character (":") in it. I think there has been a discussion recently on the subject of reserved characters in object names being a result of CAM user names.

Edit: Here it is.

Errm... qml, thanks for idea, we started to search at this issue. But why does it break not for every TM1 BLOB operation? In log file there are several TM1 BLOB errors.

qml · Post by **qml** » Fri Nov 16, 2012 11:52 am

ioscat wrote:why does it break not for every TM1 BLOB operation?

My guess is as good as yours. My theory that I've just come up with is that it puts these files into some sort of queue and when the queue gets too long for the buffer size, it just crashes, because the queue is not managed well due to poor programming. This is pure speculation though.

TM1 Forum

Sponaneous restart of TM1 server

Sponaneous restart of TM1 server

Re: Sponaneous restart of TM1 server

Re: Sponaneous restart of TM1 server

Re: Sponaneous restart of TM1 server