Absturz bei Installation Opsi-Client-Agent

Antworten
8mBandmaß
Beiträge: 4
Registriert: 04 Mär 2020, 15:19

Absturz bei Installation Opsi-Client-Agent

Beitrag von 8mBandmaß »

Hallo zusammen,

ich bin heute bei einem bestimmten Hardwaretypen auf ein gravierendes Problem bein der Installation von Win10-x64 in Verbindung mit dem Opsi-Client-Agent und Opsi-Winst gestoßen. Und zwar startet die Installation ganz normal und läuft auch erstmal durch. Nachdem Windows installiert ist, und der Opsi-Client-Agent, sowie Opsi-Winst installiert werden,hängt sich der Rechner allerdings auf. Opsi-Winst scheint noch ganz normal installiert zu werden, der Opsi-Client-Agent aber nicht. Der Bildschirm wird schwarz, er reagiert nicht mehr auf Maus und Tastatureingaben, ist allerdings weiterhin an. Hab ihn mal eine halbe Stunde laufen lassen, aber da tut sich nix mehr. Wenn man ihn dann zwingt sich auszuschalten und erneut hochfährt werden auch weitere Aktionen nicht durchgeführt.

Der Client ist ein Fujitsu Esprimo G558 mit Pentium Gold G5420 CPU und SSD.

Hatte zunächst überlegt, ob es an irgendwelchen Power-Einstellungen im BIOS zusammen hängt, das scheint allerdings unproblematisch zu sein. Hatte da mal Secure-Boot und Fast-Boot ausgeschaltet.

In dem Log "opsiconfd" schlägt sich das ganze folgendermaßen wieder. Hab jetzt mal nur die Loglevel 5 Informationen hier angehangen, kann aber die bis Level 8 bei Bedarf auch nachliefern. Wollte jetzt nicht so einen riesen Log-Berg hier dran klatschen.

Code: Alles auswählen

