No swaudit or hwaudit data showing up. Heartbreaking, really

[Scaz]

I've just set up an Opsi server using the supplied VM, converted to ESX/Vsphere. Aside from a brief problem with the wrong password being used by pcpatch, all seems to be going well: except I can't get the audit packages to return any data.

'Product Configuration' shows up the version and installation status of hwaudit and swaudit fine, but when I go to 'Hardware Information' or 'Software Inventory' I just get the message telling me "no software inventory associated, please activate product swaudit"/"no hardware configuration associated, please activate product hwaudit". Both modules are loaded fine it appears, as are dependencies. The instlog file shows that the registry reads for the hardware inventory are being made fine, but they don't reach the depot server.

I've also tried on multiple clients - all XP SP3 - but with the same (lack of) results. The only errors I can are a Samba one: "Fehler 997 ("Overlapped I/O operation is in progress")." and the much more likely suspect: "Exception: {'message': "[Errno 13] Permission denied: '/var/lib/opsi/audit/vcente.swarthmore.org.local.hw'", 'class': 'BackendIOError'}". While this looks like the cause, /var/lib/opsi/audit/ and everything under it is set to 666. I've also set pcpatch to own the directory and all files under it and given group ownership to opsiadmin for the same. Being as 'other' is set to rw as well, I'm not sure what else I can give: 777? I'm loathe to dish out 777 permissions as a rule, but is executable needed here for some reason?

Anyway, attached is a sample set of logs.

I'd be very grateful if someone could point me in the right direction with this as I've been staring at it for quite some time now and my eyes have gone funny.

Thanks.


Callum.



Logs -> ... .. .

Clientconnect


