12:14:12.79[1]DEBUG:Start logging... LocalTime 08/27/2015 12:14:12
12:14:13.43[1]DEBUG:Show splash ru ...
12:14:13.90[1]INFO :Start date:27.08.2015 12:14
12:14:13.90[1]INFO :OS=Windows 8  (Microsoft Windows NT 6.2.9200.0) is64Bit=False procCnt=2 .net=4.0.30319.42000 quik=False Culture=ru-RU UI=ru-RU
12:14:14.35[1]INFO :Init object container
12:14:14.38[1]INFO :Load Application settings
12:14:14.38[1]INFO :Load ResourceManager for ru-RU
12:14:14.51[5]DEBUG:Data Sources initialize
12:14:14.54[5]DEBUG:load ds name=123(123) type=TSLab.TextDS.TextDS
12:14:14.55[5]DEBUG:InternalRegistered 123
12:14:14.57[5]DEBUG:load ds name=Finam(Финам) type=TSLab.DataSource.Transaq.TransaqDSNew
12:14:14.62[5]DEBUG:candlekinds not get on connecting. Use default values.
12:14:14.74[5]DEBUG:Scheduler for Финам: enabled=False defined=False. Nearest work=Not defined
12:14:14.74[5]DEBUG:Scheduler for Финам InternalStart:False
12:14:14.74[5]DEBUG:Scheduler for Финам InternalStart:False
12:14:17.21[1]DEBUG:ProviderManager:Init AddDS 123
12:14:18.68[6]INFO :302:Info:ApplicationHandlers:(Module:Handlers):Загружена dll 'C:\Users\Matey\AppData\Local\TSLab\TSLab12\Handlers\spread.dll' с 1 обработчиками.
12:14:18.71[5]INFO :Финам. Convert 0 transactions.
12:14:18.77[6]DEBUG:Name='Odbc Data Provider' Descr='.Net Framework Data Provider for Odbc' : 'System.Data.Odbc' : 'System.Data.Odbc.OdbcFactory, System.Data, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089'
12:14:18.77[6]DEBUG:Name='OleDb Data Provider' Descr='.Net Framework Data Provider for OleDb' : 'System.Data.OleDb' : 'System.Data.OleDb.OleDbFactory, System.Data, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089'
12:14:18.77[6]DEBUG:Name='OracleClient Data Provider' Descr='.Net Framework Data Provider for Oracle' : 'System.Data.OracleClient' : 'System.Data.OracleClient.OracleClientFactory, System.Data.OracleClient, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089'
12:14:18.77[6]DEBUG:Name='SqlClient Data Provider' Descr='.Net Framework Data Provider for SqlServer' : 'System.Data.SqlClient' : 'System.Data.SqlClient.SqlClientFactory, System.Data, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089'
12:14:18.77[6]DEBUG:Name='Microsoft SQL Server Compact Data Provider' Descr='.NET Framework Data Provider for Microsoft SQL Server Compact' : 'System.Data.SqlServerCe.4.0' : 'System.Data.SqlServerCe.SqlCeProviderFactory, System.Data.SqlServerCe, Version=4.0.0.1, Culture=neutral, PublicKeyToken=89845dcd8080cc91'
12:14:18.79[5]INFO :Финам. Convert 0 trades.
12:14:18.85[5]INFO :Финам. Convert 0 orders.
12:14:19.29[6]INFO :127 handlers found.
12:14:20.30[5]DEBUG:[Finam] Loaded from cache orders=0 trades=0
12:14:20.43[1]DEBUG:ProviderManager:Init AddDS Finam
12:14:20.43[5]DEBUG:InternalRegistered Finam
12:14:21.15[1]DEBUG:MainWindow OnInitialized
12:14:21.57[1]DEBUG:Start load plug-ins
12:14:21.87[1]DEBUG:Loaded plug-in PretradeManager
12:14:21.87[1]DEBUG:Loaded plug-ins for 292 ms
12:14:21.95[1]DEBUG:MainWindow OnApplyTemplate
12:14:24.59[1]DEBUG:MainWindow Loaded.Version=1.2.19.0
12:14:25.01[1]DEBUG:ProviderManager:Init AddDS 123
12:14:25.01[1]DEBUG:ProviderManager:Init AddDS Finam
12:14:27.23[1]DEBUG:ProviderManager:AddDS Finam
12:14:27.32[1]DEBUG:ProviderManager:Init AddDS 123
12:14:27.32[1]DEBUG:ProviderManager:Init AddDS Finam
12:14:27.34[1]DEBUG:After ds loaded
12:14:27.39[1]DEBUG:Try to load workspace
12:14:27.71[1]ERROR:Loading error
System.IO.IOException: Файл 'C:\Users\Matey\Documents\TSLab 1.2\Demo_Finam.tlw' не найден
   в TSLab.MainWindow.LoadInternal(String path)
   в TSLab.MainWindow.LoadOnStartup(String path)