[5] [Mar 09 11:22:54] -----> Executing: productOnClient_updateObjects([<ProductOnClient(clientId=u'ws246.bsgv-n.local', productId=u'opsi-winst', installationStatus=u'installed', actionRequest=None)>]) (JsonRpc.py|133)
[5] [Mar 09 11:23:02] Application 'opsi-script 4.12.1.5' on client '10.63.72.202' did not send cookie (workers.py|185)
[5] [Mar 09 11:23:02] New session created (session.py|77)
[5] [Mar 09 11:23:02] Authorization request from host ws246.bsgv-n.local@10.63.72.202 (application: opsi-script 4.12.1.5) (workers.py|215)
[5] [Mar 09 11:23:03] -----> Executing: getDepotId(u'ws246.bsgv-n.local') (JsonRpc.py|133)
[5] [Mar 09 11:23:03] -----> Executing: backend_info() (JsonRpc.py|133)
[5] [Mar 09 11:23:05] -----> Executing: getDepotId(u'ws246.bsgv-n.local') (JsonRpc.py|133)
[5] [Mar 09 11:23:05] -----> Executing: getProductOrdering(u'opsi1.bsgv-n.local') (JsonRpc.py|133)
[5] [Mar 09 11:23:05] Using sort algorithm 'algorithm1' (10_opsi.conf|103)
[5] [Mar 09 11:23:07] -----> Executing: setProductActionRequest(u'opsi-client-agent', u'ws246.bsgv-n.local', u'setup') (JsonRpc.py|133)
[5] [Mar 09 11:23:07] -----> Executing: getProductOrdering(u'opsi1.bsgv-n.local') (JsonRpc.py|133)
[5] [Mar 09 11:23:07] Using sort algorithm 'algorithm1' (10_opsi.conf|103)
[5] [Mar 09 11:23:09] -----> Executing: getProduct_hash(u'opsi-client-agent', u'opsi1.bsgv-n.local') (JsonRpc.py|133)
[5] [Mar 09 11:23:09] -----> Executing: getProductProperties_hash(u'opsi-client-agent', u'ws246.bsgv-n.local') (JsonRpc.py|133)
[5] [Mar 09 11:23:10] -----> Executing: getProduct_hash(u'opsi-client-agent', u'opsi1.bsgv-n.local') (JsonRpc.py|133)
[5] [Mar 09 11:23:11] -----> Executing: productOnClient_updateObject(<ProductOnClient(clientId=u'ws246.bsgv-n.local', productId=u'opsi-client-agent', installationStatus=u'unknown', actionRequest=u'setup')>) (JsonRpc.py|133)
[5] [Mar 09 11:23:35] -----> Executing: authenticated() (JsonRpc.py|133)
[5] [Mar 09 11:23:35] -----> Executing: getNetworkConfig_hash(u'ws246.bsgv-n.local') (JsonRpc.py|133)
[5] [Mar 09 11:23:36] -----> Executing: getDepotId(u'ws246.bsgv-n.local') (JsonRpc.py|133)
[5] [Mar 09 11:23:36] -----> Executing: getProductProperties_hash(u'opsi-client-agent', u'ws246.bsgv-n.local') (JsonRpc.py|133)
[5] [Mar 09 11:23:37] -----> Executing: getGeneralConfigValue(u'clientconfig.depot.user', u'ws246.bsgv-n.local') (JsonRpc.py|133)
[5] [Mar 09 11:23:46] New session created (session.py|77)
[5] [Mar 09 11:27:11] Session 'ADeWd5iDSz5HVatcwMHm0IEbT6i9gqKf' from ip '10.63.72.202', application 'opsi-script / 4.12.3.1' expired after 360 seconds (Session.py|199)
[5] [Mar 09 11:27:11] Session 'ADeWd5iDSz5HVatcwMHm0IEbT6i9gqKf' from ip '10.63.72.202', application 'opsi-script / 4.12.3.1' deleted (Session.py|234)
[5] [Mar 09 11:27:16] Session 'ZjPs67uTwpTeSWbfKqcWHavaTjKDrmOC' from ip '10.63.72.202', application 'opsi-script / 4.12.3.1' expired after 360 seconds (Session.py|199)
[5] [Mar 09 11:27:16] Session 'ZjPs67uTwpTeSWbfKqcWHavaTjKDrmOC' from ip '10.63.72.202', application 'opsi-script / 4.12.3.1' deleted (Session.py|234)
[5] [Mar 09 11:27:28] Session 'Ax2ja3STrXsTH08orXlJUL6baoVwGQ7E' from ip '10.63.72.202', application 'opsi-script / 4.12.3.1' expired after 360 seconds (Session.py|199)
[5] [Mar 09 11:27:29] Session 'Ax2ja3STrXsTH08orXlJUL6baoVwGQ7E' from ip '10.63.72.202', application 'opsi-script / 4.12.3.1' deleted (Session.py|234)
[5] [Mar 09 11:27:42] Session 'GceHdlPOruuuYeY7Ns2GK2vAQjS0kBuL' from ip '10.63.72.202', application 'opsi-script / 4.12.3.1' expired after 360 seconds (Session.py|199)
[5] [Mar 09 11:27:42] Session 'GceHdlPOruuuYeY7Ns2GK2vAQjS0kBuL' from ip '10.63.72.202', application 'opsi-script / 4.12.3.1' deleted (Session.py|234)
[5] [Mar 09 11:27:43] Session 'IVKrMTIWD4ZnORlRP5C23EYJ7f7guA4t' from ip '10.63.72.202', application 'opsi-script / 4.12.3.1' expired after 360 seconds (Session.py|199)
[5] [Mar 09 11:27:43] Session 'IVKrMTIWD4ZnORlRP5C23EYJ7f7guA4t' from ip '10.63.72.202', application 'opsi-script / 4.12.3.1' deleted (Session.py|234)
[5] [Mar 09 11:27:46] Session 'i0nQlz3raaZZCXMC0sWoKPFZ8F6G0yjy' from ip '10.63.72.202', application 'opsi-script / 4.12.3.1' expired after 360 seconds (Session.py|199)
[5] [Mar 09 11:27:46] Session 'i0nQlz3raaZZCXMC0sWoKPFZ8F6G0yjy' from ip '10.63.72.202', application 'opsi-script / 4.12.3.1' deleted (Session.py|234)
[5] [Mar 09 11:28:54] Session 'wNPLEATVpXq3y8WUfvi4o4hXphYycGPQ' from ip '10.63.72.202', application 'opsiclientd version 4.0.99' expired after 360 seconds (Session.py|199)
[5] [Mar 09 11:28:54] Session 'wNPLEATVpXq3y8WUfvi4o4hXphYycGPQ' from ip '10.63.72.202', application 'opsiclientd version 4.0.99' deleted (Session.py|234)
[5] [Mar 09 11:30:11] Session 'C0k48nukQZU0YxlaofmmzkCpYcbvaOmo' from ip '10.63.72.202', application 'opsi-script 4.12.1.5' expired after 360 seconds (Session.py|199)
[5] [Mar 09 11:30:11] Session 'C0k48nukQZU0YxlaofmmzkCpYcbvaOmo' from ip '10.63.72.202', application 'opsi-script 4.12.1.5' deleted (Session.py|234)
[5] [Mar 09 11:33:24] Session 'Y3U1uYutnVEALYbUx3L1NMCZA31nBpDy' from ip '10.3.0.86', application 'opsi config editor 4.1.4.3.3' expired after 360 seconds (Session.py|199)
[5] [Mar 09 11:33:24] Session 'Y3U1uYutnVEALYbUx3L1NMCZA31nBpDy' from ip '10.3.0.86', application 'opsi config editor 4.1.4.3.3' deleted (Session.py|234)
[5] [Mar 09 11:40:31] New session created (session.py|77)
[5] [Mar 09 11:51:42] Session '8ElsThq7uTiCzJSpbw1nHEub5VPCkrbY' from ip '10.3.0.86', application 'opsi config editor 4.1.4.3.3' expired after 360 seconds (Session.py|199)
[5] [Mar 09 11:51:42] Session '8ElsThq7uTiCzJSpbw1nHEub5VPCkrbY' from ip '10.3.0.86', application 'opsi config editor 4.1.4.3.3' deleted (Session.py|234)
[5] [Mar 09 12:04:36] New session created (session.py|77)
[5] [Mar 09 12:04:37] New session created (session.py|77)
[5] [Mar 09 12:10:37] Session 'r8SrXzOG5ZPzSICiZyR1ENO6NvEVHvjC' from ip '10.3.0.117', application 'opsi config editor 4.1.4.3.3' expired after 360 seconds (Session.py|199)
[5] [Mar 09 12:10:37] Session 'r8SrXzOG5ZPzSICiZyR1ENO6NvEVHvjC' from ip '10.3.0.117', application 'opsi config editor 4.1.4.3.3' deleted (Session.py|234)
[5] [Mar 09 12:11:20] Session 'tSEkxQdzcKFlmjV6Hm1ulZrsESvgPaBc' from ip '10.3.0.117', application 'opsi config editor 4.1.4.3.3' expired after 360 seconds (Session.py|199)
[5] [Mar 09 12:11:20] Session 'tSEkxQdzcKFlmjV6Hm1ulZrsESvgPaBc' from ip '10.3.0.117', application 'opsi config editor 4.1.4.3.3' deleted (Session.py|234)
[5] [Mar 09 13:05:00] New session created (session.py|77)
[5] [Mar 09 13:13:14] Session 'PbrlAsi97mJ69ocLTgMiLpjCFjclgUlj' from ip '10.3.0.117', application 'opsi config editor 4.1.4.3.3' expired after 360 seconds (Session.py|199)
[5] [Mar 09 13:13:15] Session 'PbrlAsi97mJ69ocLTgMiLpjCFjclgUlj' from ip '10.3.0.117', application 'opsi config editor 4.1.4.3.3' deleted (Session.py|234)
Das Log OPsiclientd Log wird auch nicht wie eigentlich vorgesehen auf den Server kopiert, sondern liegt nur auf dem Client. Ich hätte jetzt anhand des opsiconfd Logs 11:23 bis 11:30 als kritischen Zeitraum identifiziert. In der Zeitspanne wird auf dem Client das Log in einer zweiten Datei fortgeführt, so dass auf dem Client opsiclientd.log und opsiclientd.log.0 vorhanden sind. Hier einmal das Ende von opsiclientd.log.0