02/03/2010 10:33:36 ============================ pcptch Version 3.9.3 ============================
02/03/2010 10:33:38 starting pcptch
02/03/2010 10:33:39 ipconfig /all :::
02/03/2010 10:33:39 ~
02/03/2010 10:33:39 ipconfig /all ::: Windows IP Configuration
02/03/2010 10:33:39 ipconfig /all :::
02/03/2010 10:33:39 ~
02/03/2010 10:33:39 ~
02/03/2010 10:33:39 ipconfig /all ::: Host Name . . . . . . . . . . . . : vcente
02/03/2010 10:33:39 ipconfig /all :::
02/03/2010 10:33:39 ipconfig /all ::: Primary Dns Suffix . . . . . . . : swarthmore.org.local
02/03/2010 10:33:39 ipconfig /all :::
02/03/2010 10:33:39 ipconfig /all ::: Node Type . . . . . . . . . . . . : Unknown
02/03/2010 10:33:39 ipconfig /all :::
02/03/2010 10:33:39 ipconfig /all ::: IP Routing Enabled. . . . . . . . : No
02/03/2010 10:33:39 ipconfig /all :::
02/03/2010 10:33:39 ipconfig /all ::: WINS Proxy Enabled. . . . . . . . : No
02/03/2010 10:33:39 ipconfig /all :::
02/03/2010 10:33:39 ipconfig /all ::: DNS Suffix Search List. . . . . . : swarthmore.org.local
02/03/2010 10:33:39 ipconfig /all :::
02/03/2010 10:33:39 ipconfig /all ::: org.local
02/03/2010 10:33:39 ipconfig /all :::
02/03/2010 10:33:39 ~
02/03/2010 10:33:39 ~
02/03/2010 10:33:39 ipconfig /all ::: Ethernet adapter Local Area Connection:
02/03/2010 10:33:39 ipconfig /all :::
02/03/2010 10:33:39 ~
02/03/2010 10:33:39 ~
02/03/2010 10:33:39 ipconfig /all ::: Connection-specific DNS Suffix . :
02/03/2010 10:33:39 ipconfig /all :::
02/03/2010 10:33:39 ipconfig /all ::: Description . . . . . . . . . . . : VMware Accelerated AMD PCNet Adapter
02/03/2010 10:33:39 ipconfig /all :::
02/03/2010 10:33:39 ipconfig /all ::: Physical Address. . . . . . . . . : 00-0C-29-DF-CF-56
02/03/2010 10:33:39 ipconfig /all :::
02/03/2010 10:33:39 ipconfig /all ::: Dhcp Enabled. . . . . . . . . . . : No
02/03/2010 10:33:39 ipconfig /all :::
02/03/2010 10:33:39 ipconfig /all ::: IP Address. . . . . . . . . . . . : 192.168.150.151
02/03/2010 10:33:39 ipconfig /all :::
02/03/2010 10:33:39 ipconfig /all ::: Subnet Mask . . . . . . . . . . . : 255.255.255.0
02/03/2010 10:33:39 ipconfig /all :::
02/03/2010 10:33:39 ipconfig /all ::: IP Address. . . . . . . . . . . . : 10.3.0.21
02/03/2010 10:33:39 ipconfig /all :::
02/03/2010 10:33:39 ipconfig /all ::: Subnet Mask . . . . . . . . . . . : 255.255.255.0
02/03/2010 10:33:39 ipconfig /all :::
02/03/2010 10:33:39 ipconfig /all ::: Default Gateway . . . . . . . . . : 10.3.0.8
02/03/2010 10:33:39 ipconfig /all :::
02/03/2010 10:33:39 ipconfig /all ::: DNS Servers . . . . . . . . . . . : 10.3.0.2
02/03/2010 10:33:39 ipconfig /all :::
02/03/2010 10:33:39 ipconfig /all ::: 10.3.0.3
02/03/2010 10:33:39 ipconfig /all :::
02/03/2010 10:33:39 getting IP-Names from Environment
02/03/2010 10:33:39 ipName from system: vcente.swarthmore.org.local
02/03/2010 10:33:39 ipAddress from system: 10.3.0.21
02/03/2010 10:33:39 retrieved from registry \SYSTEM\CurrentControlSet\Control\ComputerName\ComputerName, Computername: VCENTE
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\pcptch, mountdrive: 1
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\pcptch, label1: opsi
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\pcptch, label2: uib
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\pcptch, loadbitmap: 1
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\pcptch, bitmap1: winst1.bmp
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\pcptch, bitmap2: winst2.bmp
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\pcptch, button_stopnetworking: immediate
02/03/2010 10:33:39 Button StopNetworking enabled
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\pcptch, SecsUntilConnectionTimeOut: 180
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\pcptch, pcprotoname: pcproto.ini
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\pcptch, patchlevelTyp:
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\pcptch, copydefaultuser: 0
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\pcptch, networkEntriesFromEnvironment: 1
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\pcptch, WinstLocalDirectory: C:\Program Files\opsi.org\preloginloader\opsi-winst
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\pcptch, ConfigDirectory: C:\Program Files\opsi.org\preloginloader\cfg
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\pcptch, makeLocalCopyOfIniFile: 0
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\pcptch, makeLocalWinst: 1
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\general, opsiconf: 1
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\pcptch, pingcheck: 1
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\pcptch, sendlogtoservice: 1
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\pcptch, opsiServerType: service
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\pcptch, opsiServiceURL: https://10.3.0.12:4447
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\pcptch, repeatServiceConnectNo: 3
02/03/2010 10:33:39 opsiconf true
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\shareinfo, pckey: DONT SHOW IT
02/03/2010 10:33:39 reading pckey from file "C:\Program Files\opsi.org\preloginloader\cfg\locked.cfg"
02/03/2010 10:33:39 pckey read from file
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\general, tftpserver: opsi.swarthmore.org.local
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\general, configlocal: 0
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\shareinfo, user: pcpatch
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\shareinfo, smbusername1: opsiserver\pcpatch
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\shareinfo, try_secondary_user: 0
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\shareinfo, pcpatchpass: e0999165de19f757
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\shareinfo, depoturl: smb:\\opsi\opt_pcbin\install
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\shareinfo, configurl: smb:\\opsi\opt_pcbin\install
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\shareinfo, utilsurl: smb:\\opsi\opt_pcbin\utils
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\shareinfo, utilsdrive: P:
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\shareinfo, configdrive: P:
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\shareinfo, depotdrive: P:
02/03/2010 10:33:39 Error: Requested bitmap could not be loaded
02/03/2010 10:33:39 retrieved from registry \SOFTWARE\opsi.org\pcptch, button_stopnetworking: immediate
02/03/2010 10:33:39 Button StopNetworking enabled
02/03/2010 10:33:39 servicehost reached in 0 ms
02/03/2010 10:33:39 determining opsi client ID
02/03/2010 10:33:39 opsi service with URL https://10.3.0.12:4447
02/03/2010 10:33:39 json call: "https://10.3.0.12:4447/rpc?%7B%22id%22: ... :%5B%5D%7D"
02/03/2010 10:33:39 json general Result "{"error":null,"id":1,"result":""}"
02/03/2010 10:33:39 No client ID got from service
02/03/2010 10:33:40 Try with ipname from local system: vcente
02/03/2010 10:33:40 json call: "https://10.3.0.12:4447/rpc?%7B%22id%22: ... :%5B%5D%7D"
02/03/2010 10:33:40 json general Result "{"error":null,"id":1,"result":"swarthmore.org.local"}"
02/03/2010 10:33:40 Default domain from service >swarthmore.org.local<
02/03/2010 10:33:40 we supplement default domain from service to name: vcente
02/03/2010 10:33:40 We have client ID vcente.swarthmore.org.local
02/03/2010 10:33:40 opsi service with URL https://10.3.0.12:4447
02/03/2010 10:33:40 opsi service "https://10.3.0.12:4447", client "vcente.swarthmore.org.local" , username "vcente.swarthmore.org.local"
02/03/2010 10:33:40 json call: "https://10.3.0.12:4447/rpc?%7B%22id%22: ... :%5B%5D%7D"
02/03/2010 10:33:40 json general Result "{"error":null,"id":1,"result":true}"
02/03/2010 10:33:40 json call: "https://10.3.0.12:4447/rpc?%7B%22id%22: ... l%22%5D%7D"
02/03/2010 10:33:40 json general Result "{"error":null,"id":1,"result":{"depotDrive":"P:","nextBootServiceURL":"https://10.3.0.12:4447","utilsUrl":"smb://opsi/opt_pcbin/utils","configUrl":"smb://opsi/opt_pcbin/pcpatch","utilsDrive":"P:","opsiServer":"opsi.swarthmore.org.local","nextBootServerType":"service","depotUrl":"smb://opsi/opt_pcbin/install","depotId":"opsi.swarthmore.org.local","configDrive":"O:","winDomain":"SWARTHMORE"}}"
02/03/2010 10:33:40 depoturl for client vcente.swarthmore.org.local from opsi service: smb://opsi/opt_pcbin/install
02/03/2010 10:33:40 utilsurl for client vcente.swarthmore.org.local from opsi service: smb://opsi/opt_pcbin/utils
02/03/2010 10:33:40 json call: "https://10.3.0.12:4447/rpc?%7B%22id%22: ... l%22%5D%7D"
02/03/2010 10:33:40 json general Result "{"error":null,"id":1,"result":"e0999165de19f757"}"
02/03/2010 10:33:40 fetched encryptedpass from opsi service
02/03/2010 10:33:40 json call: "https://10.3.0.12:4447/rpc?%7B%22id%22: ... l%22%5D%7D"
02/03/2010 10:33:40 json general Result "{"error":null,"id":1,"result":{"pcptchLabel1":"opsi","pcptchLabel2":"uib","button_stopnetworking":"","pcptchBitmap1":"winst1.bmp","pcptchBitmap2":"winst2.bmp","secsUntilConnectionTimeOut":"180"}}"
02/03/2010 10:33:40 ipNameHost: /* not found */
02/03/2010 10:33:40 depoturl: smb://opsi/opt_pcbin/install
02/03/2010 10:33:40 configurl: smb://opsi/opt_pcbin/install
02/03/2010 10:33:40 utilsurl: smb://opsi/opt_pcbin/utils
02/03/2010 10:33:40 depot drive: P:
02/03/2010 10:33:40 config drive: P:
02/03/2010 10:33:40 utils drive: P:
02/03/2010 10:33:40 depotshare \\opsi\opt_pcbin
02/03/2010 10:33:40 depotdir \install
02/03/2010 10:33:40 configshare \\opsi\opt_pcbin
02/03/2010 10:33:40 configdir \install
02/03/2010 10:33:40 utilsshare \\opsi\opt_pcbin
02/03/2010 10:33:40 utilsdir \utils
02/03/2010 10:33:40 winstMasterDirectory P:\install\opsi-winst\files\opsi-winst
02/03/2010 10:33:40 Profildateienpfad P:\install\
02/03/2010 10:33:40 Bootmode BKSTD
02/03/2010 10:33:40 trying to connect remote resource "\\opsi\opt_pcbin" to local resource "P:"
02/03/2010 10:33:40 Fehler 997 ("Overlapped I/O operation is in progress")
02/03/2010 10:33:40 Netzverbindung von P: zu \\opsi\opt_pcbin hergestellt
02/03/2010 10:33:41 user of the process: pcpatch
02/03/2010 10:33:41 start working based on the network connection
02/03/2010 10:33:41 Local winst exists and seems to be up to date
02/03/2010 10:33:41 RebootRequested set to 0
02/03/2010 10:33:41 starting process: "C:\Program Files\opsi.org\preloginloader\opsi-winst\winst32.exe" /opsiservice https://10.3.0.12:4447 /clientid vcente.swarthmore.org.local /username vcente.swarthmore.org.local /password PASSWORD
02/03/2010 10:33:45 Calling cancel connection resource: P:
02/03/2010 10:33:45 Cancelled: connection to resource: P:
02/03/2010 10:33:47 ending pcptch
02/03/2010 10:33:47 json call: "https://10.3.0.12:4447/rpc?%7B%22id%22: ... :%5B%5D%7D"
02/03/2010 10:33:47 json general Result "{"error":null,"id":1,"result":true}"