12:14:27.71[1]INFO :21:Error:ApplicationLoadSave:(Module:LoadSave):Ошибка загрузки конфигурации:Файл 'C:\Users\Matey\Documents\TSLab 1.2\Demo_Finam.tlw' не найден
12:14:27.72[1]DEBUG:Cancel closing=False
12:14:27.82[1]DEBUG:Scheduler for Финам InternalStart:True
12:14:27.82[1]DEBUG:Scheduler for Финам InternalStart:True
12:14:27.82[1]DEBUG:Scheduler for Финам initialized:True
12:14:27.82[1]DEBUG:Start RealtimeScriptManager
12:14:28.30[1]DEBUG:Start initialization finished
12:14:28.48[5]DEBUG:Start updating. Try to update manifest file.
12:14:28.51[5]DEBUG:Request url http://www.tslab.ru/files/update/manifest12.xml?ver=1.2.19.0&days=0&compid=6a23ccf8-155f-4c20-****&appid&os=6.2.9200.0&pcount=0&lang=ru-RU;
12:14:41.24[5]WARN :Cannot load manifest from http://www.tslab.ru/files/update/
12:14:41.24[5]INFO :11:Warning:ApplicationUpdate:(Module:Update):Сервис обновлений: Ошибка скачивания манифеста с http://www.tslab.ru/files/update/. Будет использован адрес http://www.tslab.ru/files/update/.
12:14:41.24[5]DEBUG:Request url http://www.tslab.ru/files/update/manifest12.xml?ver=1.2.19.0&days=0&compid=6a23ccf8-155f-4c20-****&appid&os=6.2.9200.0&pcount=0&lang=ru-RU;
12:14:53.45[5]ERROR:Update failed
System.Exception: Невозможно загрузить файл манифеста
   в TSLab.Updater.AppUpdater.UpdateStatus(Boolean considerSkippedVersions)
   в TSLab.MainWindow.UpdateStatus(Boolean considerSkippedVersions)
12:14:53.48[5]INFO :13:Warning:ApplicationUpdate:(Module:Update)::Невозможно загрузить файл манифеста
12:15:10.65[1]DEBUG:Cancel closing=False
12:15:10.65[1]ERROR:Loading error
System.IO.IOException: Файл 'C:\Users\Matey\Documents\TSLab 1.2\Demo_Finam.tlw' не найден
   в TSLab.MainWindow.LoadInternal(String path)
   в TSLab.MainWindow.LoadInternalWithBackup(String path)
   в TSLab.MainWindow.Load(String path, Boolean fromRecentList)
