Setup:
opsi 3.3 (ohne Update vom 28.08.2008) unter VMware-Workstation, zwei physikalische Rechner als Testclients.
Die zwei Rechner und die opsi-Server-VM hängen alle an einem Switch, in einem isolierten Netz (das dann nur
aus diesen drei Rechnern besteht).
Probleme:
Hier möchte ich kurz zwei Auszüge aus den Logfiles posten, da ich der Meinung bin, dass man den Fehler hier
gut erkennen kann. Auf dem Testrechner mit der Bezeichnung "potcn-typ3-02" mit der IP 192.168.1.5 sollte
Firefox und der FlashPlayer installiert werden, hier der Auszug aus dem Client-Log-File C:\tmp\instlog.err:
Code: Alles auswählen
Auszug aus: "C:\tmp\instlog.err"
<snip>
03.09.2008 20:19:04 JSON service request https://192.168.1.1:4447/rpc?%7B%22id%22:1,%22method%22:%22getInstallableLocalBootProductIds%5Flist%22,%22params%22:%5B%22potcn-typ3-02.zzz.de%22%5D%7D
bootmode BKSTD
winst: Start sorting of products (03.09.2008 20:19:04)
03.09.2008 20:19:04 JSON service request https://192.168.1.1:4447/rpc?%7B%22id%22:1,%22method%22:%22getProductDependencies%5FlistOfHashes%22,%22params%22:%5B%5D%7D
~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~
Resolved sequence of products (03.09.2008 20:19:04):
Product 6 firefox : setup
Product 11 flashplayer : setup
~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~
03.09.2008 20:19:04 JSON service request https://192.168.1.1:4447/rpc?%7B%22id%22:1,%22method%22:%22getProductProperties%5Fhash%22,%22params%22:%5B%22firefox%22,%22potcn-typ3-02.zzz.de%22%5D%7D
03.09.2008 20:19:04 JSON service request https://192.168.1.1:4447/rpc?%7B%22id%22:1,%22method%22:%22getProduct%5Fhash%22,%22params%22:%5B%22firefox%22,%22Die%20Verbindung%20wurde%20erfolgreich%20geschlossen.%22%5D%7D
Error: --- opsi service problem ---{"message":"Product 'firefox' not found on depot 'die verbindung wurde erfolgreich geschlossen.'","class":"BackendMissingDataError"}
scriptname: "", special path: "P:\install\firefox\"
03.09.2008 20:19:04 JSON service request https://192.168.1.1:4447/rpc?%7B%22id%22:1,%22method%22:%22setProductInstallationStatus%22,%22params%22:%5B%22firefox%22,%22potcn-typ3-02.zzz.de%22,%22installing%22%5D%7D
no script found
no script found
03.09.2008 20:19:04 JSON service request https://192.168.1.1:4447/rpc?%7B%22id%22:1,%22method%22:%22setProductInstallationStatus%22,%22params%22:%5B%22firefox%22,%22potcn-typ3-02.zzz.de%22,%22installed%22%5D%7D
03.09.2008 20:19:04 JSON service request https://192.168.1.1:4447/rpc?%7B%22id%22:1,%22method%22:%22setProductActionRequest%22,%22params%22:%5B%22firefox%22,%22potcn-typ3-02.zzz.de%22,%22none%22%5D%7D
03.09.2008 20:19:04 JSON service request https://192.168.1.1:4447/rpc?%7B%22id%22:1,%22method%22:%22getProductProperties%5Fhash%22,%22params%22:%5B%22flashplayer%22,%22potcn-typ3-02.zzz.de%22%5D%7D
03.09.2008 20:19:04 JSON service request https://192.168.1.1:4447/rpc?%7B%22id%22:1,%22method%22:%22getProduct%5Fhash%22,%22params%22:%5B%22flashplayer%22,%22Die%20Verbindung%20wurde%20erfolgreich%20geschlossen.%22%5D%7D
Error: --- opsi service problem ---{"message":"Product 'flashplayer' not found on depot 'die verbindung wurde erfolgreich geschlossen.'","class":"BackendMissingDataError"}
scriptname: "", special path: "P:\install\flashplayer\"
03.09.2008 20:19:04 JSON service request https://192.168.1.1:4447/rpc?%7B%22id%22:1,%22method%22:%22setProductInstallationStatus%22,%22params%22:%5B%22flashplayer%22,%22potcn-typ3-02.zzz.de%22,%22installing%22%5D%7D
no script found
no script found
03.09.2008 20:19:04 JSON service request https://192.168.1.1:4447/rpc?%7B%22id%22:1,%22method%22:%22setProductInstallationStatus%22,%22params%22:%5B%22flashplayer%22,%22potcn-typ3-02.zzz.de%22,%22installed%22%5D%7D
03.09.2008 20:19:04 JSON service request https://192.168.1.1:4447/rpc?%7B%22id%22:1,%22method%22:%22setProductActionRequest%22,%22params%22:%5B%22flashplayer%22,%22potcn-typ3-02.zzz.de%22,%22none%22%5D%7D
============ winst Version 4.6.1 WIN32 is regularly exiting. Time 2008-09-03 20:19:05 .
<snap>
Code: Alles auswählen
Auszug aus: "/var/log/opsi/opsiconfd/192.168.1.5.log"
<snip>
(4) Sep 03 14:13:59 BackendManager created. (opsiconfd|403)
(4) Sep 03 14:14:56 Client '192.168.1.5' did not send cookie (opsiconfd|271)
(4) Sep 03 14:14:56 New session created (opsiconfd|938)
(4) Sep 03 14:14:56 Authorization request from potcn-typ3-02.zzz.de@192.168.1.5 (opsiconfd|366)
(3) Sep 03 14:15:52 Failed to resolve hostname 'potcn-typ3-02.zzz.de': (-2, 'Name or service not known') (opsiconfd|383)
(4) Sep 03 14:15:52 Host login attempt with username 'potcn-typ3-02.zzz.de' from ip '192.168.1.5', but name resolves to '[]', ip verification is disabled (access granted) (opsiconfd|394)
(4) Sep 03 14:15:52 BackendManager created. (opsiconfd|403)
(3) Sep 03 14:16:49 Is not a directory: '/var/lib/opsi/config/depots/die verbindung wurde erfolgreich geschlossen./products/localboot' (File31.py|1560)
(3) Sep 03 14:16:49 Is not a directory: '/var/lib/opsi/config/depots/die verbindung wurde erfolgreich geschlossen./products/netboot' (File31.py|1560)
(2) Sep 03 14:16:49 Product 'firefox' not found on depot 'die verbindung wurde erfolgreich geschlossen.' (opsiconfd|529)
(3) Sep 03 14:16:49 Is not a directory: '/var/lib/opsi/config/depots/die verbindung wurde erfolgreich geschlossen./products/localboot' (File31.py|1560)
(3) Sep 03 14:16:49 Is not a directory: '/var/lib/opsi/config/depots/die verbindung wurde erfolgreich geschlossen./products/netboot' (File31.py|1560)
(2) Sep 03 14:16:49 Product 'flashplayer' not found on depot 'die verbindung wurde erfolgreich geschlossen.' (opsiconfd|529)
<snap>
Das sieht doch schwer nach einem Bug (Spekulation: Eventuell im Threading des opsiconfd?) aus, oder?
Kann diesen Bug jemand (eventuell von uib) bestätigen?
Wurde dieser Bug eventuell schon im letzten Update (von 28.08.2008) von opsi Version 3.3 gefixt?
Gibt es ein Changelog des opsiconfd, das öffentlich einsehbar ist (um die vorige Frage zu klären)?
Vielen Dank schon mal an dieser Stelle für erhellende Antworten!
Beste Grüße,
Andreas Semt