Code: Alles auswählen

[5] [Mar 09 11:23:01] [ action_processor_starter.exe  ] Running command '"C:\\Program Files (x86)\opsi.org\opsi-client-agent\\opsi-winst\\winst32.exe" /opsiservice "https://10.63.64.49:4447/rpc" /clientid ws246.bsgv-n.local /username ws246.bsgv-n.local /password *** confidential *** ' as user 'pcpatch' on desktop 'winlogon'   (Windows.pyo|1928)
[6] [Mar 09 11:23:01] [ action_processor_starter.exe  ] Process startet, pid: 5020   (Windows.pyo|1931)
[6] [Mar 09 11:23:01] [ action_processor_starter.exe  ] Waiting for process ending: 5020 (timeout: 10800 seconds)   (Windows.pyo|1934)
[6] [Mar 09 11:23:02] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:02] [ control pipe                  ] -----> Executing: isRebootRequested()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:02] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[6] [Mar 09 11:23:02] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:02] [ control pipe                  ] -----> Executing: isShutdownRequested()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:02] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[6] [Mar 09 11:23:02] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:02] [ control pipe                  ] -----> Executing: getBlockLogin()   (JsonRpc.pyo|134)
[5] [Mar 09 11:23:02] [ opsiclientd                   ] rpc getBlockLogin: blockLogin is 'True'   (ControlPipe.pyo|426)
[6] [Mar 09 11:23:02] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[5] [Mar 09 11:23:03] [ control pipe                  ] -----> Executing: isRebootRequested()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:03] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[6] [Mar 09 11:23:03] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[6] [Mar 09 11:23:04] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:04] [ control pipe                  ] -----> Executing: isShutdownRequested()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:04] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[6] [Mar 09 11:23:04] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:04] [ control pipe                  ] -----> Executing: getBlockLogin()   (JsonRpc.pyo|134)
[5] [Mar 09 11:23:04] [ opsiclientd                   ] rpc getBlockLogin: blockLogin is 'True'   (ControlPipe.pyo|426)
[6] [Mar 09 11:23:04] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[6] [Mar 09 11:23:05] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:05] [ control pipe                  ] -----> Executing: isRebootRequested()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:05] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[6] [Mar 09 11:23:06] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:06] [ control pipe                  ] -----> Executing: isShutdownRequested()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:06] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[6] [Mar 09 11:23:06] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:06] [ control pipe                  ] -----> Executing: getBlockLogin()   (JsonRpc.pyo|134)
[5] [Mar 09 11:23:06] [ opsiclientd                   ] rpc getBlockLogin: blockLogin is 'True'   (ControlPipe.pyo|426)
[6] [Mar 09 11:23:06] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[5] [Mar 09 11:23:07] [ control pipe                  ] -----> Executing: isRebootRequested()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:07] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[6] [Mar 09 11:23:07] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[6] [Mar 09 11:23:08] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:08] [ control pipe                  ] -----> Executing: isShutdownRequested()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:08] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[5] [Mar 09 11:23:08] [ control pipe                  ] -----> Executing: getBlockLogin()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:08] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:08] [ opsiclientd                   ] rpc getBlockLogin: blockLogin is 'True'   (ControlPipe.pyo|426)
[6] [Mar 09 11:23:08] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[5] [Mar 09 11:23:09] [ control pipe                  ] -----> Executing: isRebootRequested()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:09] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[6] [Mar 09 11:23:09] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[5] [Mar 09 11:23:09] [ control pipe                  ] -----> Executing: isShutdownRequested()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:09] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[6] [Mar 09 11:23:09] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[6] [Mar 09 11:23:10] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:10] [ control pipe                  ] -----> Executing: getBlockLogin()   (JsonRpc.pyo|134)
[5] [Mar 09 11:23:10] [ opsiclientd                   ] rpc getBlockLogin: blockLogin is 'True'   (ControlPipe.pyo|426)
[6] [Mar 09 11:23:10] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[6] [Mar 09 11:23:11] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:11] [ control pipe                  ] -----> Executing: isRebootRequested()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:11] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[5] [Mar 09 11:23:11] [ control pipe                  ] -----> Executing: isShutdownRequested()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:11] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[6] [Mar 09 11:23:11] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[5] [Mar 09 11:23:12] [ control pipe                  ] -----> Executing: getBlockLogin()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:12] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:12] [ opsiclientd                   ] rpc getBlockLogin: blockLogin is 'True'   (ControlPipe.pyo|426)
[6] [Mar 09 11:23:12] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[6] [Mar 09 11:23:13] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:13] [ control pipe                  ] -----> Executing: isRebootRequested()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:13] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[6] [Mar 09 11:23:13] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:13] [ control pipe                  ] -----> Executing: isShutdownRequested()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:13] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[6] [Mar 09 11:23:14] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:14] [ control pipe                  ] -----> Executing: getBlockLogin()   (JsonRpc.pyo|134)
[5] [Mar 09 11:23:14] [ opsiclientd                   ] rpc getBlockLogin: blockLogin is 'True'   (ControlPipe.pyo|426)
[6] [Mar 09 11:23:14] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[6] [Mar 09 11:23:15] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:15] [ control pipe                  ] -----> Executing: isRebootRequested()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:15] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[6] [Mar 09 11:23:15] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:15] [ control pipe                  ] -----> Executing: isShutdownRequested()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:15] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[5] [Mar 09 11:23:15] [ control pipe                  ] -----> Executing: getBlockLogin()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:15] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:15] [ opsiclientd                   ] rpc getBlockLogin: blockLogin is 'True'   (ControlPipe.pyo|426)
[6] [Mar 09 11:23:15] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[6] [Mar 09 11:23:17] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:17] [ control pipe                  ] -----> Executing: isRebootRequested()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:17] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[6] [Mar 09 11:23:17] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:17] [ control pipe                  ] -----> Executing: isShutdownRequested()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:17] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[5] [Mar 09 11:23:17] [ control pipe                  ] -----> Executing: getBlockLogin()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:17] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:17] [ opsiclientd                   ] rpc getBlockLogin: blockLogin is 'True'   (ControlPipe.pyo|426)
[6] [Mar 09 11:23:17] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[6] [Mar 09 11:23:19] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:19] [ control pipe                  ] -----> Executing: isRebootRequested()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:19] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[6] [Mar 09 11:23:19] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:19] [ control pipe                  ] -----> Executing: isShutdownRequested()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:19] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[5] [Mar 09 11:23:19] [ control pipe                  ] -----> Executing: getBlockLogin()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:19] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:19] [ opsiclientd                   ] rpc getBlockLogin: blockLogin is 'True'   (ControlPipe.pyo|426)
[6] [Mar 09 11:23:19] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[5] [Mar 09 11:23:21] [ control pipe                  ] -----> Executing: isRebootRequested()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:21] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[6] [Mar 09 11:23:21] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[6] [Mar 09 11:23:21] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:21] [ control pipe                  ] -----> Executing: isShutdownRequested()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:21] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[5] [Mar 09 11:23:21] [ control pipe                  ] -----> Executing: getBlockLogin()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:21] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:21] [ opsiclientd                   ] rpc getBlockLogin: blockLogin is 'True'   (ControlPipe.pyo|426)
[6] [Mar 09 11:23:21] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[6] [Mar 09 11:23:23] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:23] [ control pipe                  ] -----> Executing: isRebootRequested()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:23] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[6] [Mar 09 11:23:23] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:23] [ control pipe                  ] -----> Executing: isShutdownRequested()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:23] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[5] [Mar 09 11:23:23] [ control pipe                  ] -----> Executing: getBlockLogin()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:23] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:23] [ opsiclientd                   ] rpc getBlockLogin: blockLogin is 'True'   (ControlPipe.pyo|426)
[6] [Mar 09 11:23:23] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[6] [Mar 09 11:23:24] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:24] [ control pipe                  ] -----> Executing: isRebootRequested()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:24] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[6] [Mar 09 11:23:25] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:25] [ control pipe                  ] -----> Executing: isShutdownRequested()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:25] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[6] [Mar 09 11:23:25] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:25] [ control pipe                  ] -----> Executing: getBlockLogin()   (JsonRpc.pyo|134)
[5] [Mar 09 11:23:25] [ opsiclientd                   ] rpc getBlockLogin: blockLogin is 'True'   (ControlPipe.pyo|426)
[6] [Mar 09 11:23:25] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[5] [Mar 09 11:23:26] [ control pipe                  ] -----> Executing: isRebootRequested()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:26] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[6] [Mar 09 11:23:26] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[6] [Mar 09 11:23:27] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:27] [ control pipe                  ] -----> Executing: isShutdownRequested()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:27] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[5] [Mar 09 11:23:27] [ control pipe                  ] -----> Executing: getBlockLogin()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:27] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:27] [ opsiclientd                   ] rpc getBlockLogin: blockLogin is 'True'   (ControlPipe.pyo|426)
[6] [Mar 09 11:23:27] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[6] [Mar 09 11:23:28] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:28] [ control pipe                  ] -----> Executing: isRebootRequested()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:28] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[6] [Mar 09 11:23:29] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:29] [ control pipe                  ] -----> Executing: isShutdownRequested()   (JsonRpc.pyo|134)
[6] [Mar 09 11:23:29] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
[6] [Mar 09 11:23:29] [ control pipe                  ] Creating pipe \\.\pipe\opsiclientd   (ControlPipe.pyo|251)
[5] [Mar 09 11:23:29] [ control pipe                  ] -----> Executing: getBlockLogin()   (JsonRpc.pyo|134)
[5] [Mar 09 11:23:29] [ opsiclientd                   ] rpc getBlockLogin: blockLogin is 'True'   (ControlPipe.pyo|426)
[6] [Mar 09 11:23:29] [ control pipe                  ] Got result   (JsonRpc.pyo|142)
Danach stehen in der Datei noch ganz viele Nullen, die entsprechen nicht als Zeichen interpretiert werden, und da so wahrscheinlich auch nicht hingehören.
opsiclentd.log sieht dann folgendermaßen aus:

Code: Alles auswählen

[4] [Mar 09 11:30:08] [ opsiclientd                   ] Refusing to set empty value for config value 'host_id' of section 'global'   (Config.pyo|212)
[4] [Mar 09 11:30:08] [ opsiclientd                   ] Refusing to set empty value for config value 'opsi_host_key' of section 'global'   (Config.pyo|212)
[4] [Mar 09 11:30:08] [ opsiclientd                   ] Refusing to set empty value for config value 'depot_id' of section 'depot_server'   (Config.pyo|212)
[4] [Mar 09 11:30:08] [ opsiclientd                   ] Refusing to set empty value for config value 'url' of section 'depot_server'   (Config.pyo|212)
[4] [Mar 09 11:30:08] [ opsiclientd                   ] Refusing to set empty value for config value 'drive' of section 'depot_server'   (Config.pyo|212)
[1] [Mar 09 11:30:08] [ opsiclientd                   ] Opsiclientd version: 4.0.99 (full)   (Opsiclientd.pyo|234)
[1] [Mar 09 11:30:08] [ opsiclientd                   ] Commandline: C:\\Program Files (x86)\opsi.org\opsi-client-agent\opsiclientd.exe   (Opsiclientd.pyo|239)
[1] [Mar 09 11:30:08] [ opsiclientd                   ] Working directory: C:\Windows\system32   (Opsiclientd.pyo|241)
[3] [Mar 09 11:30:08] [ opsiclientd                   ] (2, 'CreateProcessAsUser', 'Das System kann die angegebene Datei nicht finden.')   (Opsiclientd.pyo|130)
[3] [Mar 09 11:30:08] [ opsiclientd                   ] Failed to start block login notifier app: (2, 'CreateProcessAsUser', 'Das System kann die angegebene Datei nicht finden.')   (Opsiclientd.pyo|138)
[3] [Mar 09 11:30:11] [ opsiclientd                   ] (2, 'CreateProcessAsUser', 'Das System kann die angegebene Datei nicht finden.')   (Opsiclientd.pyo|130)
[3] [Mar 09 11:30:11] [ opsiclientd                   ] Failed to start block login notifier app: (2, 'CreateProcessAsUser', 'Das System kann die angegebene Datei nicht finden.')   (Opsiclientd.pyo|138)
[2] [Mar 09 11:30:14] [ control server                ] Traceback:   (Logger.pyo|757)
[2] [Mar 09 11:30:14] [ control server                ]   File "OPSI\Service\Worker.pyo", line 292, in _errback
   (Logger.pyo|757)
