Kann Befehl "CallRunAsHidden..." nicht ausführen. Fehler 2!

[TPrummer]

Hallo zusammen,

ich habe folgendes Problem und hoffe, dass mir hier jemand helfen kann.

Es soll auf D:\ für jeden User ein Ordner erstellt und für ihn berechtigt werden.

Voraussetzungen:
Alle Rechner wurden identisch installiert
Windows 7 x64
Der Lokale Administratorbenutzer "root" hat auf Partition D:\ Schreiberechte
Benutzer haben auf D:\ nur Ordnerinhalt anzeigen

Wird gelöst mit:
#Set:PartitionD,CLIENT

[Set:PartitionD]
CallRunAsHidden /U:.\root /P:1234 "cmd.exe" /c MkDir "D:\%WindowsUser%"
CallRunAsHidden /U:.\root /P:1234 "cmd.exe" /c icacls "D:\%WindowsUser%" /grant "%USERDOMAIN%\%WindowsUser%:(CI)(OI)(M)"

Soweit so gut, funktioniert theoretisch und auch praktisch - jedoch nicht immer...
bei einigen Notebooks bzw. Usern kommt folgender Fehler zurück:
Kann Befehl 'CallRunAsHidden /U:.\root /P:1234 "cmd.exe" /c MkDir "D:\%WindowsUser%"' nicht ausführen.
Fehler 2!

Notebook 1:
07.01.2015 14:47 Benutzer 7 Install (User) Failure Kann Befehl 'CallRunAsHidden /U:.\root /P:1234 "cmd.exe" /c MkDir "D:\UNGESICHERT_test"' nicht ausführen. Fehler 2!
05.01.2015 19:09 Benutzer 6 Install (User) Success
16.12.2014 18:40 Benutzer 5 Install (User) Failure Kann Befehl 'CallRunAsHidden /U:.\root /P:1234 "cmd.exe" /c MkDir "D:\UNGESICHERT_%WindowsUser%"' nicht ausführen. Fehler 2!
14.12.2014 16:24 Benutzer 4 Install (User) Failure Kann Befehl 'CallRunAsHidden /U:.\root /P:1234 "cmd.exe" /c MkDir "D:\UNGESICHERT_%WindowsUser%"' nicht ausführen. Fehler 2!
06.12.2014 10:10 Benutzer 3 Install (User) Success
16.11.2014 16:43 Benutzer 2 Install (User) Failure Kann Befehl 'CallRunAsHidden /U:.\root /P:1234 "cmd.exe" /c MkDir "D:\UNGESICHERT_%WindowsUser%"' nicht ausführen. Fehler 2!
27.10.2014 10:06 Benutzer 1 Install (User) Success
06.08.2014 11:06 SYSTEM Install (Machine) Success

Notebook 2:
11.12.2014 16:43 Benutzer 7 Install (User) Success
09.12.2014 18:41 Benutzer 6 Install (User) Success
07.09.2014 20:07 Benutzer 5 Install (User) Success
04.08.2014 10:59 Benutzer 4 Install (User) Success
08.07.2014 09:26 Benutzer 3 Install (User) Success
09.06.2014 10:47 Benutzer 2 Install (User) Success
16.05.2014 11:55 Benutzer 1 Install (User) Success
26.03.2014 05:36 SYSTEM Install (Machine) Success


Was will mir Fehler 2! sagen? Wieso geht es bei manchen und bei manchen nicht?

Was ich schon überprüft habe:
funktionieren andere cmd Befehle ? - nein
sind die Rechte auf d:\ unterschiedlich (zwischen funktionierendem Rechner und nicht funktionierendem Rechner)? - nein
unterschiedliche Setup.exe oder Setup.inf Dateien auf den Rechnern? - nein
funktioniert es mit einem anderem Benutzer? - nein
Kennwort von "root" abgelaufen? - nein
"" anders gesetzt - kein Erfolg
"%windowsuser%" durch "test" getauscht - kein Erfolg

Jemand ne Idee, wie man das noch weiter debuggen könnte?

Danke und Grüße
Tom

[Hendrik_Ambrosius]

Fehler 2 = Datei nicht gefunden.
Vielleicht hilft es den Befehl in eine Batchdatei zu schreiben und dann so aufzurufen.
Vielleicht kommt er (manchmal?) mit den geschachtelten Anführungszeichen nicht zurecht.

[TPrummer]

Aber es gibt ja überhaupt keine Datei zu finden