Opsiconfd

[4] [Feb 26 15:35:15] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Feb 26 15:35:15] New session created (opsiconfd|950)
[4] [Feb 26 15:35:15] Authorization request from vcente.swarthmore.org.local@10.3.0.21 (opsiconfd|354)
[2] [Feb 26 15:35:15] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Feb 26 15:35:15] BackendManager created. (opsiconfd|391)
[4] [Feb 26 15:42:08] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Feb 26 15:42:08] New session created (opsiconfd|950)
[4] [Feb 26 15:42:08] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Feb 26 15:42:08] New session created (opsiconfd|950)
[4] [Feb 26 15:42:08] Authorization request from vcente.swarthmore.org.local@10.3.0.21 (opsiconfd|354)
[2] [Feb 26 15:42:08] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Feb 26 15:42:08] BackendManager created. (opsiconfd|391)
[4] [Feb 26 15:45:31] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Feb 26 15:45:31] New session created (opsiconfd|950)
[4] [Feb 26 15:45:31] Authorization request from vcente.swarthmore.org.local@10.3.0.21 (opsiconfd|354)
[2] [Feb 26 15:45:31] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Feb 26 15:45:31] BackendManager created. (opsiconfd|391)
[4] [Feb 26 15:53:57] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Feb 26 15:53:57] New session created (opsiconfd|950)
[4] [Feb 26 15:53:57] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Feb 26 15:53:57] New session created (opsiconfd|950)
[4] [Feb 26 15:53:57] Authorization request from vcente.swarthmore.org.local@10.3.0.21 (opsiconfd|354)
[2] [Feb 26 15:53:57] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Feb 26 15:53:57] BackendManager created. (opsiconfd|391)
[4] [Feb 26 15:57:20] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Feb 26 15:57:20] New session created (opsiconfd|950)
[4] [Feb 26 15:57:20] Authorization request from vcente.swarthmore.org.local@10.3.0.21 (opsiconfd|354)
[2] [Feb 26 15:57:20] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Feb 26 15:57:20] BackendManager created. (opsiconfd|391)
[4] [Feb 26 16:00:34] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Feb 26 16:00:34] New session created (opsiconfd|950)
[4] [Feb 26 16:00:34] Authorization request from vcente.swarthmore.org.local@10.3.0.21 (opsiconfd|354)
[2] [Feb 26 16:00:34] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Feb 26 16:00:34] BackendManager created. (opsiconfd|391)
[4] [Feb 26 16:26:09] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Feb 26 16:26:09] New session created (opsiconfd|950)
[4] [Feb 26 16:26:09] Authorization request from none@10.3.0.21 (opsiconfd|354)
[2] [Feb 26 16:26:09] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[2] [Feb 26 16:26:11] Forbidden: PAM authentication failed for user 'none': ('User not known to the underlying authentication module', 10) (opsiconfd|417)
[1] [Feb 26 16:26:11] Traceback (most recent call last):
File "/usr/sbin/opsiconfd", line 118, in http_GET
return worker.process()
File "/usr/sbin/opsiconfd", line 200, in process
self.deferred.callback(None)
File "/usr/lib/python2.5/site-packages/twisted/internet/defer.py", line 243, in callback
self._startRunCallbacks(result)
File "/usr/lib/python2.5/site-packages/twisted/internet/defer.py", line 312, in _startRunCallbacks
self._runCallbacks()
--- <exception caught here> ---
File "/usr/lib/python2.5/site-packages/twisted/internet/defer.py", line 328, in _runCallbacks
self.result = callback(self.result, *args, **kw)
File "/usr/sbin/opsiconfd", line 389, in _authenticate
configFile = backendManagerConf )
File "/var/lib/python-support/python2.5/OPSI/Backend/BackendManager.py", line 169, in __init__
self._authenticate(self.__username, self.__password)
File "/var/lib/python-support/python2.5/OPSI/Backend/BackendManager.py", line 286, in _authenticate
return self._pamAuthenticate(user, password)
File "/var/lib/python-support/python2.5/OPSI/Backend/BackendManager.py", line 380, in _pamAuthenticate
raise BackendAuthenticationError("PAM authentication failed for user '%s': %s" % (user, e))
OPSI.Backend.Backend.BackendAuthenticationError: PAM authentication failed for user 'none': ('User not known to the underlying authentication module', 10)
(opsiconfd|619)
[2] [Feb 26 16:26:11] Failed to process rpc: PAM authentication failed for user 'none': ('User not known to the underlying authentication module', 10) (opsiconfd|623)
[4] [Feb 26 16:26:48] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Feb 26 16:26:48] New session created (opsiconfd|950)
[4] [Feb 26 16:26:48] Authorization request from root@10.3.0.21 (opsiconfd|354)
[2] [Feb 26 16:26:48] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Feb 26 16:26:48] BackendManager created. (opsiconfd|391)
[4] [Feb 26 16:26:55] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Feb 26 16:26:55] New session created (opsiconfd|950)
[4] [Feb 26 16:26:55] Authorization request from vcente.swarthmore.org.local@10.3.0.21 (opsiconfd|354)
[2] [Feb 26 16:26:55] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Feb 26 16:26:55] BackendManager created. (opsiconfd|391)
[4] [Feb 26 16:28:26] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Feb 26 16:28:26] New session created (opsiconfd|950)
[4] [Feb 26 16:28:26] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Feb 26 16:28:26] New session created (opsiconfd|950)
[4] [Feb 26 16:28:26] Authorization request from vcente.swarthmore.org.local@10.3.0.21 (opsiconfd|354)
[2] [Feb 26 16:28:26] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Feb 26 16:28:26] BackendManager created. (opsiconfd|391)
[4] [Feb 26 16:31:48] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Feb 26 16:31:48] New session created (opsiconfd|950)
[4] [Feb 26 16:31:48] Authorization request from vcente.swarthmore.org.local@10.3.0.21 (opsiconfd|354)
[2] [Feb 26 16:31:48] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Feb 26 16:31:48] BackendManager created. (opsiconfd|391)
[4] [Feb 26 16:50:39] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Feb 26 16:50:39] New session created (opsiconfd|950)
[4] [Feb 26 16:50:39] Authorization request from none@10.3.0.21 (opsiconfd|354)
[2] [Feb 26 16:50:39] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[2] [Feb 26 16:50:41] Forbidden: PAM authentication failed for user 'none': ('User not known to the underlying authentication module', 10) (opsiconfd|417)
[1] [Feb 26 16:50:41] Traceback (most recent call last):
File "/usr/sbin/opsiconfd", line 118, in http_GET
return worker.process()
File "/usr/sbin/opsiconfd", line 200, in process
self.deferred.callback(None)
File "/usr/lib/python2.5/site-packages/twisted/internet/defer.py", line 243, in callback
self._startRunCallbacks(result)
File "/usr/lib/python2.5/site-packages/twisted/internet/defer.py", line 312, in _startRunCallbacks
self._runCallbacks()
--- <exception caught here> ---
File "/usr/lib/python2.5/site-packages/twisted/internet/defer.py", line 328, in _runCallbacks
self.result = callback(self.result, *args, **kw)
File "/usr/sbin/opsiconfd", line 389, in _authenticate
configFile = backendManagerConf )
File "/var/lib/python-support/python2.5/OPSI/Backend/BackendManager.py", line 169, in __init__
self._authenticate(self.__username, self.__password)
File "/var/lib/python-support/python2.5/OPSI/Backend/BackendManager.py", line 286, in _authenticate
return self._pamAuthenticate(user, password)
File "/var/lib/python-support/python2.5/OPSI/Backend/BackendManager.py", line 380, in _pamAuthenticate
raise BackendAuthenticationError("PAM authentication failed for user '%s': %s" % (user, e))
OPSI.Backend.Backend.BackendAuthenticationError: PAM authentication failed for user 'none': ('User not known to the underlying authentication module', 10)
(opsiconfd|619)
[2] [Feb 26 16:50:41] Failed to process rpc: PAM authentication failed for user 'none': ('User not known to the underlying authentication module', 10) (opsiconfd|623)
[4] [Feb 26 16:51:34] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Feb 26 16:51:34] New session created (opsiconfd|950)
[4] [Feb 26 16:51:34] Authorization request from root@10.3.0.21 (opsiconfd|354)
[2] [Feb 26 16:51:34] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Feb 26 16:51:34] BackendManager created. (opsiconfd|391)
[4] [Feb 26 16:51:39] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Feb 26 16:51:39] New session created (opsiconfd|950)
[4] [Feb 26 16:51:39] Authorization request from vcente.swarthmore.org.local@10.3.0.21 (opsiconfd|354)
[2] [Feb 26 16:51:39] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Feb 26 16:51:39] BackendManager created. (opsiconfd|391)
[4] [Feb 26 16:53:14] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Feb 26 16:53:14] New session created (opsiconfd|950)
[4] [Feb 26 16:53:14] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Feb 26 16:53:14] New session created (opsiconfd|950)
[4] [Feb 26 16:53:14] Authorization request from vcente.swarthmore.org.local@10.3.0.21 (opsiconfd|354)
[2] [Feb 26 16:53:14] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Feb 26 16:53:14] BackendManager created. (opsiconfd|391)
[4] [Feb 26 16:53:21] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Feb 26 16:53:21] New session created (opsiconfd|950)
[4] [Feb 26 16:53:21] Authorization request from vcente.swarthmore.org.local@10.3.0.21 (opsiconfd|354)
[2] [Feb 26 16:53:21] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Feb 26 16:53:21] BackendManager created. (opsiconfd|391)
[4] [Feb 26 16:54:10] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Feb 26 16:54:10] New session created (opsiconfd|950)
[4] [Feb 26 16:54:10] Authorization request from vcente.swarthmore.org.local@10.3.0.21 (opsiconfd|354)
[2] [Feb 26 16:54:10] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Feb 26 16:54:10] BackendManager created. (opsiconfd|391)
[4] [Feb 26 16:56:23] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Feb 26 16:56:23] New session created (opsiconfd|950)
[4] [Feb 26 16:56:25] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Feb 26 16:56:25] New session created (opsiconfd|950)
[4] [Feb 26 16:56:25] Authorization request from vcente.swarthmore.org.local@10.3.0.21 (opsiconfd|354)
[2] [Feb 26 16:56:25] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Feb 26 16:56:25] BackendManager created. (opsiconfd|391)
[4] [Feb 26 16:56:33] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Feb 26 16:56:33] New session created (opsiconfd|950)
[4] [Feb 26 16:56:33] Authorization request from vcente.swarthmore.org.local@10.3.0.21 (opsiconfd|354)
[2] [Feb 26 16:56:33] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Feb 26 16:56:33] BackendManager created. (opsiconfd|391)
[4] [Feb 26 16:56:49] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Feb 26 16:56:49] New session created (opsiconfd|950)
[2] [Feb 26 16:56:49] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Feb 26 16:56:49] Authorization request from vcente.swarthmore.org.local@10.3.0.21 (opsiconfd|354)
[2] [Feb 26 16:56:49] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Feb 26 16:56:49] BackendManager created. (opsiconfd|391)
[2] [Feb 26 16:56:49] [Errno 13] Permission denied: '/var/lib/opsi/audit/vcente.swarthmore.org.local.sw' (opsiconfd|533)
[4] [Feb 26 16:56:53] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Feb 26 16:56:53] New session created (opsiconfd|950)
[2] [Feb 26 16:56:53] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Feb 26 16:56:53] Authorization request from vcente.swarthmore.org.local@10.3.0.21 (opsiconfd|354)
[2] [Feb 26 16:56:53] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Feb 26 16:56:53] BackendManager created. (opsiconfd|391)
[2] [Feb 26 16:57:52] [Errno 13] Permission denied: '/var/lib/opsi/audit/vcente.swarthmore.org.local.hw' (opsiconfd|533)
[4] [Feb 26 16:57:59] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Feb 26 16:57:59] New session created (opsiconfd|950)
[4] [Feb 26 16:57:59] Authorization request from vcente.swarthmore.org.local@10.3.0.21 (opsiconfd|354)
[2] [Feb 26 16:57:59] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Feb 26 16:57:59] BackendManager created. (opsiconfd|391)
[4] [Feb 26 17:02:00] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Feb 26 17:02:00] New session created (opsiconfd|950)
[4] [Feb 26 17:02:00] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Feb 26 17:02:00] New session created (opsiconfd|950)
[4] [Feb 26 17:02:00] Authorization request from vcente.swarthmore.org.local@10.3.0.21 (opsiconfd|354)
[2] [Feb 26 17:02:00] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Feb 26 17:02:00] BackendManager created. (opsiconfd|391)
[4] [Feb 26 17:02:07] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Feb 26 17:02:07] New session created (opsiconfd|950)
[4] [Feb 26 17:02:07] Authorization request from vcente.swarthmore.org.local@10.3.0.21 (opsiconfd|354)
[2] [Feb 26 17:02:07] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Feb 26 17:02:07] BackendManager created. (opsiconfd|391)
[4] [Feb 26 17:02:48] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Feb 26 17:02:48] New session created (opsiconfd|950)
[2] [Feb 26 17:02:48] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Feb 26 17:02:48] Authorization request from vcente.swarthmore.org.local@10.3.0.21 (opsiconfd|354)
[2] [Feb 26 17:02:48] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Feb 26 17:02:48] BackendManager created. (opsiconfd|391)
[2] [Feb 26 17:03:05] [Errno 13] Permission denied: '/var/lib/opsi/audit/vcente.swarthmore.org.local.hw' (opsiconfd|533)
[4] [Feb 26 17:03:11] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Feb 26 17:03:11] New session created (opsiconfd|950)
[4] [Feb 26 17:03:11] Authorization request from vcente.swarthmore.org.local@10.3.0.21 (opsiconfd|354)
[2] [Feb 26 17:03:11] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Feb 26 17:03:11] BackendManager created. (opsiconfd|391)
[4] [Mar 02 10:20:18] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Mar 02 10:20:18] New session created (opsiconfd|950)
[4] [Mar 02 10:20:19] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Mar 02 10:20:19] New session created (opsiconfd|950)
[4] [Mar 02 10:20:19] Authorization request from vcente.swarthmore.org.local@10.3.0.21 (opsiconfd|354)
[2] [Mar 02 10:20:19] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Mar 02 10:20:19] BackendManager created. (opsiconfd|391)
[4] [Mar 02 10:20:20] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Mar 02 10:20:20] New session created (opsiconfd|950)
[4] [Mar 02 10:20:20] Authorization request from vcente.swarthmore.org.local@10.3.0.21 (opsiconfd|354)
[2] [Mar 02 10:20:20] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Mar 02 10:20:20] BackendManager created. (opsiconfd|391)
[4] [Mar 02 10:20:30] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Mar 02 10:20:30] New session created (opsiconfd|950)
[2] [Mar 02 10:20:30] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Mar 02 10:20:30] Authorization request from vcente.swarthmore.org.local@10.3.0.21 (opsiconfd|354)
[2] [Mar 02 10:20:30] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Mar 02 10:20:30] BackendManager created. (opsiconfd|391)
[2] [Mar 02 10:20:44] [Errno 13] Permission denied: '/var/lib/opsi/audit/vcente.swarthmore.org.local.hw' (opsiconfd|533)
[4] [Mar 02 10:20:49] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Mar 02 10:20:49] New session created (opsiconfd|950)
[4] [Mar 02 10:20:49] Authorization request from vcente.swarthmore.org.local@10.3.0.21 (opsiconfd|354)
[2] [Mar 02 10:20:49] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Mar 02 10:20:49] BackendManager created. (opsiconfd|391)
[4] [Mar 02 10:33:39] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Mar 02 10:33:39] New session created (opsiconfd|950)
[4] [Mar 02 10:33:40] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Mar 02 10:33:40] New session created (opsiconfd|950)
[4] [Mar 02 10:33:40] Authorization request from vcente.swarthmore.org.local@10.3.0.21 (opsiconfd|354)
[2] [Mar 02 10:33:40] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Mar 02 10:33:40] BackendManager created. (opsiconfd|391)
[4] [Mar 02 10:33:42] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Mar 02 10:33:42] New session created (opsiconfd|950)
[4] [Mar 02 10:33:42] Authorization request from vcente.swarthmore.org.local@10.3.0.21 (opsiconfd|354)
[2] [Mar 02 10:33:42] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Mar 02 10:33:42] BackendManager created. (opsiconfd|391)
[4] [Mar 02 10:33:47] Client '10.3.0.21' did not send cookie (opsiconfd|261)
[4] [Mar 02 10:33:47] New session created (opsiconfd|950)
[4] [Mar 02 10:33:47] Authorization request from vcente.swarthmore.org.local@10.3.0.21 (opsiconfd|354)
[2] [Mar 02 10:33:47] Failed to read opsi modules file '/etc/opsi/modules': [Errno 2] No such file or directory: '/etc/opsi/modules' (BackendManager.py|1211)
[4] [Mar 02 10:33:47] BackendManager created. (opsiconfd|391)