[2] [Mar 09 11:30:14] [ control server                ]   File "twisted\internet\defer.pyo", line 651, in _runCallbacks
   (Logger.pyo|757)
[2] [Mar 09 11:30:14] [ control server                ]   File "ocdlib\ControlServer.pyo", line 217, in _authenticate
   (Logger.pyo|757)
[2] [Mar 09 11:30:14] [ control server                ]      ==>>> Opsi authentication error: Forbidden: No password from 127.0.0.1 (application: opsi jsonrpc module version 4.0.7.62)   (Worker.pyo|294)
[2] [Mar 09 11:30:16] [ control server                ] Traceback:   (Logger.pyo|757)
[2] [Mar 09 11:30:16] [ control server                ]   File "OPSI\Service\Worker.pyo", line 292, in _errback
   (Logger.pyo|757)
[2] [Mar 09 11:30:16] [ control server                ]   File "twisted\internet\defer.pyo", line 651, in _runCallbacks
   (Logger.pyo|757)
[2] [Mar 09 11:30:16] [ control server                ]   File "ocdlib\ControlServer.pyo", line 217, in _authenticate
   (Logger.pyo|757)
[2] [Mar 09 11:30:16] [ control server                ]      ==>>> Opsi authentication error: Forbidden: No password from 127.0.0.1 (application: opsi jsonrpc module version 4.0.7.62)   (Worker.pyo|294)
[4] [Mar 09 11:30:16] [ opsiclientd                   ] Failed to get current active desktop name for session 1, using 'default'   (Opsiclientd.pyo|457)
[3] [Mar 09 11:30:16] [ event processing gui_startup{installation_pending}] (2, 'CreateProcessAsUser', 'Das System kann die angegebene Datei nicht finden.')   (EventProcessing.pyo|309)
[3] [Mar 09 11:30:16] [ event processing gui_startup{installation_pending}] Failed to start notifier application 'C:\\Program Files (x86)\opsi.org\opsi-client-agent\\notifier.exe -p %port% -i %id% -s notifier\\event.ini': (2, 'CreateProcessAsUser', 'Das System kann die angegebene Datei nicht finden.')   (EventProcessing.pyo|332)
[3] [Mar 09 11:30:16] [ service connection            ] Failed to read version info from file u'/etc/opsi/version': [Errno 2] No such file or directory: u'/etc/opsi/version'   (Backend.pyo|206)
[4] [Mar 09 11:30:21] [ opsiclientd                   ] Connecting to u'opsi.uib.local' did not succeed after retrying.   (HTTP.pyo|601)
[3] [Mar 09 11:30:21] [ service connection            ] Failed to connect to config server 'https://opsi.uib.local:4447/rpc': [Errno 11001] getaddrinfo failed   (OpsiService.pyo|366)
[3] [Mar 09 11:30:24] [ service connection            ] Failed to read version info from file u'/etc/opsi/version': [Errno 2] No such file or directory: u'/etc/opsi/version'   (Backend.pyo|206)
[4] [Mar 09 11:30:29] [ opsiclientd                   ] Connecting to u'opsi.uib.local' did not succeed after retrying.   (HTTP.pyo|601)
[3] [Mar 09 11:30:29] [ service connection            ] Failed to connect to config server 'https://opsi.uib.local:4447/rpc': [Errno 11001] getaddrinfo failed   (OpsiService.pyo|366)
[3] [Mar 09 11:30:32] [ service connection            ] Failed to read version info from file u'/etc/opsi/version': [Errno 2] No such file or directory: u'/etc/opsi/version'   (Backend.pyo|206)
[4] [Mar 09 11:30:37] [ opsiclientd                   ] Connecting to u'opsi.uib.local' did not succeed after retrying.   (HTTP.pyo|601)
[3] [Mar 09 11:30:37] [ service connection            ] Failed to connect to config server 'https://opsi.uib.local:4447/rpc': [Errno 11001] getaddrinfo failed   (OpsiService.pyo|366)
[3] [Mar 09 11:30:40] [ service connection            ] Failed to read version info from file u'/etc/opsi/version': [Errno 2] No such file or directory: u'/etc/opsi/version'   (Backend.pyo|206)
[4] [Mar 09 11:30:45] [ opsiclientd                   ] Connecting to u'opsi.uib.local' did not succeed after retrying.   (HTTP.pyo|601)
[3] [Mar 09 11:30:45] [ service connection            ] Failed to connect to config server 'https://opsi.uib.local:4447/rpc': [Errno 11001] getaddrinfo failed   (OpsiService.pyo|366)
[4] [Mar 09 11:30:48] [ service connection            ] Invalid thread id 1664   (Thread.pyo|68)
[4] [Mar 09 11:30:49] [ service connection            ] Invalid thread id 1664   (Thread.pyo|68)
[4] [Mar 09 11:30:49] [ service connection            ] Invalid thread id 1664   (Thread.pyo|68)
[4] [Mar 09 11:30:50] [ service connection            ] Invalid thread id 1664   (Thread.pyo|68)
[4] [Mar 09 11:30:50] [ service connection            ] Invalid thread id 1664   (Thread.pyo|68)
[4] [Mar 09 11:30:51] [ service connection            ] Invalid thread id 1664   (Thread.pyo|68)
[4] [Mar 09 11:30:51] [ service connection            ] Invalid thread id 1664   (Thread.pyo|68)
[4] [Mar 09 11:30:52] [ service connection            ] Invalid thread id 1664   (Thread.pyo|68)
[3] [Mar 09 11:30:52] [ event processing gui_startup{installation_pending}] Failed to connect to config service 'https://opsi.uib.local:4447/rpc': timed out after 30 seconds   (OpsiService.pyo|106)
[4] [Mar 09 11:30:52] [ event processing gui_startup{installation_pending}] Cannot write log to service: not connected   (EventProcessing.pyo|262)
[4] [Mar 09 11:30:52] [ opsiclientd                   ] Failed to get RebootRequested from registry: [Error 2] Das System kann die angegebene Datei nicht finden   (Windows.pyo|308)
[3] [Mar 09 11:30:53] [ event processing gui_startup{installation_pending}] Failed to process event <ocdlib.Events.GUIStartupEvent object at 0x028DC0D0>: Failed to connect to config service 'https://opsi.uib.local:4447/rpc': timed out after 30 seconds   (EventProcessing.pyo|1303)
[2] [Mar 09 11:30:53] [ event processing gui_startup{installation_pending}] Traceback:   (Logger.pyo|757)
[2] [Mar 09 11:30:53] [ event processing gui_startup{installation_pending}]   File "ocdlib\EventProcessing.pyo", line 1237, in run
   (Logger.pyo|757)