via Batch geht das mit dem Kennwort leider nicht so einfach - da braucht man dann noch PsExec.exe mit dazu

[Hendrik_Ambrosius]

Doch, die cmd.exe.
Wie wäre es versuchsweise mit %windir%\cmd.exe ?

Wieso sollte man für eine Batchdatei psexec brauchen?
Kann man doch der cmd.exe auch als Parameter mitgeben.

[TPrummer]

stimmt die cmd.exe muss er ausführen... kann aber auch ausgeschlossen werden.

Kann Befehl 'CallRunAs /U:.\root /P:1234 "C:\Windows\Syswow64\cmd.exe"' nicht ausführen. Fehler 2!
Kann Befehl 'CallRunAs /U:.\root /P:1234 "C:\Windows\Syswow64\calc.exe"' nicht ausführen. Fehler 2!
Kann Befehl 'CallRunAs /U:.\root /P:1234 "C:\Temp\test.txt"' nicht ausführen. Fehler 2!

Wird den für den CallRunAs-Befehl eine CallRunAs.exe oder so angesteuert die fehlt?

[Hendrik_Ambrosius]

Nein, ist alles in der setup.exe drin.
Aber es kann sein dass auf einigen Clients eine zu alte setup.exe liegt.
Das am besten mal checken.
Ab welcher Version genau der Befehl drin ist kann ich so spontan aber nicht sagen.

[TPrummer]

Leider überall identisch...

Rechner bei dem es funktioniert:
in EmpirumAgent\User\Setup.exe | Größe 3111KB | Änderungsdatum 22.10.2014 02:51 | Dateiversion 15.1.1.1285
in %Windir%\System32\Empirum\Setup.exe | Größe 3111KB | Änderungsdatum 22.10.2014 02:51 | Dateiversion 15.1.1.1285

Rechner bei dem es nicht funktioniert:
in EmpirumAgent\User\Setup.exe | Größe 3111KB | Änderungsdatum 22.10.2014 02:51 | Dateiversion 15.1.1.1285
in %Windir%\System32\Empirum\Setup.exe | Größe 3111KB | Änderungsdatum 22.10.2014 02:51 | Dateiversion 15.1.1.1285

Server:
Configurator\User\Setup.exe | Größe 3111KB | Änderungsdatum 22.10.2014 02:51 | Dateiversion 15.1.1.1285

Der Ordner "Configurator\User" auf Server und den Clients hat die selbe Größe.
Der Ordner "%Windir%\System32\Empirum" ist auf beiden Clients gleich.


Laut Inventory ist auf beiden Rechnern die selbe Software installiert.
Selbe Hardware.
Beide wurden am 26.03.2014 gegen 05:15 installiert.


Gibt es weitere Debug- bzw. Loggingoptionen der Setup.exe?

[Hendrik_Ambrosius]

Ja, man kann die setup.exe per Debugview monitoren.

[TPrummer]

Funktioniert nicht:
[2068] ComJobSmb.cpp(580):INFO Job Smb Files Setup.exe and C:\EmpirumAgent\User\Setup.exe are identical
[2068] # swdepot # "C:\Program Files\Common Files\Setup64\Setup.exe" "C:\EmpirumInst\System\Partition D\1.0\Install\Setup.inf" /S0 /X8
[2068] # normal # SwDepot->CmdLine:"C:\Program Files\Common Files\Setup64\Setup.exe" "C:\EmpirumInst\System\Partition D\1.0\Install\Setup.inf" /S0 /X8 "/E:+C:\EmpirumAgent\log\SetupErrorLog\DSP.Rechner1.2015-01-09_10-06-02.217.log"
[2068] # normal # Setup callback sending: System\Partition D\1.0 with "C:\Program Files\Common Files\Setup64\Setup.exe" "C:\EmpirumInst\System\Partition D\1.0\Install\Setup.inf" /S0 /X8 "/E:+C:\EmpirumAgent\log\SetupErrorLog\DSP.Rechner1.2015-01-09_10-06-02.217.log"
[2068] "C:\Program Files\Common Files\Setup64\Setup.exe" "C:\EmpirumInst\System\Partition D\1.0\Install\Setup.inf" /S0 /X8 "/E:+C:\EmpirumAgent\log\SetupErrorLog\DSP.Rechner1.2015-01-09_10-06-02.217.log"
[2068] # normal # setup.exe process 4952 has exited with code -1
[2068] # swdepot # "C:\Program Files\Common Files\Setup64\Setup.exe" "C:\EmpirumInst\System\Partition D\1.0\Install\Setup.inf" /S0 /X8 "/E:+C:\EmpirumAgent\log\SetupErrorLog\DSP.Rechner1.2015-01-09_10-06-02.217.log"


