Morgendliche Startschwierigkeiten der TSE

In diesem Forum können Fragen zum OrderSprinter gestellt werden.
Florian

Morgendliche Startschwierigkeiten der TSE

Beitrag von Florian »

Moin,

nach dem morgendlichen Einschalten der Kassenkiste schlägt das Aktualisieren der Zeit fehl und ein Selbsttest jagt den nächsten, wodurch die Weboberfläche quasi nicht mehr benutzt werden kann (reagiert nicht mehr auf Klicks).
Workaround ist momentan: Den Connector stoppen, sich als Admin anmelden, den Connector starten und sofort danach das TSE-Setup anschubsen.

Die Logs sehen folgendermassen aus, zuerst die Einträge nach dem Start (die "***" habe ich hinzugefügt):

Code: Alles auswählen

TSE seems to be mounted
Sync Time = 1800 seconds (30 minutes)
2020-10-14T08:49:29.075704: Abgeschlossen Startup des TSEConnectors
2020-10-14T08:51:56.835765: Transferred POST-Data: {"pass":"***","pin":[***],"clientid":"ORD1","cmd":"check"}
2020-10-14T08:51:57.364959: isCheckUseful = true: current = 1602658317, lastSucces=0
2020-10-14T08:51:57.365255: Check for TSE Status and availability
2020-10-14T08:51:57.368955: TSE has no valid self test. Start self test now.
2020-10-14T08:51:57.370154: Start Self Test
2020-10-14T08:52:10.972431: Completed Self Test
2020-10-14T08:52:11.015533: TSE has no valid time. Set time now.
2020-10-14T08:52:11.015772: TSE needs time sync because soon expiration of maxSyncTime after last time sync
2020-10-14T08:52:11.119115: TSE update time resulted into an error so self test will be triggered. Error message: WormException: WORM_ERROR_NOT_AUTHORIZED
2020-10-14T08:52:11.119414: Start Self Test
2020-10-14T08:52:24.526714: Completed Self Test
2020-10-14T08:52:24.629008: TSE update time resulted into an error: WormException: WORM_ERROR_NOT_AUTHORIZED
2020-10-14T08:52:25.361163: Transferred POST-Data: {"pass":"***","pin":[***],"clientid":"ORD1","cmd":"check"}
2020-10-14T08:52:25.366046: isCheckUseful = true: current = 1602658345, lastSucces=0
2020-10-14T08:52:25.366199: Check for TSE Status and availability
2020-10-14T08:52:25.374434: TSE has no valid time. Set time now.
2020-10-14T08:52:25.374550: TSE needs time sync because soon expiration of maxSyncTime after last time sync
2020-10-14T08:52:25.475634: TSE update time resulted into an error so self test will be triggered. Error message: WormException: WORM_ERROR_NOT_AUTHORIZED
2020-10-14T08:52:25.475974: Start Self Test
2020-10-14T08:52:38.919893: Completed Self Test
2020-10-14T08:52:39.090781: TSE update time resulted into an error: WormException: WORM_ERROR_NOT_AUTHORIZED
2020-10-14T08:52:39.195265: Transferred POST-Data: {"pass":"***","pin":[***],"clientid":"ORD1","cmd":"check"}
2020-10-14T08:52:39.200160: isCheckUseful = true: current = 1602658359, lastSucces=0
2020-10-14T08:52:39.200318: Check for TSE Status and availability
2020-10-14T08:52:39.211498: TSE has no valid time. Set time now.
2020-10-14T08:52:39.211646: TSE needs time sync because soon expiration of maxSyncTime after last time sync
2020-10-14T08:52:39.312787: TSE update time resulted into an error so self test will be triggered. Error message: WormException: WORM_ERROR_NOT_AUTHORIZED
2020-10-14T08:52:39.313087: Start Self Test
2020-10-14T08:52:52.860825: Completed Self Test
2020-10-14T08:52:53.020745: TSE update time resulted into an error: WormException: WORM_ERROR_NOT_AUTHORIZED

Und hier die Einträge nach dem Ausführen des TSE-Setups (die "***" habe ich hinzugefügt):