12:15:13.20[1]DEBUG:Cancel closing=False
12:15:25.55[1]DEBUG:Cancel closing=False
12:15:25.55[1]DEBUG:try to load workspace=C:\Users\Matey\Documents\TSLab 1.2\Demo_Finam.tlw2
12:15:26.77[1]DEBUG:<------------0 items is ready to initalization after load
12:15:26.77[7]DEBUG:<------------m_starting false
12:15:28.27[1]DEBUG:Attach from QuotationViewModel
12:15:28.30[1]DEBUG:Attach from QuotationViewModel
12:15:28.30[1]DEBUG:Attach from QuotationViewModel
12:15:28.30[1]DEBUG:Attach from QuotationViewModel
12:15:28.30[1]DEBUG:Attach from QuotationViewModel
12:15:28.32[1]DEBUG:Attach from QuotationViewModel
12:15:28.32[1]DEBUG:Attach from QuotationViewModel
12:15:28.32[1]DEBUG:Attach from QuotationViewModel
12:15:28.32[1]DEBUG:Attach from QuotationViewModel
12:15:28.32[1]DEBUG:Attach from QuotationViewModel
12:15:28.32[1]DEBUG:Attach from QuotationViewModel
12:15:28.32[1]DEBUG:Attach from QuotationViewModel
12:15:28.32[1]DEBUG:Attach from QuotationViewModel
12:15:28.32[1]DEBUG:Attach from QuotationViewModel
12:15:28.62[1]DEBUG:Attach from SecurityController
12:15:28.79[1]DEBUG:Attach from SecurityCollectionController
12:15:31.48[7]DEBUG:State 2. Initialization is started.
12:15:31.52[7]DEBUG:GetMinuteBars for SBER_1 interval=1 from=07/14/2014 00:00:00 to 08/29/2015 00:02:00
12:15:31.62[7]DEBUG:Load 8734 bars from cache for SBER:ММВБ (1M). Last is 12/08/2014 14:29:00
12:15:31.65[7]DEBUG:GetMinuteBars end for SBER_1 interval=1 from=07/14/2014 00:00:00 to 08/29/2015 00:02:00
12:15:31.68[7]DEBUG:State 2. Last cached date 12/08/2014 14:29:00 for SBER:ММВБ 1M
12:15:31.69[7]DEBUG:State 2, Adding 0 trades to SBER:ММВБ. startTime=08/24/2015 00:00:00 endTime=08/29/2015 00:02:00
12:15:31.76[7]DEBUG:State 2, UpdateData finished to SBER:ММВБ. bars=8734 Last=12/08/2014 14:29:00
12:15:31.76[7]DEBUG:State 2. Attach update to 'SBER:ММВБ'
12:15:31.77[7]DEBUG:Attach from State
12:15:32.32[10]DEBUG:State 4. Initialization is started.
12:15:32.32[10]DEBUG:GetMinuteBars for SBER_1 interval=60 from=05/15/2014 00:00:00 to 08/29/2015 02:00:00
12:15:32.37[10]DEBUG:Load 4908 bars from cache for SBER:ММВБ (15M). Last is 12/08/2014 14:15:00
12:15:32.38[10]DEBUG:GetMinuteBars end for SBER_1 interval=60 from=05/15/2014 00:00:00 to 08/29/2015 02:00:00
12:15:32.38[10]DEBUG:State 4. Last cached date 12/08/2014 14:00:00 for SBER:ММВБ 60M
12:15:32.38[10]DEBUG:State 4, Adding 0 trades to SBER:ММВБ. startTime=08/24/2015 00:00:00 endTime=08/29/2015 02:00:00
12:15:32.40[10]DEBUG:State 4. Make cache SBER:ММВБ bars=1264, removelast=False, date=14:00:00.00, server=10:15:32.38(10:15:32.38)
12:15:32.40[10]DEBUG:State 4, UpdateData finished to SBER:ММВБ. bars=1264 Last=12/08/2014 14:00:00
12:15:32.40[10]DEBUG:State 4. Attach update to 'SBER:ММВБ'
12:15:32.40[10]DEBUG:Attach from State
12:15:34.18[1]DEBUG:Attach from SecurityController
12:15:34.19[1]DEBUG:Attach from SecurityCollectionController
12:15:34.48[7]DEBUG:State 2. Initialization is stopped.
12:15:34.93[10]DEBUG:State 4. Initialization is stopped.
12:15:35.19[7]DEBUG:State 6. Initialization is started.
12:15:35.19[7]DEBUG:GetMinuteBars for GAZP_1 interval=1 from=07/14/2014 00:00:00 to 08/29/2015 00:02:00
12:15:35.32[7]DEBUG:Load 8519 bars from cache for GAZP:ММВБ (1M). Last is 12/08/2014 14:29:00
12:15:35.32[7]DEBUG:GetMinuteBars end for GAZP_1 interval=1 from=07/14/2014 00:00:00 to 08/29/2015 00:02:00
12:15:35.32[7]DEBUG:State 6. Last cached date 12/08/2014 14:29:00 for GAZP:ММВБ 1M
12:15:35.32[7]DEBUG:State 6, Adding 0 trades to GAZP:ММВБ. startTime=08/24/2015 00:00:00 endTime=08/29/2015 00:02:00
12:15:35.32[7]DEBUG:State 6, UpdateData finished to GAZP:ММВБ. bars=8519 Last=12/08/2014 14:29:00
12:15:35.32[7]DEBUG:State 6. Attach update to 'GAZP:ММВБ'
12:15:35.32[7]DEBUG:Attach from State
12:15:35.68[7]DEBUG:State 6. Initialization is stopped.
12:15:35.98[5]DEBUG:State 8. Initialization is started.
12:15:35.98[5]DEBUG:GetMinuteBars for GAZP_1 interval=60 from=05/15/2014 00:00:00 to 08/29/2015 02:00:00
12:15:36.01[5]DEBUG:Load 4780 bars from cache for GAZP:ММВБ (15M). Last is 12/08/2014 14:15:00
12:15:36.01[5]DEBUG:GetMinuteBars end for GAZP_1 interval=60 from=05/15/2014 00:00:00 to 08/29/2015 02:00:00
12:15:36.01[5]DEBUG:State 8. Last cached date 12/08/2014 14:00:00 for GAZP:ММВБ 60M
12:15:36.01[5]DEBUG:State 8, Adding 0 trades to GAZP:ММВБ. startTime=08/24/2015 00:00:00 endTime=08/29/2015 02:00:00
12:15:36.01[5]DEBUG:State 8. Make cache GAZP:ММВБ bars=1232, removelast=False, date=14:00:00.00, server=10:15:36.01(10:15:36.01)
12:15:36.01[5]DEBUG:State 8, UpdateData finished to GAZP:ММВБ. bars=1232 Last=12/08/2014 14:00:00
12:15:36.01[5]DEBUG:State 8. Attach update to 'GAZP:ММВБ'
12:15:36.01[5]DEBUG:Attach from State
12:15:36.59[5]DEBUG:State 8. Initialization is stopped.
12:15:46.44[1]DEBUG:Updated HandlerType: cnt=0 call from TSLab.TemplatesEditor.EditItems.ExternalScriptEditItem.InternalInitialize
TSLab.TemplatesEditor.EditItems.BaseTemplateEditItem.Initialize
TSLab.TemplatesEditor.Model.TemplateItemBlock.Initialize