Funktioniert:
[1636] ComJobSmb.cpp(580):INFO Job Smb Files Setup.exe and C:\EmpirumAgent\User\Setup.exe are identical
[1636] # swdepot # "C:\Program Files\Common Files\Setup64\Setup.exe" "C:\EmpirumInst\System\Partition D\1.0\Install\Setup.inf" /S0 /X8
[1636] # normal # SwDepot->CmdLine:"C:\Program Files\Common Files\Setup64\Setup.exe" "C:\EmpirumInst\System\Partition D\1.0\Install\Setup.inf" /S0 /X8 "/E:+C:\EmpirumAgent\log\SetupErrorLog\DSP.Rechner2.2015-01-09_10-09-48.347.log"
[1636] # normal # Setup callback sending: System\Partition D\1.0 with "C:\Program Files\Common Files\Setup64\Setup.exe" "C:\EmpirumInst\System\Partition D\1.0\Install\Setup.inf" /S0 /X8 "/E:+C:\EmpirumAgent\log\SetupErrorLog\DSP.Rechner2.2015-01-09_10-09-48.347.log"
[1636] "C:\Program Files\Common Files\Setup64\Setup.exe" "C:\EmpirumInst\System\Partition D\1.0\Install\Setup.inf" /S0 /X8 "/E:+C:\EmpirumAgent\log\SetupErrorLog\DSP.Rechner2.2015-01-09_10-09-48.347.log"
[1636] # normal # setup.exe process 6188 has exited with code 0
[1636] # swdepot # "C:\Program Files\Common Files\Setup64\Setup.exe" "C:\EmpirumInst\System\Partition D\1.0\Install\Setup.inf" /S0 /X8 "/E:+C:\EmpirumAgent\log\SetupErrorLog\DSP.Rechner2.2015-01-09_10-09-48.347.log"


"C:\Program Files\Common Files\Setup64\Setup.exe" bei beiden gleich
Änderungsdatum 22.10.2014 02:51 | Größe: 1641 KB | 15.1.1.1285

[Hendrik_Ambrosius]

Das sieht mir aber nach einem Log der swdepot.exe bzw. eris.exe und nicht der setup.exe aus?!

[TPrummer]

Ich habe gefiltert nach Setup.exe und dann nach neuer Software gesucht.
Wie könnte man es noch machen?

[Hendrik_Ambrosius]

Nach der Prozess-ID filtern wie hier beschrieben:
http://helpfiles.matrix42-web.de/2014_D ... =debugview

[Hendrik_Ambrosius]

Noch ne Idee dazu:
Wie wäre es wenn man einfach eine zweite setup.exe (z.B. umbenannt nach setup2.exe um das ganze übersichtlicher zu machen) via CALLRUNAS aufruft?
Dort hat man dann die ganze Syntax der setup.inf und braucht auch nur ein script!

Beispiel für eine Minimal-Hülle, z.B. CreateUserDir.inf genannt:
[Setup]
Version=6.5
ShowCaption=1
Platform=x86

[Requirements]

[Application]
ShowEndMessage=0
DisableCancelButton=1
SrcDir=..

[Options]
run = run, COPYALWAYS

[run]
echo user=%Windowsuser%
mkdir d:\%windowsuser%
#Security:RechteSetzen
...usw...

[TPrummer]

Leider weiß man ja die PID der Setup.exe vorher nicht, habs jetzt einfach mal mit include * laufen lassen.

Es gibt zwei verschiedene Aufzeichnungen:
00004332 7.45778561 [6380] CalledFromService:
00004333 7.45780230 [6380] bRunAsLocalSystem: 0
00004334 7.45878601 [6380] Userdomain: Domain
00004335 7.45879459 [6380] WindowsUser: User
00004336 7.45880890 [6380] Looking up SID for user Domain\User
00004337 7.45918369 [6380] SecuritySID: S-1-5-21-123456-1231234234-234234234-6513
00004338 7.91454172 [6380] start to get commandline params
00004339 8.35608864 [6380] : bConfigChanged: 0, bExitWindows: 0
00004340 8.35608864 [6380]
00004341 8.47535229 [6380] : Return value from Setup main: -1

