Server stürzt ab wenn Client während dem Import lokaler Medienquellen beendet wird (1 Viewer)

rico123

MP Donator
  • Premium Supporter
  • January 1, 2015
    78
    15
    Home Country
    Germany Germany
    Wenn der Client gerade Importieren lokaler Medienquellen ist und ich diesen beende (ab und zu will ich auch mal was anderes außer TV und Video etc.) dann stürzt der Server ab. Bei mir läuft MP2.1 in einer getrennten Client-Server Umgebung. Logs im Anhang.

    Grüße, Rico.
     

    HTPCSourcer

    Retired Team Member
  • Premium Supporter
  • May 16, 2008
    11,418
    2,335
    Home Country
    Germany Germany
    Das Log gibt nichts her, es endet einfach. Kannst du mal die Ereignisanzeige auf dem Server prüfen, was dort ausgeworfen worden ist?
     

    rico123

    MP Donator
  • Premium Supporter
  • January 1, 2015
    78
    15
    Home Country
    Germany Germany
    Hab was gefunden was auf den letzten Absturz passt:
    XML:
    Protokollname: Application
    Quelle:        Application Error
    Datum:         11.05.2017 17:55:07
    Ereignis-ID:   1000
    Aufgabenkategorie:(100)
    Ebene:         Fehler
    Schlüsselwörter:Klassisch
    Benutzer:      Nicht zutreffend
    Computer:      TV-Server
    Beschreibung:
    Name der fehlerhaften Anwendung: MP2-Server.exe, Version: 2.1.1705.10177, Zeitstempel: 0x5908d2e4
    Name des fehlerhaften Moduls: KERNELBASE.dll, Version: 10.0.14393.1198, Zeitstempel: 0x5902845a
    Ausnahmecode: 0xe0434352
    Fehleroffset: 0x000da9f2
    ID des fehlerhaften Prozesses: 0xeb0
    Startzeit der fehlerhaften Anwendung: 0x01d2ca3663e1c2fe
    Pfad der fehlerhaften Anwendung: C:\Program Files (x86)\Team MediaPortal\MP2-Server\MP2-Server.exe
    Pfad des fehlerhaften Moduls: C:\Windows\System32\KERNELBASE.dll
    Berichtskennung: dc370ad8-ee07-497b-b75a-aba42c0db4b7
    Vollständiger Name des fehlerhaften Pakets:
    Anwendungs-ID, die relativ zum fehlerhaften Paket ist:
    Ereignis-XML:
    <Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
      <System>
        <Provider Name="Application Error" />
        <EventID Qualifiers="0">1000</EventID>
        <Level>2</Level>
        <Task>100</Task>
        <Keywords>0x80000000000000</Keywords>
        <TimeCreated SystemTime="2017-05-11T15:55:07.349008200Z" />
        <EventRecordID>4965</EventRecordID>
        <Channel>Application</Channel>
        <Computer>TV-Server</Computer>
        <Security />
      </System>
      <EventData>
        <Data>MP2-Server.exe</Data>
        <Data>2.1.1705.10177</Data>
        <Data>5908d2e4</Data>
        <Data>KERNELBASE.dll</Data>
        <Data>10.0.14393.1198</Data>
        <Data>5902845a</Data>
        <Data>e0434352</Data>
        <Data>000da9f2</Data>
        <Data>eb0</Data>
        <Data>01d2ca3663e1c2fe</Data>
        <Data>C:\Program Files (x86)\Team MediaPortal\MP2-Server\MP2-Server.exe</Data>
        <Data>C:\Windows\System32\KERNELBASE.dll</Data>
        <Data>dc370ad8-ee07-497b-b75a-aba42c0db4b7</Data>
        <Data>
        </Data>
        <Data>
        </Data>
      </EventData>
    </Event>
    XML:
    Protokollname: Application
    Quelle:        .NET Runtime
    Datum:         11.05.2017 17:55:07
    Ereignis-ID:   1026
    Aufgabenkategorie:Keine
    Ebene:         Fehler
    Schlüsselwörter:Klassisch
    Benutzer:      Nicht zutreffend
    Computer:      TV-Server
    Beschreibung:
    Anwendung: MP2-Server.exe
    Frameworkversion: v4.0.30319
    Beschreibung: Der Prozess wurde aufgrund einer unbehandelten Ausnahme beendet.
    Ausnahmeinformationen: System.Data.SQLite.SQLiteException
       bei System.Data.SQLite.SQLite3.Prepare(System.Data.SQLite.SQLiteConnection, System.String, System.Data.SQLite.SQLiteStatement, UInt32, System.String ByRef)
       bei System.Data.SQLite.SQLiteCommand.BuildNextCommand()
       bei System.Data.SQLite.SQLiteCommand.GetStatement(Int32)
       bei System.Data.SQLite.SQLiteDataReader.NextResult()
       bei System.Data.SQLite.SQLiteDataReader..ctor(System.Data.SQLite.SQLiteCommand, System.Data.CommandBehavior)
       bei System.Data.SQLite.SQLiteCommand.ExecuteReader(System.Data.CommandBehavior)
       bei System.Data.SQLite.SQLiteCommand.ExecuteNonQuery(System.Data.CommandBehavior)
       bei System.Data.SQLite.SQLiteCommand.ExecuteNonQuery()
       bei System.Data.SQLite.SQLiteConnection.Open()
       bei Gentle.Provider.SQLite.SQLiteProvider.GetConnection()
    
    Ausnahmeinformationen: Gentle.Common.GentleException
       bei Gentle.Common.Check.FailWith(Gentle.Common.Severity, Gentle.Common.Error, System.Exception, System.String)
       bei Gentle.Common.Check.Fail(System.Exception, Gentle.Common.Error, System.Object[])
       bei Gentle.Provider.SQLite.SQLiteProvider.GetConnection()
       bei Gentle.Framework.PersistenceBroker.Execute(Gentle.Framework.SqlStatement, System.Data.IDbConnection, System.Data.IDbTransaction)
       bei TvDatabase.TvBusinessLayer.GetSetting(System.String, System.String)
       bei TvEngine.PowerScheduler.PowerScheduler.LoadSettings()
       bei TvEngine.PowerScheduler.PowerScheduler.StandbyWakeupThread()
       bei System.Threading.ThreadHelper.ThreadStart_Context(System.Object)
       bei System.Threading.ExecutionContext.RunInternal(System.Threading.ExecutionContext, System.Threading.ContextCallback, System.Object, Boolean)
       bei System.Threading.ExecutionContext.Run(System.Threading.ExecutionContext, System.Threading.ContextCallback, System.Object, Boolean)
       bei System.Threading.ExecutionContext.Run(System.Threading.ExecutionContext, System.Threading.ContextCallback, System.Object)
       bei System.Threading.ThreadHelper.ThreadStart()
    
    
    Ereignis-XML:
    <Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
      <System>
        <Provider Name=".NET Runtime" />
        <EventID Qualifiers="0">1026</EventID>
        <Level>2</Level>
        <Task>0</Task>
        <Keywords>0x80000000000000</Keywords>
        <TimeCreated SystemTime="2017-05-11T15:55:07.048711700Z" />
        <EventRecordID>4964</EventRecordID>
        <Channel>Application</Channel>
        <Computer>TV-Server</Computer>
        <Security />
      </System>
      <EventData>
        <Data>Anwendung: MP2-Server.exe
    Frameworkversion: v4.0.30319
    Beschreibung: Der Prozess wurde aufgrund einer unbehandelten Ausnahme beendet.
    Ausnahmeinformationen: System.Data.SQLite.SQLiteException
       bei System.Data.SQLite.SQLite3.Prepare(System.Data.SQLite.SQLiteConnection, System.String, System.Data.SQLite.SQLiteStatement, UInt32, System.String ByRef)
       bei System.Data.SQLite.SQLiteCommand.BuildNextCommand()
       bei System.Data.SQLite.SQLiteCommand.GetStatement(Int32)
       bei System.Data.SQLite.SQLiteDataReader.NextResult()
       bei System.Data.SQLite.SQLiteDataReader..ctor(System.Data.SQLite.SQLiteCommand, System.Data.CommandBehavior)
       bei System.Data.SQLite.SQLiteCommand.ExecuteReader(System.Data.CommandBehavior)
       bei System.Data.SQLite.SQLiteCommand.ExecuteNonQuery(System.Data.CommandBehavior)
       bei System.Data.SQLite.SQLiteCommand.ExecuteNonQuery()
       bei System.Data.SQLite.SQLiteConnection.Open()
       bei Gentle.Provider.SQLite.SQLiteProvider.GetConnection()
    
    Ausnahmeinformationen: Gentle.Common.GentleException
       bei Gentle.Common.Check.FailWith(Gentle.Common.Severity, Gentle.Common.Error, System.Exception, System.String)
       bei Gentle.Common.Check.Fail(System.Exception, Gentle.Common.Error, System.Object[])
       bei Gentle.Provider.SQLite.SQLiteProvider.GetConnection()
       bei Gentle.Framework.PersistenceBroker.Execute(Gentle.Framework.SqlStatement, System.Data.IDbConnection, System.Data.IDbTransaction)
       bei TvDatabase.TvBusinessLayer.GetSetting(System.String, System.String)
       bei TvEngine.PowerScheduler.PowerScheduler.LoadSettings()
       bei TvEngine.PowerScheduler.PowerScheduler.StandbyWakeupThread()
       bei System.Threading.ThreadHelper.ThreadStart_Context(System.Object)
       bei System.Threading.ExecutionContext.RunInternal(System.Threading.ExecutionContext, System.Threading.ContextCallback, System.Object, Boolean)
       bei System.Threading.ExecutionContext.Run(System.Threading.ExecutionContext, System.Threading.ContextCallback, System.Object, Boolean)
       bei System.Threading.ExecutionContext.Run(System.Threading.ExecutionContext, System.Threading.ContextCallback, System.Object)
       bei System.Threading.ThreadHelper.ThreadStart()
    
    </Data>
      </EventData>
    </Event>
    Hoffe das hilft weiter...
    Gibt es eine Möglichkeit den Server vom Client aus neu zu starten wenn er abgeschossen wurde? Ist etwas mühsam immer über Remote auf den Server zu gehen usw...

    Grüße.
     

    morpheus_xx

    Retired Team Member
  • Team MediaPortal
  • March 24, 2007
    12,073
    7,459
    Home Country
    Germany Germany
    Danke für die Logs! Leider deutet das (auch wieder) auf einen Fehler in SQLite hin, der bereits gemeldet wurde (@aspik @Brownard)

    Wir sind gerade dabei, das Problem zu untersuchen
     

    aspik

    Retired Team Member
  • Team MediaPortal
  • April 14, 2008
    1,322
    586
    Könntest du bitte noch die Logs posten, die zu dem Zeitstempel der SQLiteException passen (11.05 17:55)? Die angehängten Logs enden am 10.05.

    Kannst du den Fehler zu 100% reproduzieren? Jedes mal wenn der Server am importieren ist und du den Client schließt, stürzt der Server ab?

    Gibt es eine Möglichkeit den Server vom Client aus neu zu starten wenn er abgeschossen wurde?
    Du kannst es mal versuchen über die recovery options den Service automatisch neu starten zu lassen.
     

    rico123

    MP Donator
  • Premium Supporter
  • January 1, 2015
    78
    15
    Home Country
    Germany Germany
    Leider kann ich das beschriebene Verhalten im Moment nicht reproduzieren. Aber im Anhang die Logs passend zur Exception.

    Grüße.
     

    aspik

    Retired Team Member
  • Team MediaPortal
  • April 14, 2008
    1,322
    586
    Aber im Anhang die Logs passend zur Exception.
    Die Exception im event Log passierte um 17:55, das Server Log endet aber um 17:53.

    Der ImporterWorker endet um 11:49:
    Code:
    [2017-05-11 11:49:54,656] [2383835] [108      ] [INFO ] - ImporterWorker.ImportJob(#1): Completed
    [2017-05-11 11:49:54,656] [2383835] [108      ] [INFO ] - ImporterWorker.ImportJob(#1): Disposed
    Von 11:50 bis 17:53 gibt es keine Kommunikation mir der Datenbank. Seltsam von wo die SQLiteException kommt...
     

    rico123

    MP Donator
  • Premium Supporter
  • January 1, 2015
    78
    15
    Home Country
    Germany Germany
    Hab wieder nen neuen Absturz im Zusammenhang mit Medienimport... Diesmal lief der Client die ganze Zeit.
     

    HTPCSourcer

    Retired Team Member
  • Premium Supporter
  • May 16, 2008
    11,418
    2,335
    Home Country
    Germany Germany
    Hallo

    interessant. Im Server-Log fällt zunächst folgende Fehlermeldung auf
    [2017-05-14 10:46:44,203] [11565 ] [69 ] [DEBUG] - ImporterWorker.ImportJob(#1).DirectoryUnfoldBlock: Successfully processed 0 MediaItems; time elapsed: 00:00:00.0001319; MaxDegreeOfParallelism(InnerBlock) = 1
    [2017-05-14 10:46:44,309] [11671 ] [69 ] [DEBUG] - ImporterWorker.ImportJob(#1).DirectorySaveBlock: Successfully processed 0 MediaItems; time elapsed: 00:00:00.0006749; MaxDegreeOfParallelism(InnerBlock) = 1
    [2017-05-14 10:46:44,421] [11783 ] [66 ] [DEBUG] - ImporterWorker.ImportJob(#1).FileUnfoldBlock: Successfully processed 0 MediaItems; time elapsed: 00:00:00.0001392; MaxDegreeOfParallelism(InnerBlock) = 1
    [2017-05-14 10:46:44,968] [12330 ] [20 ] [INFO ] - ImporterWorker.ImportJob(#1): Activated
    [2017-05-14 10:46:44,970] [12332 ] [20 ] [INFO ] - ImporterWorker: Activated (2 ImportJobs pending)
    [2017-05-14 10:46:47,425] [14787 ] [3 ] [ERROR] - ImporterWorker.ImportJob(#2): Could not create ResourceAccessor for resource '{03dd2da6-4da8-4d3e-9e55-80e3165729a3}:////LS-WXLE76/Medien/Musik/Rock/Die Fantastischen Vier/Fornika/Die Fantastischen Vier/Fornika/': It is no filesystem resource
    [2017-05-14 10:46:47,433] [14795 ] [3 ] [WARN ] - ImporterWorker.ImportJob(#2).MediaItemLoadBlock: Error while processing PendingImportResource '{03dd2da6-4da8-4d3e-9e55-80e3165729a3}:////LS-WXLE76/Medien/Musik/Rock/Die Fantastischen Vier/Fornika/Die Fantastischen Vier/Fornika/' (parent directory={03dd2da6-4da8-4d3e-9e55-80e3165729a3}:////LS-WXLE76/Medien/Musik/Rock/Die Fantastischen Vier/Fornika/Die Fantastischen Vier/)
    System.NullReferenceException: Der Objektverweis wurde nicht auf eine Objektinstanz festgelegt.
    bei MediaPortal.Common.Services.MediaManagement.ImportDataflowBlocks.MediaItemLoadBlock.<ProcessMediaItem>d__3.MoveNext()
    Aber das scheint das System nicht zum Absturz zu bringen, denn es geht anschließend weiter und es wird erfolgreich auf Kika HD getunt.

    Anschließend steht hier aber, dass Standby angefordert wurde:
    [2017-05-14 10:47:14,069] [41430 ] [PS StandbyWakeup] [DEBUG] - PS: SetStandbyMode(AwayModeRequested)
    Wurde doch versucht, den Client abzuschalten?

    Die Log-Aktivität endet dann 1 sek später mit
    [2017-05-14 10:47:15,184] [42546 ] [16 ] [INFO ] - ImporterWorker: 2 % completed (2 ImportJob(s), in total 510 of 24055 so far identified resources processed)

    Ich vermute, dass Im Event-Log wieder ein SQLite-Fehler steht. Kannst du das mal prüfen und vor allem die Zeiten vergleichen?
     

    rico123

    MP Donator
  • Premium Supporter
  • January 1, 2015
    78
    15
    Home Country
    Germany Germany
    Der Client wurde zu der Zeit definitiv nicht abgeschaltet. Im Event-Log des Servers hab ich folgendes gefunden:
    XML:
    Protokollname: System
    Quelle:        Service Control Manager
    Datum:         14.05.2017 10:45:24
    Ereignis-ID:   7031
    Aufgabenkategorie:Keine
    Ebene:         Fehler
    Schlüsselwörter:Klassisch
    Benutzer:      Nicht zutreffend
    Computer:      TV-Server
    Beschreibung:
    Der Dienst "MediaPortal 2 Server Service" wurde unerwartet beendet. Dies ist bereits 1 Mal vorgekommen. Folgende Korrekturmaßnahmen werden in 60000 Millisekunden durchgeführt: Neustart des Diensts.
    Ereignis-XML:
    <Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
      <System>
        <Provider Name="Service Control Manager" Guid="{555908d1-a6d7-4695-8e1e-26931d2012f4}" EventSourceName="Service Control Manager" />
        <EventID Qualifiers="49152">7031</EventID>
        <Version>0</Version>
        <Level>2</Level>
        <Task>0</Task>
        <Opcode>0</Opcode>
        <Keywords>0x8080000000000000</Keywords>
        <TimeCreated SystemTime="2017-05-14T08:45:24.488684600Z" />
        <EventRecordID>3766</EventRecordID>
        <Correlation />
        <Execution ProcessID="688" ThreadID="1984" />
        <Channel>System</Channel>
        <Computer>TV-Server</Computer>
        <Security />
      </System>
      <EventData>
        <Data Name="param1">MediaPortal 2 Server Service</Data>
        <Data Name="param2">1</Data>
        <Data Name="param3">60000</Data>
        <Data Name="param4">1</Data>
        <Data Name="param5">Neustart des Diensts</Data>
        <Binary>4D00500032002D005300650072007600650072000000</Binary>
      </EventData>
    </Event>

    Der Fehler, welcher dazu geführt hat ist in der ServerError1.log zu finden:
    Error: SSDPClientController: Problem receiving multicast SSDP packets: 'Eine vorhandene Verbindung wurde vom Remotehost geschlossen'

    Hoffe das hilft weiter.

    Grüße.
     

    Users who are viewing this thread

    Top Bottom