Snippet from instlog. Error in bold:

"BASE_BOARD" :
[
{
"product" : "440BX Desktop Reference Platform",
"vendor" : "Intel Corporation",
"name" : "440BX Desktop Reference Platform",
"serialNumber" : "None",
"model" : null,
"description" : "Base Board"
}
],
"SCSI_CONTROLLER" :
[

]
}
Sending hardware information to service
Traceback (most recent call last):
File "c:\tmp\_winst.bat", line 751, in <module>
main(sys.argv[1:])
File "c:\tmp\_winst.bat", line 745, in main
backend.setHardwareInformation(USERNAME, values)
File "<string>", line 1, in setHardwareInformation
File "P:\install\hwaudit\OPSI\Backend\JSONRPC.py", line 220, in _jsonRPC
raise Exception( json.read(response).get('error') )
Exception: {'message': "[Errno 13] Permission denied: '/var/lib/opsi/audit/vcente.swarthmore.org.local.hw'", 'class': 'BackendIOError'}

retrieving strings from GetOutStreamFromSection [switch to loglevel 3 for debugging]

If
errorsOccuredSinceMark > 0 <<< result false
Then
EndIf
EndIf
___________________
0 errors
13 warnings


no script found for file name ""
02/03/2010 10:20:44 JSON service request https://10.3.0.12:4447/rpc?%7B%22id%22: ... d%22%5D%7D
02/03/2010 10:20:44 JSON service request https://10.3.0.12:4447/rpc?%7B%22id%22: ... e%22%5D%7D
Registry key [HKLM\SOFTWARE\opsi.org\winst] opened
Variable "RebootRequested" had value "0"
Info: "RebootRequested" changed to "4"
Variable "LastLogFilename" is keeping its value "c:\tmp\instlog.txt"
Variable "ContinueLogFile" had value "0"
Info: "ContinueLogFile" changed to "1"
Variable "NumberOfErrors" is keeping its value "0"
Key flushed
Key closed
Registry key [HKLM\SOFTWARE\opsi.org\winst] opened
Key closed
============ winst Version 4.8.8.1 WIN32 is regularly exiting. Time 2010-03-02 10:20:46 .
--
--


