[Apr 02 12:08:22] [ event processing gui_startup ] Choosing depot with networkAddress 192.168.248.0/255.255.252.0 for ip 192.168.248.23 (<string>|45)
[5] [Apr 02 12:08:22] [ event processing gui_startup ] Selected depot is: <OpsiConfigserver id 'opsi.stute.loc'> (Config.pyo|505)
[6] [Apr 02 12:08:22] [ event processing gui_startup ] Setting config value depot_server.depot_id (Config.pyo|198)
[6] [Apr 02 12:08:22] [ event processing gui_startup ] Setting config value depot_server.url (Config.pyo|198)
[5] [Apr 02 12:08:22] [ event processing gui_startup ] Getting TrustedInstaller service configuration (EventProcessing.pyo|715)
[6] [Apr 02 12:08:22] [ opsiclientd ] Searching pids of process name winlogon.exe (session id: 1) (Windows.pyo|1335)
[6] [Apr 02 12:08:22] [ opsiclientd ] Found process winlogon.exe with matching name (pid 872, session 1) (Windows.pyo|1357)
[5] [Apr 02 12:08:22] [ opsiclientd ] Executing: 'C:\Program Files (x86)\opsi.org\opsi-client-agent\\opsiclientd_rpc.exe "mycomputer" "*** confidential ***" "4441" "setCurrentActiveDesktopName("1", System.getActiveDesktopName())"' in session '1' on desktop 'winsta0\winlogon' (Windows.pyo|1514)
[6] [Apr 02 12:08:22] [ opsiclientd ] Process startet, pid: 3832 (Windows.pyo|1517)
[6] [Apr 02 12:08:22] [ opsiclientd ] Waiting for process ending: 3832 (timeout: 60 seconds) (Windows.pyo|1520)
[6] [Apr 02 12:08:24] [ control server ] Worker <ocdlib.ControlServer.WorkerOpsiclientdJsonRpc instance at 0x024A0120> started processing (Worker.pyo|244)
[5] [Apr 02 12:08:24] [ control server ] New session created (Session.pyo|179)
[5] [Apr 02 12:08:24] [ control server ] Authorization request from mycomputer@127.0.0.1 (application: opsi jsonrpc module version 4.0.2) (ControlServer.pyo|144)
[5] [Apr 02 12:08:24] [ opsiclientd ] -----> Executing: backend_getInterface() (JsonRpc.pyo|123)
[6] [Apr 02 12:08:24] [ opsiclientd ] Got result (JsonRpc.pyo|131)
[6] [Apr 02 12:08:24] [ control server ] Worker <ocdlib.ControlServer.WorkerOpsiclientdJsonRpc instance at 0x0257E0F8> started processing (Worker.pyo|244)
[6] [Apr 02 12:08:24] [ control server ] Reusing session for client '127.0.0.1', application 'opsi jsonrpc module version 4.0.2' (Worker.pyo|391)
[5] [Apr 02 12:08:24] [ control server ] Authorization request from mycomputer@127.0.0.1 (application: opsi jsonrpc module version 4.0.2) (ControlServer.pyo|144)
[5] [Apr 02 12:08:24] [ opsiclientd ] -----> Executing: setCurrentActiveDesktopName(1, u'Winlogon') (JsonRpc.pyo|123)
[5] [Apr 02 12:08:24] [ opsiclientd ] rpc setCurrentActiveDesktopName: current active desktop name for session 1 set to 'Winlogon' (ControlServer.pyo|536)
[6] [Apr 02 12:08:24] [ opsiclientd ] Got result (JsonRpc.pyo|131)
[6] [Apr 02 12:08:24] [ control server ] Worker <ocdlib.ControlServer.WorkerOpsiclientdJsonRpc instance at 0x024A2378> started processing (Worker.pyo|244)
[6] [Apr 02 12:08:24] [ control server ] Reusing session for client '127.0.0.1', application 'opsi jsonrpc module version 4.0.2' (Worker.pyo|391)
[5] [Apr 02 12:08:24] [ control server ] Authorization request from mycomputer@127.0.0.1 (application: opsi jsonrpc module version 4.0.2) (ControlServer.pyo|144)
[5] [Apr 02 12:08:24] [ opsiclientd ] -----> Executing: backend_exit() (JsonRpc.pyo|123)
[6] [Apr 02 12:08:24] [ opsiclientd ] Got result (JsonRpc.pyo|131)
[5] [Apr 02 12:08:24] [ opsiclientd ] Process 3832 ended with exit code 0 (Windows.pyo|1530)
[5] [Apr 02 12:08:24] [ event processing gui_startup ] Updating action processor (EventProcessing.pyo|401)
[5] [Apr 02 12:08:24] [ event processing gui_startup ] Mounting depot share smb://opsi.stute.loc/opt_pcbin/install (EventProcessing.pyo|369)
[6] [Apr 02 12:08:24] [ event processing gui_startup ] Added depot 'opsi.stute.loc' to trusted domains (EventProcessing.pyo|378)
[5] [Apr 02 12:08:24] [ event processing gui_startup ] Mounting '\\opsi.stute.loc\opt_pcbin' to 'p:' (Windows.pyo|670)
[6] [Apr 02 12:08:24] [ product cache service ] Transfered 0.29 kByte in 0.00 minutes, average speed was 18.19 kByte/s (Repository.pyo|370)
[6] [Apr 02 12:08:24] [ product cache service ] Product 'opt-bla-bla' contains 5 files with a total size of 109.452 MB (CacheService.pyo|885)
[6] [Apr 02 12:08:24] [ product cache service ] Product cache dir sizelimit of 50.000 MB exceeded. Current size: 6.295 MB, space needed for product 'opt-bla-bla': 109.452 MB (CacheService.pyo|893)
[6] [Apr 02 12:08:24] [ product cache service ] Traceback: (Logger.pyo|742)
[6] [Apr 02 12:08:24] [ product cache service ] line 756 in '_cacheProducts' in file 'ocdlibnonfree\CacheService.pyo' (Logger.pyo|742)
[6] [Apr 02 12:08:24] [ product cache service ] line 950 in '_cacheProduct' in file 'ocdlibnonfree\CacheService.pyo' (Logger.pyo|742)
[6] [Apr 02 12:08:24] [ product cache service ] ==>>> Failed to free enough disk space for product cache: Needed space: 65.748 MB, maximum freeable space: 0.002 MB (CacheService.pyo|758)
[5] [Apr 02 12:08:25] [ event processing gui_startup ] Updating action processor from depot dir 'p:\install\opsi-winst\\files\\opsi-winst' (EventProcessing.pyo|448)
[5] [Apr 02 12:08:25] [ event processing gui_startup ] Local action processor exists and seems to be up to date (EventProcessing.pyo|459)
[5] [Apr 02 12:08:25] [ event processing gui_startup ] Unmounting depot share (EventProcessing.pyo|394)
[5] [Apr 02 12:08:25] [ event processing gui_startup ] Starting action processor in session '1' on desktop 'winlogon' (EventProcessing.pyo|811)
[6] [Apr 02 12:08:25] [ event processing gui_startup ] Running command C:\Program Files (x86)\opsi.org\opsi-client-agent\action_processor_starter.exe "mycomputer" "*** confidential ***" "4441" "c:\\tmp\\opsiclientd.log" "6" "smb://opsi.stute.loc/opt_pcbin/install" "p:" "pcpatch" "*** confidential ***" "1" "winlogon" "\"C:\Program Files (x86)\opsi.org\opsi-client-agent\\opsi-winst\\winst32.exe\" /opsiservice \"
https://opsi.stute.loc:4447/rpc\" /clientid stute-pc-0441.stute.loc /username mycomputer /password *** confidential *** " 10800 "" "" false in session '1' on desktop 'winlogon' (EventProcessing.pyo|301)
[6] [Apr 02 12:08:25] [ event processing gui_startup ] Searching pids of process name winlogon.exe (session id: 1) (Windows.pyo|1335)
[6] [Apr 02 12:08:25] [ event processing gui_startup ] Found process winlogon.exe with matching name (pid 872, session 1) (Windows.pyo|1357)
[5] [Apr 02 12:08:25] [ event processing gui_startup ] Executing: 'C:\Program Files (x86)\opsi.org\opsi-client-agent\action_processor_starter.exe "mycomputer" "*** confidential ***" "4441" "c:\\tmp\\opsiclientd.log" "6" "smb://opsi.stute.loc/opt_pcbin/install" "p:" "pcpatch" "*** confidential ***" "1" "winlogon" "\"C:\Program Files (x86)\opsi.org\opsi-client-agent\\opsi-winst\\winst32.exe\" /opsiservice \"
https://opsi.stute.loc:4447/rpc\" /clientid mycomputer /username mycomputer /password *** confidential *** " 10800 "" "" false' in session '1' on desktop 'winsta0\winlogon' (Windows.pyo|1514)
[5] [Apr 02 12:08:25] [ product cache service ] Caching product 'opsi-winst' (max bandwidth: 0, dynamic bandwidth: False) (CacheService.pyo|852)
[6] [Apr 02 12:08:25] [ event processing gui_startup ] Process startet, pid: 3916 (Windows.pyo|1517)
[6] [Apr 02 12:08:25] [ event processing gui_startup ] Waiting for process ending: 3916 (timeout: 0 seconds) (Windows.pyo|1520)
[5] [Apr 02 12:08:25] [ product cache service ] Selecting depot for products [u'opsi-winst'] (Config.pyo|380)
[5] [Apr 02 12:08:25] [ product cache service ] MasterOnly --> 'False' (Config.pyo|381)
[6] [Apr 02 12:08:25] [ product cache service ] Dynamic depot selection enabled (Config.pyo|433)
[6] [Apr 02 12:08:25] [ product cache service ] Master depot for products [u'opsi-winst'] is opsi.stute.loc (Config.pyo|461)
[6] [Apr 02 12:08:25] [ product cache service ] Got alternative depots for products: [u'opsi-winst'] (Config.pyo|465)
[6] [Apr 02 12:08:26] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x0254DE90> (Config.pyo|476)
[6] [Apr 02 12:08:26] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x0254DE40> (Config.pyo|476)
[6] [Apr 02 12:08:26] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x0254DE90> (Config.pyo|476)
[6] [Apr 02 12:08:26] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x0254DE40> (Config.pyo|476)
[6] [Apr 02 12:08:26] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x0254DE90> (Config.pyo|476)
[6] [Apr 02 12:08:26] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x0254DE40> (Config.pyo|476)
[6] [Apr 02 12:08:26] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x0254DE90> (Config.pyo|476)
[6] [Apr 02 12:08:26] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x0254DE40> (Config.pyo|476)
[6] [Apr 02 12:08:26] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x0254DE90> (Config.pyo|476)
[6] [Apr 02 12:08:26] [ product cache service ] Found network interface: <OPSI.System.Windows.IP_ADAPTER_INFO object at 0x0254DE40> (Config.pyo|476)
[6] [Apr 02 12:08:26] [ product cache service ] Passing client configuration to depot selection algorithm: {'netmask': u'255.255.252.0', 'opsiHostKey': u'*** confidential ***', 'ipAddress': u'192.168.248.23', 'defaultGateway': u'192.168.251.254', 'clientId': u'mycomputer'} (Config.pyo|492)
[6] [Apr 02 12:08:26] [ product cache service ] Choosing depot from list of depots: (<string>|4)
[6] [Apr 02 12:08:26] [ product cache service ] Master depot: <OpsiConfigserver id 'opsi.stute.loc'> (<string>|5)
[5] [Apr 02 12:08:26] [ product cache service ] Choosing depot with networkAddress 192.168.248.0/255.255.252.0 for ip 192.168.248.23 (<string>|45)
[5] [Apr 02 12:08:26] [ product cache service ] Selected depot is: <OpsiConfigserver id 'opsi.stute.loc'> (Config.pyo|505)
[6] [Apr 02 12:08:26] [ product cache service ] Setting config value depot_server.depot_id (Config.pyo|198)
[6] [Apr 02 12:08:26] [ product cache service ] Setting config value depot_server.url (Config.pyo|198)
[6] [Apr 02 12:08:26] [ control server ] Worker <ocdlib.ControlServer.WorkerOpsiclientdJsonRpc instance at 0x024968F0> started processing (Worker.pyo|244)
[5] [Apr 02 12:08:26] [ control server ] New session created (Session.pyo|179)
[6] [Apr 02 12:08:26] [ product cache service ] Transfered 1.89 kByte in 0.00 minutes, average speed was 118.35 kByte/s (Repository.pyo|370)
[5] [Apr 02 12:08:26] [ control server ] Authorization request from mycomputer@127.0.0.1 (application: opsi jsonrpc module version 4.0.2) (ControlServer.pyo|144)
[5] [Apr 02 12:08:26] [ opsiclientd ] -----> Executing: backend_getInterface() (JsonRpc.pyo|123)
[6] [Apr 02 12:08:26] [ opsiclientd ] Got result (JsonRpc.pyo|131)
[6] [Apr 02 12:08:26] [ product cache service ] Product 'opsi-winst' contains 27 files with a total size of 6.291 MB (CacheService.pyo|885)
[6] [Apr 02 12:08:26] [ action_processor_starter.exe ] <OPSI.Backend.JSONRPC.JSONRPCBackend instance at 0x0153F8F0>: Connected to service (JSONRPC.pyo|427)
[6] [Apr 02 12:08:26] [ action_processor_starter.exe ] Impersonating network account 'pcpatch' (action_processor_starter.py|98)
[5] [Apr 02 12:08:26] [ action_processor_starter.exe ] Mounting depot share smb://opsi.stute.loc/opt_pcbin/install (action_processor_starter.py|103)
[6] [Apr 02 12:08:26] [ product cache service ] Disk space usage for path 'C:\opsi.org\cache\depot': {'available': 46435848192L, 'usage': 0.70927665261552686, 'used': 113289363456L, 'capacity': 159725211648L} (Windows.pyo|621)
[5] [Apr 02 12:08:26] [ product cache service ] Syncing product opsi-winst of depot <CIFSRepository smb://opsi.stute.loc/opt_pcbin/install> with local directory C:\opsi.org\cache\depot (Repository.pyo|1318)
[6] [Apr 02 12:08:26] [ product cache service ] Downloading package content file (Repository.pyo|1324)
[6] [Apr 02 12:08:26] [ control server ] Worker <ocdlib.ControlServer.WorkerOpsiclientdJsonRpc instance at 0x02CB3DC8> started processing (Worker.pyo|244)
[6] [Apr 02 12:08:26] [ product cache service ] Transfered 1.89 kByte in 0.00 minutes, average speed was 18935546.88 kByte/s (Repository.pyo|370)
[6] [Apr 02 12:08:26] [ control server ] Reusing session for client '127.0.0.1', application 'opsi jsonrpc module version 4.0.2' (Worker.pyo|391)
[5] [Apr 02 12:08:26] [ control server ] Authorization request from mycomputer@127.0.0.1 (application: opsi jsonrpc module version 4.0.2) (ControlServer.pyo|144)
[5] [Apr 02 12:08:26] [ opsiclientd ] -----> Executing: setStatusMessage(u'1', u'Verbinde mit Depot-Freigabe smb://opsi.stute.loc/opt_pcbin/install') (JsonRpc.pyo|123)
[5] [Apr 02 12:08:26] [ opsiclientd ] DEBUG: [<EventProcessingThread(Thread-16, started daemon 3000)>] (Opsiclientd.pyo|434)
[5] [Apr 02 12:08:26] [ opsiclientd ] DEBUG: 1 (Opsiclientd.pyo|436)
[5] [Apr 02 12:08:26] [ opsiclientd ] rpc setStatusMessage: Setting status message to 'Verbinde mit Depot-Freigabe smb://opsi.stute.loc/opt_pcbin/install' (ControlServer.pyo|515)
[6] [Apr 02 12:08:26] [ opsiclientd ] Got result (JsonRpc.pyo|131)
[5] [Apr 02 12:08:26] [ action_processor_starter.exe ] Mounting '\\opsi.stute.loc\opt_pcbin' to 'p:' (Windows.pyo|670)
[5] [Apr 02 12:08:26] [ action_processor_starter.exe ] Starting action processor (action_processor_starter.py|112)
[6] [Apr 02 12:08:26] [ control server ] Worker <ocdlib.ControlServer.WorkerOpsiclientdJsonRpc instance at 0x02CAEEB8> started processing (Worker.pyo|244)
[6] [Apr 02 12:08:26] [ control server ] Reusing session for client '127.0.0.1', application 'opsi jsonrpc module version 4.0.2' (Worker.pyo|391)
[5] [Apr 02 12:08:26] [ control server ] Authorization request from mycomputer@127.0.0.1 (application: opsi jsonrpc module version 4.0.2) (ControlServer.pyo|144)
[5] [Apr 02 12:08:26] [ opsiclientd ] -----> Executing: setStatusMessage(u'1', u'Action processor l\xe4uft') (JsonRpc.pyo|123)
[5] [Apr 02 12:08:26] [ opsiclientd ] DEBUG: [<EventProcessingThread(Thread-16, started daemon 3000)>] (Opsiclientd.pyo|434)
[5] [Apr 02 12:08:26] [ opsiclientd ] DEBUG: 1 (Opsiclientd.pyo|436)
[5] [Apr 02 12:08:26] [ opsiclientd ] rpc setStatusMessage: Setting status message to 'Action processor läuft' (ControlServer.pyo|515)
[6] [Apr 02 12:08:26] [ opsiclientd ] Got result (JsonRpc.pyo|131)
[5] [Apr 02 12:08:26] [ action_processor_starter.exe ] Running command '"C:\Program Files (x86)\opsi.org\opsi-client-agent\\opsi-winst\\winst32.exe" /opsiservice "
https://opsi.stute.loc:4447/rpc" /clientid stute-pc-0441.stute.loc /username stute-pc-0441.stute.loc /password *** confidential *** ' as user 'pcpatch' on desktop 'winlogon' (Windows.pyo|1767)
[6] [Apr 02 12:08:26] [ action_processor_starter.exe ] Process startet, pid: 3996 (Windows.pyo|1771)
[6] [Apr 02 12:08:26] [ action_processor_starter.exe ] Waiting for process ending: 3996 (timeout: 10800 seconds) (Windows.pyo|1774)
[5] [Apr 02 12:08:28] [ product cache service ] Product 'opsi-winst' cached (CacheService.pyo|928)
[3] [Apr 02 12:08:29] [ product cache service ] Errors occured while caching products opt-fleetboard-cockpit, opsi-winst: Failed to free enough disk space for product cache: Needed space: 65.748 MB, maximum freeable space: 0.002 MB (CacheService.pyo|765)
[5] [Apr 02 12:08:35] [ action_processor_starter.exe ] Process 3996 ended with exit code 0 (Windows.pyo|1784)
[5] [Apr 02 12:08:35] [ action_processor_starter.exe ] Action processor ended (action_processor_starter.py|117)
[6] [Apr 02 12:08:35] [ control server ] Worker <ocdlib.ControlServer.WorkerOpsiclientdJsonRpc instance at 0x02CA9E40> started processing (Worker.pyo|244)
[6] [Apr 02 12:08:35] [ control server ] Reusing session for client '127.0.0.1', application 'opsi jsonrpc module version 4.0.2' (Worker.pyo|391)
[5] [Apr 02 12:08:35] [ control server ] Authorization request from mycomputer@127.0.0.1 (application: opsi jsonrpc module version 4.0.2) (ControlServer.pyo|144)
[5] [Apr 02 12:08:35] [ opsiclientd ] -----> Executing: setStatusMessage(u'1', u'Action processor beendet') (JsonRpc.pyo|123)
[5] [Apr 02 12:08:35] [ opsiclientd ] DEBUG: [<EventProcessingThread(Thread-16, started daemon 3000)>] (Opsiclientd.pyo|434)
[5] [Apr 02 12:08:35] [ opsiclientd ] DEBUG: 1 (Opsiclientd.pyo|436)
[5] [Apr 02 12:08:35] [ opsiclientd ] rpc setStatusMessage: Setting status message to 'Action processor beendet' (ControlServer.pyo|515)
[6] [Apr 02 12:08:35] [ opsiclientd ] Got result (JsonRpc.pyo|131)
[5] [Apr 02 12:08:35] [ action_processor_starter.exe ] Unmounting depot share (action_processor_starter.py|132)
[6] [Apr 02 12:08:35] [ control server ] Worker <ocdlib.ControlServer.WorkerOpsiclientdJsonRpc instance at 0x02CB7990> started processing (Worker.pyo|244)
[6] [Apr 02 12:08:35] [ control server ] Reusing session for client '127.0.0.1', application 'opsi jsonrpc module version 4.0.2' (Worker.pyo|391)
[5] [Apr 02 12:08:35] [ control server ] Authorization request from mycomputer@127.0.0.1 (application: opsi jsonrpc module version 4.0.2) (ControlServer.pyo|144)
[5] [Apr 02 12:08:35] [ opsiclientd ] -----> Executing: backend_exit() (JsonRpc.pyo|123)
[6] [Apr 02 12:08:35] [ opsiclientd ] Got result (JsonRpc.pyo|131)
[5] [Apr 02 12:08:35] [ event processing gui_startup ] Process 3916 ended with exit code 0 (Windows.pyo|1530)