und
00004329 3.83106995 [1004] CalledFromService:
00004330 3.83111215 [1004] bRunAsLocalSystem: 0
00004331 3.83213377 [1004] Userdomain: Domain
00004332 3.83214164 [1004] WindowsUser: User
00004333 3.83215666 [1004] Looking up SID for user Domain\User
00004334 3.83247042 [1004] SecuritySID: S-1-5-21-123456-1231234234-234234234-6513
00004335 3.84267545 [FFFFFA80047EFA70] WskProIRPGetAddrInfo is called.
00004336 3.84268212 [bind=FFFFFA8008C2A820] Binding reference count++ = 2 (status = 00000000, impersonation= 2).
00004337 3.84268403 [FFFFFA800794D0E0] Request reference count++ = 3.
00004338 3.84270072 [FFFFFA800794D0E0] RPC method type = 1: rpc-method succeeded, queue to rpc-pending-list.
00004339 3.84270263 [FFFFFA800794D0E0] Request reference count-- = 2.
00004340 3.84328413 [FFFFFA800794D0E0] WskKnrRpcComplete: rpc calls back for completion.
00004341 3.84328699 [FFFFFA800794D0E0] WskKnrCompletePending: complete pending request (rpc=1).
00004342 3.84328842 [FFFFFA800794D0E0] Request reference count-- = 1.
00004343 3.84329009 [FFFFFA800794D0E0] Request reference count-- = 0.
00004344 3.84329796 [FFFFFA800794D0E0] WskKnrCompleteRequest: rpc completion return status = 00000000 (reply=00000000).
00004345 3.84330034 [FFFFFA800794D0E0] WskProAPIGetAddressInfo returned addrinfo: [addr=FFFFF8A00B9F4960].
00004346 3.84330177 [bind=FFFFFA8008C2A820] Binding reference count-- = 1.
00004347 3.84330416 [FFFFFA800794D0E0] WskKnrCompleteRequest: complete irp with IO status = 00000000.
00004348 3.94306588 [addr=FFFFF8A00B9F4960] WskProAPIFreeAddressInfo freed addrinfo.
00004349 4.43169832 [FFFFFA8004B50490] WskProIRPGetAddrInfo is called.
00004350 4.43170977 [bind=FFFFFA8008C2A820] Binding reference count++ = 2 (status = 00000000, impersonation= 2).
00004351 4.43171167 [FFFFFA800BB64610] Request reference count++ = 3.
00004352 4.43172979 [FFFFFA800BB64610] RPC method type = 1: rpc-method succeeded, queue to rpc-pending-list.
00004353 4.43173218 [FFFFFA800BB64610] Request reference count-- = 2.
00004354 4.43262148 [FFFFFA800BB64610] WskKnrRpcComplete: rpc calls back for completion.
00004355 4.43262529 [FFFFFA800BB64610] WskKnrCompletePending: complete pending request (rpc=1).
00004356 4.43262672 [FFFFFA800BB64610] Request reference count-- = 1.
00004357 4.43262911 [FFFFFA800BB64610] Request reference count-- = 0.
00004358 4.43264103 [FFFFFA800BB64610] WskKnrCompleteRequest: rpc completion return status = 00000000 (reply=00000000).
00004359 4.43264341 [FFFFFA800BB64610] WskProAPIGetAddressInfo returned addrinfo: [addr=FFFFF8A00EA1CCE0].
00004360 4.43264580 [bind=FFFFFA8008C2A820] Binding reference count-- = 1.
00004361 4.43264866 [FFFFFA800BB64610] WskKnrCompleteRequest: complete irp with IO status = 00000000.
00004362 4.53300333 [addr=FFFFF8A00EA1CCE0] WskProAPIFreeAddressInfo freed addrinfo.
00004363 4.94270802 [1004] start to get commandline params
00004364 4.94366980 [1004] : bConfigChanged: 0, bExitWindows: 0
00004365 4.94366980 [1004]
00004366 4.96256685 [1004] : Return value from Setup main: -1

Das mit der zweiten Setup.exe teste ich mal

[TPrummer]

2. klappt leider auch nicht:
Kann Befehl 'CallRunAsHidden /U:.\root /P:1234 "C:\Program Files\Common Files\Setup64\Setup2.exe" "C:\EmpirumInst\System\Partition D\1.0\Install\Setup2.inf" /S0 /X8' nicht ausführen.
Fehler 2!
OK