Depotserver dynamisch - der richtige wird nicht gefunden
Verfasst: 02 Dez 2016, 11:58
Hallo,
aktuelle opsi-Version 4.0.7.X.
Wenn der Client am entfernten Standort den opsi-Depot Server ermittelt, ermittelt er (leider) den Config-Server, anstelle des lokalen Depot-Servers. Funktionieren tuts aber ...
Im lokalen Log-File C:\opsi.org\log\opsiclientd.log findet man Hinweise, dass die lokale IP nicht korrekt ermittelt werden konnte - s.w.u.
Da ich das Problem in keinem Thema finden konnte, scheint dies nur bei uns zu sein? Wir haben lauter Windows10-Clients ...
Über Hilfe würdfe ich mich freuen.
VG
Walter
Ich habe das (vermeintliche Problem) fett markiert:
[5] [Dec 01 21:31:16] [ event processing net_connection] Got config from service (Config.pyo|595)
[5] [Dec 01 21:31:16] [ event processing net_connection] Reconfiguring event generators (EventProcessing.pyo|250)
[5] [Dec 01 21:31:16] [ event processing net_connection] Event config 'gui_startup' is deactivated (Events.pyo|918)
[5] [Dec 01 21:31:16] [ event processing net_connection] Event config 'on_shutdown' is deactivated (Events.pyo|918)
[5] [Dec 01 21:31:16] [ event processing net_connection] Event config 'user_login' is deactivated (Events.pyo|918)
[5] [Dec 01 21:31:16] [ event processing net_connection] Event config 'timer_silentinstall' is deactivated (Events.pyo|918)
[5] [Dec 01 21:31:16] [ event processing net_connection] Event config 'on_demand' added to event generator 'on_demand' (Events.pyo|1132)
[5] [Dec 01 21:31:16] [ event processing net_connection] Event config 'silent_install' added to event generator 'silent_install' (Events.pyo|1132)
[5] [Dec 01 21:31:16] [ event processing net_connection] Event config 'timer' added to event generator 'timer' (Events.pyo|1132)
[5] [Dec 01 21:31:16] [ event processing net_connection] Event config 'sync_completed' added to event generator 'sync_completed' (Events.pyo|1132)
[5] [Dec 01 21:31:16] [ event processing net_connection] Event config 'net_connection' added to event generator 'net_connection' (Events.pyo|1132)
[5] [Dec 01 21:31:16] [ event processing net_connection] Event config 'software_on_demand' added to event generator 'software_on_demand' (Events.pyo|1132)
[5] [Dec 01 21:31:16] [ event processing net_connection] Updating config file: 'C:\Program Files (x86)\opsi.org\opsi-client-agent\opsiclientd\opsiclientd.conf' (Config.pyo|334)
[5] [Dec 01 21:31:16] [ event processing net_connection] No need to write config file 'C:\Program Files (x86)\opsi.org\opsi-client-agent\opsiclientd\opsiclientd.conf', config file is up to date (Config.pyo|365)
[5] [Dec 01 21:31:16] [ event processing net_connection] Writing log to service (EventProcessing.pyo|257)
[5] [Dec 01 21:31:17] [ config cache service ] Creating opsi base (SQL.pyo|465)
[5] [Dec 01 21:31:17] [ product cache service ] Selecting depot for products [u'putty'] (Config.pyo|391)
[5] [Dec 01 21:31:17] [ product cache service ] MasterOnly --> 'False' (Config.pyo|392)
[3] [Dec 01 21:31:17] [ config cache service ] 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)
[6] [Dec 01 21:31:17] [ config cache service ] Setting context to backend <ExtendedConfigDataBackend(configDataBackend=<JSONRPCBackend(host=u'172.21.25.20', deflate=False)>)> (Backend.pyo|460)
[5] [Dec 01 21:31:17] [ opsiclientd ] Shutdown request in Registry: 0 (Windows.pyo|327)
[5] [Dec 01 21:31:17] [ opsiclientd ] Reboot request in Registry: 0 (Windows.pyo|311)
[5] [Dec 01 21:31:17] [ opsiclientd ] Block login now set to 'False' (Opsiclientd.pyo|109)
[6] [Dec 01 21:31:17] [ event processing net_connection] Stopping notification server (EventProcessing.pyo|235)
[6] [Dec 01 21:31:18] [ event processing net_connection] Notification server stopped (Message.pyo|636)
[5] [Dec 01 21:31:18] [ event processing net_connection] ============= EventProcessingThread for event 'net_connection' ended ============= (EventProcessing.pyo|1276)
[5] [Dec 01 21:31:18] [ opsiclientd ] Done processing event '<ocdlib.Events.CustomEvent object at 0x0270C370>' (Opsiclientd.pyo|419)
[3] [Dec 01 21:31:18] [ config cache service ] 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)
[6] [Dec 01 21:31:18] [ config cache service ] Setting context to backend <ExtendedConfigDataBackend(configDataBackend=<SQLiteBackend()>)> (Backend.pyo|460)
[6] [Dec 01 21:31:18] [ config cache service ] Replicating: serverIds=[], depotIds=[u'v1054.sct.co.schwindt.intra'], clientIds=[u'l1058.schwindt.intra'], groupIds=[], productIds=[], productTypes=['LocalbootProduct'], audit: False, license: False (Replicator.pyo|128)
[6] [Dec 01 21:31:18] [ product cache service ] Dynamic depot selection enabled (Config.pyo|444)
[5] [Dec 01 21:31:18] [ config cache service ] Creating opsi base (SQL.pyo|465)
[6] [Dec 01 21:31:18] [ product cache service ] Master depot for products [u'putty'] is v1054.sct.co.schwindt.intra (Config.pyo|472)
[6] [Dec 01 21:31:18] [ product cache service ] Got alternative depots for products: [u'putty'] (Config.pyo|476)
[6] [Dec 01 21:31:18] [ product cache service ] 1. alternative depot is v1063.sct.wue.schwindt.intra (Config.pyo|478)
[6] [Dec 01 21:31:18] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x0291AE90> (Config.pyo|487)
[6] [Dec 01 21:31:18] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x0291AC60> (Config.pyo|487)
[6] [Dec 01 21:31:18] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x0291AE90> (Config.pyo|487)
[6] [Dec 01 21:31:18] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x0291AC60> (Config.pyo|487)
[6] [Dec 01 21:31:18] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x0291AE90> (Config.pyo|487)
[6] [Dec 01 21:31:18] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x0291AC60> (Config.pyo|487)
[6] [Dec 01 21:31:18] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x0291AE90> (Config.pyo|487)
[6] [Dec 01 21:31:18] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x0291AC60> (Config.pyo|487)
[6] [Dec 01 21:31:18] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x0291AE90> (Config.pyo|487)
[6] [Dec 01 21:31:18] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x0291AC60> (Config.pyo|487)
[6] [Dec 01 21:31:19] [ product cache service ] Choosing depot from list of depots: (<string>|4)
[6] [Dec 01 21:31:19] [ product cache service ] Master depot: <OpsiConfigserver(id=u'v1054.sct.co.schwindt.intra', isMasterDepot=True)> (<string>|5)
[6] [Dec 01 21:31:19] [ product cache service ] Alternative depot: <OpsiDepotserver(id=u'v1063.sct.wue.schwindt.intra', isMasterDepot=True)> (<string>|7)
[2] [Dec 01 21:31:19] [ product cache service ] Traceback: (Logger.pyo|753)
[2] [Dec 01 21:31:19] [ product cache service ] File "ocdlib\Config.pyo", line 508, in selectDepotserver
(Logger.pyo|753)
[2] [Dec 01 21:31:19] [ product cache service ] File "<string>", line 23, in selectDepot
(Logger.pyo|753)
[2] [Dec 01 21:31:19] [ product cache service ] File "OPSI\Util\__init__.pyo", line 754, in ipAddressInNetwork
(Logger.pyo|753)
[2] [Dec 01 21:31:19] [ product cache service ] File "OPSI\Types.pyo", line 305, in forceIPAddress
(Logger.pyo|753)
[2] [Dec 01 21:31:19] [ product cache service ] ==>>> Bad ip address: '' (Config.pyo|512)
[3] [Dec 01 21:31:19] [ product cache service ] Failed to select depot: Bad ip address: '' (Config.pyo|513)
[5] [Dec 01 21:31:19] [ product cache service ] Selected depot is: <OpsiConfigserver(id=u'v1054.sct.co.schwindt.intra', isMasterDepot=True)> (Config.pyo|516)
[6] [Dec 01 21:31:19] [ product cache service ] Setting config value depot_server.depot_id (Config.pyo|203)
[6] [Dec 01 21:31:19] [ product cache service ] Setting config value depot_server.url (Config.pyo|203)
[6] [Dec 01 21:31:20] [ product cache service ] Transfered 0.37 kByte in 0.00 minutes, average speed was 8.13 kByte/s (Repository.pyo|418)
[6] [Dec 01 21:31:20] [ product cache service ] Product 'putty' contains 7 files with a total size of 0.694 MB (CacheService.pyo|952)
[5] [Dec 01 21:31:21] [ product cache service ] Syncing product putty of depot <CIFSRepository(u'smb://v1054.sct.co.schwindt.intra/opsi_depot')> with local directory C:\opsi.org\cache\depot (Repository.pyo|1332)
[6] [Dec 01 21:31:21] [ product cache service ] Downloading package content file (Repository.pyo|1338)
[6] [Dec 01 21:31:21] [ product cache service ] Transfered 0.37 kByte in 0.00 minutes, average speed was 10.39 kByte/s (Repository.pyo|418)
[5] [Dec 01 21:31:21] [ product cache service ] Product 'putty' cached (CacheService.pyo|995)
[5] [Dec 01 21:31:21] [ product cache service ] Caching product 'opsi-winst' (max bandwidth: 0, dynamic bandwidth: True) (CacheService.pyo|919)
[5] [Dec 01 21:31:22] [ product cache service ] Selecting depot for products [u'opsi-winst'] (Config.pyo|391)
[5] [Dec 01 21:31:22] [ product cache service ] MasterOnly --> 'False' (Config.pyo|392)
[6] [Dec 01 21:31:22] [ product cache service ] Dynamic depot selection enabled (Config.pyo|444)
[6] [Dec 01 21:31:23] [ product cache service ] Master depot for products [u'opsi-winst'] is v1054.sct.co.schwindt.intra (Config.pyo|472)
[6] [Dec 01 21:31:23] [ product cache service ] Got alternative depots for products: [u'opsi-winst'] (Config.pyo|476)
[6] [Dec 01 21:31:23] [ product cache service ] 1. alternative depot is v1063.sct.wue.schwindt.intra (Config.pyo|478)
[6] [Dec 01 21:31:23] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x027186C0> (Config.pyo|487)
[6] [Dec 01 21:31:23] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x02718620> (Config.pyo|487)
[6] [Dec 01 21:31:23] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x027186C0> (Config.pyo|487)
[6] [Dec 01 21:31:23] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x02718620> (Config.pyo|487)
[6] [Dec 01 21:31:23] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x027186C0> (Config.pyo|487)
[6] [Dec 01 21:31:23] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x02718620> (Config.pyo|487)
[6] [Dec 01 21:31:23] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x027186C0> (Config.pyo|487)
[6] [Dec 01 21:31:23] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x02718620> (Config.pyo|487)
[6] [Dec 01 21:31:23] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x027186C0> (Config.pyo|487)
[6] [Dec 01 21:31:23] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x02718620> (Config.pyo|487)
[6] [Dec 01 21:31:23] [ product cache service ] Choosing depot from list of depots: (<string>|4)
[6] [Dec 01 21:31:23] [ product cache service ] Master depot: <OpsiConfigserver(id=u'v1054.sct.co.schwindt.intra', isMasterDepot=True)> (<string>|5)
[6] [Dec 01 21:31:23] [ product cache service ] Alternative depot: <OpsiDepotserver(id=u'v1063.sct.wue.schwindt.intra', isMasterDepot=True)> (<string>|7)
[2] [Dec 01 21:31:23] [ product cache service ] Traceback: (Logger.pyo|753)
[2] [Dec 01 21:31:23] [ product cache service ] File "ocdlib\Config.pyo", line 508, in selectDepotserver
(Logger.pyo|753)
[2] [Dec 01 21:31:23] [ product cache service ] File "<string>", line 23, in selectDepot
(Logger.pyo|753)
[2] [Dec 01 21:31:23] [ product cache service ] File "OPSI\Util\__init__.pyo", line 754, in ipAddressInNetwork
(Logger.pyo|753)
[2] [Dec 01 21:31:23] [ product cache service ] File "OPSI\Types.pyo", line 305, in forceIPAddress
(Logger.pyo|753)
[2] [Dec 01 21:31:23] [ product cache service ] ==>>> Bad ip address: '' (Config.pyo|512)
[3] [Dec 01 21:31:23] [ product cache service ] Failed to select depot: Bad ip address: '' (Config.pyo|513)
[5] [Dec 01 21:31:23] [ product cache service ] Selected depot is: <OpsiConfigserver(id=u'v1054.sct.co.schwindt.intra', isMasterDepot=True)> (Config.pyo|516)
[6] [Dec 01 21:31:23] [ product cache service ] Setting config value depot_server.depot_id (Config.pyo|203)
[6] [Dec 01 21:31:23] [ product cache service ] Setting config value depot_server.url (Config.pyo|203)
[6] [Dec 01 21:31:24] [ product cache service ] Transfered 1.89 kByte in 0.00 minutes, average speed was 49.73 kByte/s (Repository.pyo|418)
[6] [Dec 01 21:31:24] [ product cache service ] Product 'opsi-winst' contains 27 files with a total size of 6.506 MB (CacheService.pyo|952)
[5] [Dec 01 21:31:24] [ product cache service ] Syncing product opsi-winst of depot <CIFSRepository(u'smb://v1054.sct.co.schwindt.intra/opsi_depot')> with local directory C:\opsi.org\cache\depot (Repository.pyo|1332)
[6] [Dec 01 21:31:24] [ product cache service ] Downloading package content file (Repository.pyo|1338)
[6] [Dec 01 21:31:24] [ product cache service ] Transfered 1.89 kByte in 0.00 minutes, average speed was 51.07 kByte/s (Repository.pyo|418)
[5] [Dec 01 21:31:25] [ config cache service ] Creating opsi base (SQL.pyo|465)
[5] [Dec 01 21:31:25] [ product cache service ] Product 'opsi-winst' cached (CacheService.pyo|995)
[3] [Dec 01 21:31:25] [ config cache service ] 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)
[6] [Dec 01 21:31:25] [ config cache service ] Setting context to backend <ExtendedConfigDataBackend(configDataBackend=<SQLiteBackend()>)> (Backend.pyo|460)
[3] [Dec 01 21:31:25] [ config cache service ] 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)
[6] [Dec 01 21:31:25] [ config cache service ] Setting context to backend <ExtendedConfigDataBackend(configDataBackend=<SQLiteBackend()>)> (Backend.pyo|460)
[6] [Dec 01 21:31:25] [ config cache service ] Replicating: serverIds=[], depotIds=[], clientIds=[], groupIds=[], productIds=[], productTypes=[], audit: True, license: True (Replicator.pyo|128)
[5] [Dec 01 21:31:25] [ config cache service ] Creating opsi base (SQL.pyo|465)
[5] [Dec 01 21:31:25] [ product cache service ] All products cached: putty, opsi-winst (CacheService.pyo|837)
[6] [Dec 01 21:31:25] [ event generator sync_completed] Firing event '<ocdlib.Events.SyncCompletedEvent object at 0x0564A890>' (Events.pyo|443)
[6] [Dec 01 21:31:25] [ event generator sync_completed] Event info: (Events.pyo|444)
[6] [Dec 01 21:31:25] [ event generator sync_completed] Starting FireEventThread for listeners: [<OpsiclientdNT61(Thread-1, started daemon 5820)>] (Events.pyo|467)
[6] [Dec 01 21:31:25] [ event generator sync_completed] Calling processEvent on listener <OpsiclientdNT61(Thread-1, started daemon 5820)> (Events.pyo|462)
[5] [Dec 01 21:31:25] [ opsiclientd ] Processing event <ocdlib.Events.SyncCompletedEvent object at 0x0564A890> (Opsiclientd.pyo|384)
[6] [Dec 01 21:31:25] [ event processing sync_completed] Session id set to 1 (EventProcessing.pyo|173)
[5] [Dec 01 21:31:25] [ event processing sync_completed] ============= EventProcessingThread for occurrcence of event 'sync_completed' started ============= (EventProcessing.pyo|1116)
[5] [Dec 01 21:31:25] [ opsiclientd ] Block login now set to 'False' (Opsiclientd.pyo|109)
[5] [Dec 01 21:31:25] [ event processing sync_completed] Starting notification server on port 44003 (EventProcessing.pyo|194)
[6] [Dec 01 21:31:25] [ opsiclientd ] Notification server starting (Message.pyo|594)
[5] [Dec 01 21:31:26] [ event processing sync_completed] Notification server started (EventProcessing.pyo|221)
[6] [Dec 01 21:31:26] [ event processing sync_completed] Action processor name 'opsi-script', version '4.11.6.8' (EventProcessing.pyo|351)
[5] [Dec 01 21:31:26] [ opsiclientd ] Block login now set to 'False' (Opsiclientd.pyo|109)
[5] [Dec 01 21:31:26] [ opsiclientd ] Shutdown request in Registry: 0 (Windows.pyo|327)
[5] [Dec 01 21:31:26] [ opsiclientd ] Reboot request in Registry: 0 (Windows.pyo|311)
[5] [Dec 01 21:31:26] [ opsiclientd ] Block login now set to 'False' (Opsiclientd.pyo|109)
[6] [Dec 01 21:31:26] [ event processing sync_completed] Stopping notification server (EventProcessing.pyo|235)
[6] [Dec 01 21:31:27] [ event processing sync_completed] Notification server stopped (Message.pyo|636)
[5] [Dec 01 21:31:27] [ event processing sync_completed] ============= EventProcessingThread for event 'sync_completed' ended ============= (EventProcessing.pyo|1276)
[5] [Dec 01 21:31:27] [ opsiclientd ] Done processing event '<ocdlib.Events.SyncCompletedEvent object at 0x0564A890>' (Opsiclientd.pyo|419)
aktuelle opsi-Version 4.0.7.X.
Wenn der Client am entfernten Standort den opsi-Depot Server ermittelt, ermittelt er (leider) den Config-Server, anstelle des lokalen Depot-Servers. Funktionieren tuts aber ...
Im lokalen Log-File C:\opsi.org\log\opsiclientd.log findet man Hinweise, dass die lokale IP nicht korrekt ermittelt werden konnte - s.w.u.
Da ich das Problem in keinem Thema finden konnte, scheint dies nur bei uns zu sein? Wir haben lauter Windows10-Clients ...
Über Hilfe würdfe ich mich freuen.
VG
Walter
Ich habe das (vermeintliche Problem) fett markiert:
[5] [Dec 01 21:31:16] [ event processing net_connection] Got config from service (Config.pyo|595)
[5] [Dec 01 21:31:16] [ event processing net_connection] Reconfiguring event generators (EventProcessing.pyo|250)
[5] [Dec 01 21:31:16] [ event processing net_connection] Event config 'gui_startup' is deactivated (Events.pyo|918)
[5] [Dec 01 21:31:16] [ event processing net_connection] Event config 'on_shutdown' is deactivated (Events.pyo|918)
[5] [Dec 01 21:31:16] [ event processing net_connection] Event config 'user_login' is deactivated (Events.pyo|918)
[5] [Dec 01 21:31:16] [ event processing net_connection] Event config 'timer_silentinstall' is deactivated (Events.pyo|918)
[5] [Dec 01 21:31:16] [ event processing net_connection] Event config 'on_demand' added to event generator 'on_demand' (Events.pyo|1132)
[5] [Dec 01 21:31:16] [ event processing net_connection] Event config 'silent_install' added to event generator 'silent_install' (Events.pyo|1132)
[5] [Dec 01 21:31:16] [ event processing net_connection] Event config 'timer' added to event generator 'timer' (Events.pyo|1132)
[5] [Dec 01 21:31:16] [ event processing net_connection] Event config 'sync_completed' added to event generator 'sync_completed' (Events.pyo|1132)
[5] [Dec 01 21:31:16] [ event processing net_connection] Event config 'net_connection' added to event generator 'net_connection' (Events.pyo|1132)
[5] [Dec 01 21:31:16] [ event processing net_connection] Event config 'software_on_demand' added to event generator 'software_on_demand' (Events.pyo|1132)
[5] [Dec 01 21:31:16] [ event processing net_connection] Updating config file: 'C:\Program Files (x86)\opsi.org\opsi-client-agent\opsiclientd\opsiclientd.conf' (Config.pyo|334)
[5] [Dec 01 21:31:16] [ event processing net_connection] No need to write config file 'C:\Program Files (x86)\opsi.org\opsi-client-agent\opsiclientd\opsiclientd.conf', config file is up to date (Config.pyo|365)
[5] [Dec 01 21:31:16] [ event processing net_connection] Writing log to service (EventProcessing.pyo|257)
[5] [Dec 01 21:31:17] [ config cache service ] Creating opsi base (SQL.pyo|465)
[5] [Dec 01 21:31:17] [ product cache service ] Selecting depot for products [u'putty'] (Config.pyo|391)
[5] [Dec 01 21:31:17] [ product cache service ] MasterOnly --> 'False' (Config.pyo|392)
[3] [Dec 01 21:31:17] [ config cache service ] 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)
[6] [Dec 01 21:31:17] [ config cache service ] Setting context to backend <ExtendedConfigDataBackend(configDataBackend=<JSONRPCBackend(host=u'172.21.25.20', deflate=False)>)> (Backend.pyo|460)
[5] [Dec 01 21:31:17] [ opsiclientd ] Shutdown request in Registry: 0 (Windows.pyo|327)
[5] [Dec 01 21:31:17] [ opsiclientd ] Reboot request in Registry: 0 (Windows.pyo|311)
[5] [Dec 01 21:31:17] [ opsiclientd ] Block login now set to 'False' (Opsiclientd.pyo|109)
[6] [Dec 01 21:31:17] [ event processing net_connection] Stopping notification server (EventProcessing.pyo|235)
[6] [Dec 01 21:31:18] [ event processing net_connection] Notification server stopped (Message.pyo|636)
[5] [Dec 01 21:31:18] [ event processing net_connection] ============= EventProcessingThread for event 'net_connection' ended ============= (EventProcessing.pyo|1276)
[5] [Dec 01 21:31:18] [ opsiclientd ] Done processing event '<ocdlib.Events.CustomEvent object at 0x0270C370>' (Opsiclientd.pyo|419)
[3] [Dec 01 21:31:18] [ config cache service ] 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)
[6] [Dec 01 21:31:18] [ config cache service ] Setting context to backend <ExtendedConfigDataBackend(configDataBackend=<SQLiteBackend()>)> (Backend.pyo|460)
[6] [Dec 01 21:31:18] [ config cache service ] Replicating: serverIds=[], depotIds=[u'v1054.sct.co.schwindt.intra'], clientIds=[u'l1058.schwindt.intra'], groupIds=[], productIds=[], productTypes=['LocalbootProduct'], audit: False, license: False (Replicator.pyo|128)
[6] [Dec 01 21:31:18] [ product cache service ] Dynamic depot selection enabled (Config.pyo|444)
[5] [Dec 01 21:31:18] [ config cache service ] Creating opsi base (SQL.pyo|465)
[6] [Dec 01 21:31:18] [ product cache service ] Master depot for products [u'putty'] is v1054.sct.co.schwindt.intra (Config.pyo|472)
[6] [Dec 01 21:31:18] [ product cache service ] Got alternative depots for products: [u'putty'] (Config.pyo|476)
[6] [Dec 01 21:31:18] [ product cache service ] 1. alternative depot is v1063.sct.wue.schwindt.intra (Config.pyo|478)
[6] [Dec 01 21:31:18] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x0291AE90> (Config.pyo|487)
[6] [Dec 01 21:31:18] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x0291AC60> (Config.pyo|487)
[6] [Dec 01 21:31:18] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x0291AE90> (Config.pyo|487)
[6] [Dec 01 21:31:18] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x0291AC60> (Config.pyo|487)
[6] [Dec 01 21:31:18] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x0291AE90> (Config.pyo|487)
[6] [Dec 01 21:31:18] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x0291AC60> (Config.pyo|487)
[6] [Dec 01 21:31:18] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x0291AE90> (Config.pyo|487)
[6] [Dec 01 21:31:18] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x0291AC60> (Config.pyo|487)
[6] [Dec 01 21:31:18] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x0291AE90> (Config.pyo|487)
[6] [Dec 01 21:31:18] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x0291AC60> (Config.pyo|487)
[6] [Dec 01 21:31:19] [ product cache service ] Choosing depot from list of depots: (<string>|4)
[6] [Dec 01 21:31:19] [ product cache service ] Master depot: <OpsiConfigserver(id=u'v1054.sct.co.schwindt.intra', isMasterDepot=True)> (<string>|5)
[6] [Dec 01 21:31:19] [ product cache service ] Alternative depot: <OpsiDepotserver(id=u'v1063.sct.wue.schwindt.intra', isMasterDepot=True)> (<string>|7)
[2] [Dec 01 21:31:19] [ product cache service ] Traceback: (Logger.pyo|753)
[2] [Dec 01 21:31:19] [ product cache service ] File "ocdlib\Config.pyo", line 508, in selectDepotserver
(Logger.pyo|753)
[2] [Dec 01 21:31:19] [ product cache service ] File "<string>", line 23, in selectDepot
(Logger.pyo|753)
[2] [Dec 01 21:31:19] [ product cache service ] File "OPSI\Util\__init__.pyo", line 754, in ipAddressInNetwork
(Logger.pyo|753)
[2] [Dec 01 21:31:19] [ product cache service ] File "OPSI\Types.pyo", line 305, in forceIPAddress
(Logger.pyo|753)
[2] [Dec 01 21:31:19] [ product cache service ] ==>>> Bad ip address: '' (Config.pyo|512)
[3] [Dec 01 21:31:19] [ product cache service ] Failed to select depot: Bad ip address: '' (Config.pyo|513)
[5] [Dec 01 21:31:19] [ product cache service ] Selected depot is: <OpsiConfigserver(id=u'v1054.sct.co.schwindt.intra', isMasterDepot=True)> (Config.pyo|516)
[6] [Dec 01 21:31:19] [ product cache service ] Setting config value depot_server.depot_id (Config.pyo|203)
[6] [Dec 01 21:31:19] [ product cache service ] Setting config value depot_server.url (Config.pyo|203)
[6] [Dec 01 21:31:20] [ product cache service ] Transfered 0.37 kByte in 0.00 minutes, average speed was 8.13 kByte/s (Repository.pyo|418)
[6] [Dec 01 21:31:20] [ product cache service ] Product 'putty' contains 7 files with a total size of 0.694 MB (CacheService.pyo|952)
[5] [Dec 01 21:31:21] [ product cache service ] Syncing product putty of depot <CIFSRepository(u'smb://v1054.sct.co.schwindt.intra/opsi_depot')> with local directory C:\opsi.org\cache\depot (Repository.pyo|1332)
[6] [Dec 01 21:31:21] [ product cache service ] Downloading package content file (Repository.pyo|1338)
[6] [Dec 01 21:31:21] [ product cache service ] Transfered 0.37 kByte in 0.00 minutes, average speed was 10.39 kByte/s (Repository.pyo|418)
[5] [Dec 01 21:31:21] [ product cache service ] Product 'putty' cached (CacheService.pyo|995)
[5] [Dec 01 21:31:21] [ product cache service ] Caching product 'opsi-winst' (max bandwidth: 0, dynamic bandwidth: True) (CacheService.pyo|919)
[5] [Dec 01 21:31:22] [ product cache service ] Selecting depot for products [u'opsi-winst'] (Config.pyo|391)
[5] [Dec 01 21:31:22] [ product cache service ] MasterOnly --> 'False' (Config.pyo|392)
[6] [Dec 01 21:31:22] [ product cache service ] Dynamic depot selection enabled (Config.pyo|444)
[6] [Dec 01 21:31:23] [ product cache service ] Master depot for products [u'opsi-winst'] is v1054.sct.co.schwindt.intra (Config.pyo|472)
[6] [Dec 01 21:31:23] [ product cache service ] Got alternative depots for products: [u'opsi-winst'] (Config.pyo|476)
[6] [Dec 01 21:31:23] [ product cache service ] 1. alternative depot is v1063.sct.wue.schwindt.intra (Config.pyo|478)
[6] [Dec 01 21:31:23] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x027186C0> (Config.pyo|487)
[6] [Dec 01 21:31:23] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x02718620> (Config.pyo|487)
[6] [Dec 01 21:31:23] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x027186C0> (Config.pyo|487)
[6] [Dec 01 21:31:23] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x02718620> (Config.pyo|487)
[6] [Dec 01 21:31:23] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x027186C0> (Config.pyo|487)
[6] [Dec 01 21:31:23] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x02718620> (Config.pyo|487)
[6] [Dec 01 21:31:23] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x027186C0> (Config.pyo|487)
[6] [Dec 01 21:31:23] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x02718620> (Config.pyo|487)
[6] [Dec 01 21:31:23] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x027186C0> (Config.pyo|487)
[6] [Dec 01 21:31:23] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x02718620> (Config.pyo|487)
[6] [Dec 01 21:31:23] [ product cache service ] Choosing depot from list of depots: (<string>|4)
[6] [Dec 01 21:31:23] [ product cache service ] Master depot: <OpsiConfigserver(id=u'v1054.sct.co.schwindt.intra', isMasterDepot=True)> (<string>|5)
[6] [Dec 01 21:31:23] [ product cache service ] Alternative depot: <OpsiDepotserver(id=u'v1063.sct.wue.schwindt.intra', isMasterDepot=True)> (<string>|7)
[2] [Dec 01 21:31:23] [ product cache service ] Traceback: (Logger.pyo|753)
[2] [Dec 01 21:31:23] [ product cache service ] File "ocdlib\Config.pyo", line 508, in selectDepotserver
(Logger.pyo|753)
[2] [Dec 01 21:31:23] [ product cache service ] File "<string>", line 23, in selectDepot
(Logger.pyo|753)
[2] [Dec 01 21:31:23] [ product cache service ] File "OPSI\Util\__init__.pyo", line 754, in ipAddressInNetwork
(Logger.pyo|753)
[2] [Dec 01 21:31:23] [ product cache service ] File "OPSI\Types.pyo", line 305, in forceIPAddress
(Logger.pyo|753)
[2] [Dec 01 21:31:23] [ product cache service ] ==>>> Bad ip address: '' (Config.pyo|512)
[3] [Dec 01 21:31:23] [ product cache service ] Failed to select depot: Bad ip address: '' (Config.pyo|513)
[5] [Dec 01 21:31:23] [ product cache service ] Selected depot is: <OpsiConfigserver(id=u'v1054.sct.co.schwindt.intra', isMasterDepot=True)> (Config.pyo|516)
[6] [Dec 01 21:31:23] [ product cache service ] Setting config value depot_server.depot_id (Config.pyo|203)
[6] [Dec 01 21:31:23] [ product cache service ] Setting config value depot_server.url (Config.pyo|203)
[6] [Dec 01 21:31:24] [ product cache service ] Transfered 1.89 kByte in 0.00 minutes, average speed was 49.73 kByte/s (Repository.pyo|418)
[6] [Dec 01 21:31:24] [ product cache service ] Product 'opsi-winst' contains 27 files with a total size of 6.506 MB (CacheService.pyo|952)
[5] [Dec 01 21:31:24] [ product cache service ] Syncing product opsi-winst of depot <CIFSRepository(u'smb://v1054.sct.co.schwindt.intra/opsi_depot')> with local directory C:\opsi.org\cache\depot (Repository.pyo|1332)
[6] [Dec 01 21:31:24] [ product cache service ] Downloading package content file (Repository.pyo|1338)
[6] [Dec 01 21:31:24] [ product cache service ] Transfered 1.89 kByte in 0.00 minutes, average speed was 51.07 kByte/s (Repository.pyo|418)
[5] [Dec 01 21:31:25] [ config cache service ] Creating opsi base (SQL.pyo|465)
[5] [Dec 01 21:31:25] [ product cache service ] Product 'opsi-winst' cached (CacheService.pyo|995)
[3] [Dec 01 21:31:25] [ config cache service ] 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)
[6] [Dec 01 21:31:25] [ config cache service ] Setting context to backend <ExtendedConfigDataBackend(configDataBackend=<SQLiteBackend()>)> (Backend.pyo|460)
[3] [Dec 01 21:31:25] [ config cache service ] 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)
[6] [Dec 01 21:31:25] [ config cache service ] Setting context to backend <ExtendedConfigDataBackend(configDataBackend=<SQLiteBackend()>)> (Backend.pyo|460)
[6] [Dec 01 21:31:25] [ config cache service ] Replicating: serverIds=[], depotIds=[], clientIds=[], groupIds=[], productIds=[], productTypes=[], audit: True, license: True (Replicator.pyo|128)
[5] [Dec 01 21:31:25] [ config cache service ] Creating opsi base (SQL.pyo|465)
[5] [Dec 01 21:31:25] [ product cache service ] All products cached: putty, opsi-winst (CacheService.pyo|837)
[6] [Dec 01 21:31:25] [ event generator sync_completed] Firing event '<ocdlib.Events.SyncCompletedEvent object at 0x0564A890>' (Events.pyo|443)
[6] [Dec 01 21:31:25] [ event generator sync_completed] Event info: (Events.pyo|444)
[6] [Dec 01 21:31:25] [ event generator sync_completed] Starting FireEventThread for listeners: [<OpsiclientdNT61(Thread-1, started daemon 5820)>] (Events.pyo|467)
[6] [Dec 01 21:31:25] [ event generator sync_completed] Calling processEvent on listener <OpsiclientdNT61(Thread-1, started daemon 5820)> (Events.pyo|462)
[5] [Dec 01 21:31:25] [ opsiclientd ] Processing event <ocdlib.Events.SyncCompletedEvent object at 0x0564A890> (Opsiclientd.pyo|384)
[6] [Dec 01 21:31:25] [ event processing sync_completed] Session id set to 1 (EventProcessing.pyo|173)
[5] [Dec 01 21:31:25] [ event processing sync_completed] ============= EventProcessingThread for occurrcence of event 'sync_completed' started ============= (EventProcessing.pyo|1116)
[5] [Dec 01 21:31:25] [ opsiclientd ] Block login now set to 'False' (Opsiclientd.pyo|109)
[5] [Dec 01 21:31:25] [ event processing sync_completed] Starting notification server on port 44003 (EventProcessing.pyo|194)
[6] [Dec 01 21:31:25] [ opsiclientd ] Notification server starting (Message.pyo|594)
[5] [Dec 01 21:31:26] [ event processing sync_completed] Notification server started (EventProcessing.pyo|221)
[6] [Dec 01 21:31:26] [ event processing sync_completed] Action processor name 'opsi-script', version '4.11.6.8' (EventProcessing.pyo|351)
[5] [Dec 01 21:31:26] [ opsiclientd ] Block login now set to 'False' (Opsiclientd.pyo|109)
[5] [Dec 01 21:31:26] [ opsiclientd ] Shutdown request in Registry: 0 (Windows.pyo|327)
[5] [Dec 01 21:31:26] [ opsiclientd ] Reboot request in Registry: 0 (Windows.pyo|311)
[5] [Dec 01 21:31:26] [ opsiclientd ] Block login now set to 'False' (Opsiclientd.pyo|109)
[6] [Dec 01 21:31:26] [ event processing sync_completed] Stopping notification server (EventProcessing.pyo|235)
[6] [Dec 01 21:31:27] [ event processing sync_completed] Notification server stopped (Message.pyo|636)
[5] [Dec 01 21:31:27] [ event processing sync_completed] ============= EventProcessingThread for event 'sync_completed' ended ============= (EventProcessing.pyo|1276)
[5] [Dec 01 21:31:27] [ opsiclientd ] Done processing event '<ocdlib.Events.SyncCompletedEvent object at 0x0564A890>' (Opsiclientd.pyo|419)