Code: Alles auswählen

 TSE seems to be mounted
 Sync Time = 1800 seconds (30 minutes)
 2020-10-14T09:15:36.882644: Abgeschlossen Startup des TSEConnectors
 2020-10-14T09:15:37.972392: Transferred POST-Data: {"pass":"***","pin":[***],"puk":[***],"clientid":"ORD1","cmd":"setup"}
 2020-10-14T09:15:38.274776: Start Self Test
 2020-10-14T09:15:54.791264: Completed Self Test
 2020-10-14T09:15:54.791517: Start Login
 2020-10-14T09:15:54.980547: Logged in
 2020-10-14T09:15:55.339256: Start InfoTask
 2020-10-14T09:15:55.399903: Completed InfoTask. Out=CommandResult [ok=true, msg={"msg":"No factory reset done. Self Test completed. Time updated"}]
 CommandResult [ok=true, msg={"msg":"TseDescription: ***\nceritificateExpirationDate: ***\nCreated Signatures: ***\nhasValidTime: true\nAnzahl verbleibender Signaturen: ***\n"}]
 2020-10-14T09:15:55.423204: Transferred POST-Data: {"pass":"***","pin":[***],"clientid":"ORD1","cmd":"check"}
 2020-10-14T09:15:55.427177: isCheckUseful = true: current = 1602659755, lastSucces=0
 2020-10-14T09:15:55.427301: Check for TSE Status and availability
 2020-10-14T09:15:55.435744: TSE needs time sync because soon expiration of maxSyncTime after last time sync
 2020-10-14T09:15:55.790981: TSE time is set
 2020-10-14T09:15:56.195159: TSE time is set
 2020-10-14T09:15:56.198830: Transferred POST-Data: {"pass":"***","pin":[***],"clientid":"ORD1","cmd":"check"}
 2020-10-14T09:15:56.205205: isCheckUseful = false: current = 1602659756, lastSucces=1602659756
 2020-10-14T09:15:56.205369: Ignore Check request - last check not that far in the past
 2020-10-14T09:15:56.210703: Transferred POST-Data: {"pass":"***","pin":[***],"clientid":"ORD1","cmd":"check"}
 2020-10-14T09:15:56.214149: isCheckUseful = false: current = 1602659756, lastSucces=1602659756
 2020-10-14T09:15:56.214266: Ignore Check request - last check not that far in the past

Soweit ich das mitbekommen habe, ist danach den Tag über alles normal und kein Aufruf des TSE-Setups mehr nötig.

Ordersprinter-Version ist die momentan aktuelle (2.0.9)

Bin ich mit diesem Verhalten alleine oder geht es anderen auch so?
Und hat jemand vielleicht eine Idee was das Problem sein könnte?

Gruß,
Florian
pichel
Administrator
Beiträge: 1170
Registriert: So 13. Sep 2015, 19:48
Wohnort: Hamburg
Kontaktdaten:

Re: Morgendliche Startschwierigkeiten der TSE

Beitrag von pichel »

Hallo Florian,

hast du eine andere PIN/PUK zugewiesen? Hast du die in der Konfiguration nach dem Setzen bei der TSE auch über den Speichern-Button gespeichert?

Gruß,

Stefan
Stefan Pichel
Entwickler der Kassensoftware OrderSprinter (http://www.ordersprinter.de)
Florian

Re: Morgendliche Startschwierigkeiten der TSE

Beitrag von Florian »

Hallo Stefan,

ja, die PIN und PUK habe ich geändert und auch gespeichert. Wenn ich die Konfiguration öffne stehen beide dort korrekt und beim TSE-Setup beklagt sich der Connector auch nicht über eine falsche PIN oder PUK.

Gruß,
Florian
Florian

Re: Morgendliche Startschwierigkeiten der TSE

Beitrag von Florian »

Noch ein Nachtrag:

Habe gerade noch einmal das Speichern der PIN und der PUK gemacht (einfach nur zum Testen auf einen anderen Wert geändert) und dabei ist mir nichts besonderes aufgefallen, ausser dass die PUK anscheinend keinen History-Eintrag in der Datenbank-Tabelle ordersprinter_histconfig bekommt nachdem sie gespeichert wurde. Der neue Wert landet aber dennoch korrekt in der Tabelle ordersprinter_config.
Die PIN hingegen taucht in der History auf.

Das war jetzt nur spontan probiert, ob das etwas mit dem Problem zu tun hat kann ich nicht beurteilen, ich möchte hier auch keine falsche Fährte legen ;)
pichel
Administrator
Beiträge: 1170
Registriert: So 13. Sep 2015, 19:48
Wohnort: Hamburg
Kontaktdaten:

Re: Morgendliche Startschwierigkeiten der TSE

Beitrag von pichel »

Hallo,

die PUK wird derzeit noch nicht benötigt, d.h. es sollte keinen Unterschied machen, ob diese gespeichert und versioniert wird.

Ein TSE-Setup sollte eigentlich nur einmal im Leben einer TSE aufgerufen werden. Hast du mal versucht, manuell den Selbsttest über die Administrationsoberfläche aufzurufen (statt dem Selbsttest)?

Mich würde mal interessieren, ob andere Anwender das gleiche Problem haben. Ich bitte sehr um Feedback. Ich konnte es nämlich bei mir nicht reproduzieren bisher.

Ich werde es mir aber alles trotzdem intensiv am Wochenende anschauen. So lange müssen dann eben alle, die damit Probleme haben, am besten die TSE auf "Fehler" in der Administrationsansicht/Konfiguration/TSE einstellen.