[2] [Mar 09 11:30:53] [ event processing gui_startup{installation_pending}]   File "ocdlib\OpsiService.pyo", line 188, in connectConfigService
   (Logger.pyo|757)
[2] [Mar 09 11:30:53] [ event processing gui_startup{installation_pending}]   File "ocdlib\EventProcessing.pyo", line 158, in connectionTimedOut
   (Logger.pyo|757)
[2] [Mar 09 11:30:53] [ event processing gui_startup{installation_pending}]   File "ocdlib\OpsiService.pyo", line 107, in connectionTimedOut
   (Logger.pyo|757)
[2] [Mar 09 11:30:53] [ event processing gui_startup{installation_pending}]      ==>>> Failed to connect to config service 'https://opsi.uib.local:4447/rpc': timed out after 30 seconds   (EventProcessing.pyo|1304)
Auffällig ist hier, dass für die URL des Opsi Config Server scheinbar ein Default Wert gesetzt ist ('https://opsi.uib.local:4447), wobei im opsiclientd.log.0 der korrekte Wert gesetzt ist.

Wir hatten schon mal eine neuere Version des Opsi-Client-Agents (4.1.0.0-40) probiert, den Timeout für die Sessions (maxinactiveintervall) auf 360 Sekunden erhöht und speziellere Treiber über "byAudit" hinzugefügt anstatt derer die er sich über "preferred" automatisch zuweist. Leider alles ohne Erfolg. Was mich besonders stutzig macht, ist dass das Problem echt nur bei der Hardware auftritt und bei diversen anderen Clients nicht.
Wäre cool wenn noch jemand eine Idee dazu hätte. Könnte wie gesagt noch weitere detailliertere Logs liefern bei Bedarf, wollte jetzt nicht alles einfach hier dran klatschen.

Freundliche Grüße
8mBandmaß
Nach oben
8mBandmaß
Beiträge: 4
Registriert: 04 Mär 2020, 15:19

Re: Absturz bei Installation Opsi-Client-Agent

Beitrag von 8mBandmaß »

Hallo zusammen,

haben mittlerweile ein Workaround gefunden. Ursächlich für den Absturz scheint eine Kombination aus Grafikkartentreiber und Anschlussart des Monitors zu sein. Im ursprünglichen Setup hatten wir einen Viewsonic VG2448 Monitor über HDMI und einen weiteren Monitor des gleichen Typs per DP angeschlossen. Sobald wir nur einen Monitor angeschlossen hatten, lief alles problemlos durch. Wenn wir beide Monitore angeschlossen hatten, und den Grafikkartentreiber gelöscht hatten, lief es auch durch. Interessanterweise läuft es auch problemlos, wenn man den DP Monitor, mit einem DP->HDMI kabel anschließt. Klingt komisch, ist aber so. Das ist jetzt auch die Lösung, die wir hier umsetzen werden.
Vielleicht hilft der Thread hier ja in Zukunft jemandem weiter.

VG
8mBandmaß
Nach oben
Antworten

Zurück zu „Freier Support“