======= APPEND 02/03/2010 10:33:42
02/03/2010 10:33:42 JSON service request https://10.3.0.12:4447/rpc?%7B%22id%22: ... l%22%5D%7D
02/03/2010 10:33:42 JSON service request https://10.3.0.12:4447/rpc?%7B%22id%22: ... l%22%5D%7D
02/03/2010 10:33:42 JSON service request https://10.3.0.12:4447/rpc?%7B%22id%22: ... :%5B%5D%7D
02/03/2010 10:33:42 JSON service request https://10.3.0.12:4447/rpc?%7B%22id%22: ... l%22%5D%7D
02/03/2010 10:33:42 JSON service request https://10.3.0.12:4447/rpc?%7B%22id%22: ... l%22%5D%7D
Computername:vcente.swarthmore.org.local
Computername according to Environment Variable :VCENTE
opsi service URL https://10.3.0.12:4447
Config path: P:\install
Utils path: P:\utils
Depot path: P:\install

bootmode BKSTD
winst: Start sorting of products (02/03/2010 10:33:42)
02/03/2010 10:33:42 JSON service request https://10.3.0.12:4447/rpc?%7B%22id%22: ... :%5B%5D%7D
~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~
Resolved sequence of products (02/03/2010 10:33:42):
~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~

[Scaz]

Actually I just tried giving 777 perms to the directory and contents and this allows Opsi to accept hwaudit and swaudit are installed, but both scans are still empty. Both hw and sw audits only contain:

[SCANPROPERTIES]
scantime = 2010-02-24 16:31:28

Having no other data, even though I can see the registry has been read as needed.

If anyone has any thoughts or knows the correct permissions & ownership for /var/lib/opsi/audit/ and contents, I'd be very grateful.


Callum.

[wolfbardo]

Hi Scaz,

Code: Alles auswählen

/var/lib/opsi# ls -l | grep audit
drwxrws--- 2 opsiconfd pcpatch 4096 17. Feb 09:58 audit

regards
Bardo Wolf

[Scaz]

Result!

Having changed those permissions, restarted the PC and restarted opsiconfd, I've got a hardware and a software inventory. Happiness is mine.

Could you just give me the correct permissions/ownership for /var/lib/opsi/audit and well Bardo.

Thanks,


Callum.