Florian, man kann bei der TSE auch explizit einen TimeAdmin registrieren bzw. User ohne weitergehende Rechte. Ich nehme an, dass hast du nicht gemacht?

Gruß,

Stefan
Stefan Pichel
Entwickler der Kassensoftware OrderSprinter (http://www.ordersprinter.de)
pichel
Administrator
Beiträge: 1170
Registriert: So 13. Sep 2015, 19:48
Wohnort: Hamburg
Kontaktdaten:

Re: Morgendliche Startschwierigkeiten der TSE

Beitrag von pichel »

Hallo,

die Entwickler-TSE verhält sich offenbar an verschiedenen Stellen etwas anders als die "richtige" TSE, wie ich gerade anhand einer Teamviewer-Session sehen konnte. Ich habe ein paar Screenshots gemacht, um das jetzt genauer zu analysieren.

Das bedeutet also, dass man bei Problemen die TSE erst einmal abschalten sollte (Administrationsansicht -> Konfiguration -> Tse = Aus oder Fehler).

Trotzdem würde mich interessieren, wer mit der aktuellen Version 2.0.9 nun problemlos arbeiten kann und bei wem es immer noch Probleme gibt.

Gruß,

Stefan
Stefan Pichel
Entwickler der Kassensoftware OrderSprinter (http://www.ordersprinter.de)
Florian

Re: Morgendliche Startschwierigkeiten der TSE

Beitrag von Florian »

Moin,
pichel hat geschrieben: Mi 14. Okt 2020, 18:01 Ein TSE-Setup sollte eigentlich nur einmal im Leben einer TSE aufgerufen werden. Hast du mal versucht, manuell den Selbsttest über die Administrationsoberfläche aufzurufen (statt dem Selbsttest)?
Der läuft auch durch ("Result: Self Test completed"). Man muss nach dem Starten des Connectors allerdings das richtige timing haben um manuell den Test starten zu können, denn sobald dort die Selbsttests beginnen ist die Weboberfläche nicht mehr ansprechbar.

Was hat es denn für Folgen wenn man das TSE-Setup mehrfach aufgerufen hat? Bzw. was genau macht dasTSE-Setup?
pichel hat geschrieben: Mi 14. Okt 2020, 18:01 Florian, man kann bei der TSE auch explizit einen TimeAdmin registrieren bzw. User ohne weitergehende Rechte. Ich nehme an, dass hast du nicht gemacht?
Ja, das habe ich nicht gemacht.

Gruß,
Florian
misery
Beiträge: 36
Registriert: Do 24. Sep 2020, 09:53

Re: Morgendliche Startschwierigkeiten der TSE

Beitrag von misery »

Moin Florian,
Florian hat geschrieben: Do 15. Okt 2020, 09:05 Der läuft auch durch ("Result: Self Test completed"). Man muss nach dem Starten des Connectors allerdings das richtige timing haben um manuell den Test starten zu können, denn sobald dort die Selbsttests beginnen ist die Weboberfläche nicht mehr ansprechbar.
welchen Webserver verwendest du? Ist der eventuell auf http2 gestellt?

Kannst du mal im Browser (Firefox, Chrome) F12 klicken und dort auf "Netzwerk/Netzwerkanalyse" gehen?
Welche Queries sind denn da langsam?
Du kannst unter Firefox rechts das Zahnrad klicken und auf "Alles als HAR speichern" wählen. Bei Chrome ist das rechte Taste auf die Liste und dort "Speichere alles als HAR ..." oder so was. Dann könnten wir uns das auch ansehen. Aber am besten die Datei "privat" zusenden, da dort der ganze Netzwerk zwischen Browser und Ordersprinter gespeichert wird.

André
Florian

Re: Morgendliche Startschwierigkeiten der TSE

Beitrag von Florian »

Hallo André,

hier läuft ein Apache ohne http2.
Ich denke auch, dass das eher ein Symptom und nicht die Ursache ist, denn das Problem tritt ja erst auf, seit der Connector ohne Pause mit den ständigen Selbsttests beschäftigt ist (siehe Log), und Stefan schreibt in der Dokumentation bei Punkt 5.6 auch etwas zu diesem "ausgebremsten" Verhalten wenn die TSE bestimmte Aktionen ausführt.

Gruß,
Florian
os_user

Re: Morgendliche Startschwierigkeiten der TSE

Beitrag von os_user »

Hallo zusammen,
habe die Swissbit-TSE ebenfalls im Produktivbetrieb, gestern noch auf 2.0.9 von 2.0.7 aktualisiert, allerdings kann ich den Fehler nicht reproduzieren. Allerdings läuft das System auch ohne Unterbrechung und wird nicht neu gestartet.
Antworten