12:15:46.45[1]DEBUG:Updated HandlerType:quatra1.quatra1Strategy cnt=1 call from TSLab.TemplatesEditor.EditItems.ExternalScriptEditItem.OnModelLoaded
TSLab.TemplatesEditor.EditBlocks.ExternalScriptBlock.OnModelLoaded
TSLab.TemplatesEditor.Model.ScriptDiagramModel.AfterLoad

12:15:46.47[7]DEBUG:State 10. Initialization is started.
12:15:49.03[7]DEBUG:Load 116131 bars for 'SPFB_SI_150101_150803'.
12:15:49.05[7]DEBUG:Return 30752 bars for 'SPFB_SI_150101_150803'.
12:15:49.05[7]DEBUG:State 10. Last cached date 02/27/2015 23:50:00 for SPFB_SI_150101_150803:- 1M
12:15:49.05[7]DEBUG:State 10, Adding 0 trades to SPFB_SI_150101_150803:-. startTime=08/24/2015 00:00:00 endTime=03/01/2015 00:00:00
12:15:49.06[7]DEBUG:State 10, UpdateData finished to SPFB_SI_150101_150803:-. bars=30752 Last=02/27/2015 23:50:00
12:15:49.06[7]DEBUG:State 10. Attach update to 'SPFB_SI_150101_150803:-'
12:15:50.33[7]DEBUG:Short attempt!
12:15:50.34[7]INFO :Short attempt!
12:15:50.34[7]DEBUG:0,8593523
12:15:50.34[7]INFO :0,8593523
12:15:50.34[7]DEBUG:State 10. Initialization is stopped.
12:18:00.57[1]DEBUG:OnClosing enter
12:18:00.58[1]DEBUG:Cancel closing=False
12:18:00.58[1]DEBUG:CheckOnModified:False
12:18:00.58[1]DEBUG:OnClosing run
12:18:00.58[1]DEBUG:Closed tabПозиции
12:18:00.91[1]DEBUG:Closed tabПозиции
12:18:00.91[1]DEBUG:Closed tabКотировки
12:18:01.25[1]DEBUG:Detach from QuotationViewModel
12:18:01.25[1]DEBUG:Detach from QuotationViewModel
12:18:01.25[1]DEBUG:Detach from QuotationViewModel
12:18:01.26[1]DEBUG:Detach from QuotationViewModel
12:18:01.26[1]DEBUG:Detach from QuotationViewModel
12:18:01.26[1]DEBUG:Detach from QuotationViewModel
12:18:01.26[1]DEBUG:Detach from QuotationViewModel
12:18:01.26[1]DEBUG:Detach from QuotationViewModel
12:18:01.26[1]DEBUG:Detach from QuotationViewModel
12:18:01.26[1]DEBUG:Detach from QuotationViewModel
12:18:01.26[1]DEBUG:Detach from QuotationViewModel
12:18:01.26[1]DEBUG:Detach from QuotationViewModel
12:18:01.26[1]DEBUG:Detach from QuotationViewModel
12:18:01.26[1]DEBUG:Detach from QuotationViewModel
12:18:01.95[1]DEBUG:State 10. Detach update to 'SPFB_SI_150101_150803:-'
12:18:01.96[1]DEBUG:Closed tabКотировки
12:18:01.96[1]DEBUG:Closed tabSBER
12:18:01.97[1]DEBUG:Detach from BaseController
12:18:02.00[1]DEBUG:Detach from BaseController
12:18:02.02[1]DEBUG:State 2. Detach update to 'SBER:ММВБ'
12:18:02.02[1]DEBUG:Detach from State
12:18:02.02[1]DEBUG:State 4. Detach update to 'SBER:ММВБ'
12:18:02.02[1]DEBUG:Detach from State
12:18:02.03[1]DEBUG:Closed tabSBER
12:18:02.03[1]DEBUG:Closed tabGAZP
12:18:02.03[1]DEBUG:Detach from BaseController
12:18:02.06[1]DEBUG:Detach from BaseController
12:18:02.09[1]DEBUG:State 6. Detach update to 'GAZP:ММВБ'
12:18:02.09[1]DEBUG:Detach from State
12:18:02.09[1]DEBUG:State 8. Detach update to 'GAZP:ММВБ'
12:18:02.09[1]DEBUG:Detach from State
12:18:02.09[1]DEBUG:Closed tabGAZP
12:18:02.09[1]DEBUG:OnClosing end
12:18:02.18[1]DEBUG:OnExit
12:18:02.18[1]DEBUG:ProviderManager:RemoveDS 123
12:18:02.19[1]DEBUG:ProviderManager:RemoveDS Finam
12:18:02.24[1]DEBUG:Begin saving trades 'FinamCacheTrades'...
12:18:02.24[1]DEBUG:End saving trades 'FinamCacheTrades'.
12:18:02.42[1]DEBUG:OnExit done