Hi guys,

I am currently experiencing this somewhat strange problem with the
Scripting Driver 4.5:
Polling-Intervall: 300
Script timeout: 240

My poll script is set to exit by itself after 200 seconds So i would
expect to see the following messages in the trace:

1. Poll started
2. 200s later Poll finished code 0
3. Publisher detected Event

However this is what i seee:

Code:
--------------------
2015-04-01 17:05:31 [4048@4896] (trace): --->DriverShim publisher channel: polling...
2015-04-01 17:05:31 [4048@4896] (trace): --->DriverShim publisher channel: executing poll
2015-04-01 17:05:31 [4048@4896] (trace): --->WindowsScript Driver Publisher channel: executing polling script
2015-04-01 17:05:31 [4048@4896] (trace): WindowsScript_executeCommand: Executing command bin\scriptclient.exe "scripts\powershell\Poll.ps1" "C:\Users\S-GLB-~1\AppData\Local\Temp\WSD3B90.tmp"
2015-04-01 17:07:03 [4048@4896] (trace): WindowsScript_executeCommand: command exited with code 1
2015-04-01 17:07:03 [4048@4896] (trace): --->WindowsScript Driver Publisher channel: polling script returned error 1
2015-04-01 17:07:03 [4048@4896] (trace): --->DriverShim publisher channel: checking change log
2015-04-01 17:07:03 [4048@4896] (trace): --->WindowsScript Publisher channel detected an event
2015-04-01 17:07:03 [4048@4896] (trace): Received document from publicationShim:
2015-04-01 17:07:03 [4048@4896] (trace): <nds dtdversion="2.0" ndsversion="8.x">
2015-04-01 17:07:03 [4048@4896] (trace): <source>
2015-04-01 17:07:03 [4048@4896] (trace): <product version="4.5" build="201409041500" />
2015-04-01 17:07:03 [4048@4896] (trace): <contact />
2015-04-01 17:07:03 [4048@4896] (trace): </source>
2015-04-01 17:07:03 [4048@4896] (trace): <input>
2015-04-01 17:07:03 [4048@4896] (trace): <modify event-id="20150401150557Z#0000501000" class-name="User">
--------------------

As you can see the after roughly 90s the script is stopped with code 1

script-trace:

Code:
--------------------
4.01.2015 05:07:03 System.Threading.ThreadAbortException: Thread was being aborted.
at System.Threading.WaitHandle.WaitOneNative(SafeHand le waitableSafeHandle, UInt32 millisecondsTimeout, Boolean hasThreadAffinity, Boolean exitContext)
at System.Threading.WaitHandle.InternalWaitOne(SafeHa ndle waitableSafeHandle, Int64 millisecondsTimeout, Boolean hasThreadAffinity, Boolean exitContext)
at System.Management.Automation.Runspaces.PipelineBas e.Invoke(IEnumerable input)
at System.Management.Automation.RunspaceInvoke.Invoke (String script, IEnumerable input, IList& errors)
at Novell.IDM.WSD.ScriptService.ScriptServiceServer.E xecuteScript(String sScriptPath, String sArg0, String sArg1, String sArg2, String sArg3, String sArg4, String sArg5, String sArg6, String sArg7, String sArg8, String sArg9)
--------------------


So it appears that the script was terminated. However the poll script
still appears to be running which i can see from my poll debug log


Code:
--------------------
break because of timeout
time: 04/01/2015 17:05:57 endTime: 04/01/2015 17:08:53
time: 04/01/2015 17:06:04 endTime: 04/01/2015 17:08:53
time: 04/01/2015 17:06:11 endTime: 04/01/2015 17:08:53
time: 04/01/2015 17:06:18 endTime: 04/01/2015 17:08:53
time: 04/01/2015 17:06:30 endTime: 04/01/2015 17:08:53
time: 04/01/2015 17:06:41 endTime: 04/01/2015 17:08:53
time: 04/01/2015 17:06:47 endTime: 04/01/2015 17:08:53
time: 04/01/2015 17:06:54 endTime: 04/01/2015 17:08:53
time: 04/01/2015 17:07:01 endTime: 04/01/2015 17:08:53
time: 04/01/2015 17:07:08 endTime: 04/01/2015 17:08:53
time: 04/01/2015 17:07:21 endTime: 04/01/2015 17:08:53
time: 04/01/2015 17:07:28 endTime: 04/01/2015 17:08:53
time: 04/01/2015 17:07:36 endTime: 04/01/2015 17:08:53
time: 04/01/2015 17:07:43 endTime: 04/01/2015 17:08:53
time: 04/01/2015 17:07:52 endTime: 04/01/2015 17:08:53
time: 04/01/2015 17:08:15 endTime: 04/01/2015 17:08:53
time: 04/01/2015 17:08:22 endTime: 04/01/2015 17:08:53
time: 04/01/2015 17:08:29 endTime: 04/01/2015 17:08:53
time: 04/01/2015 17:08:35 endTime: 04/01/2015 17:08:53
time: 04/01/2015 17:08:42 endTime: 04/01/2015 17:08:53
time: 04/01/2015 17:08:49 endTime: 04/01/2015 17:08:53
time: 04/01/2015 17:08:55 endTime: 04/01/2015 17:08:53
break because of timeout
--------------------


This is extremely troublesome because while the script is still running
every command issued after will cause a
"Pipeline not run because a pipeline is already running." exception and
therefore fail with the following Status:
Error executing script command for object [unknown] (code 1). Event
discarded."

When i set my script to terminate before the 90 seconds are reached
everything is fine but this severely limits the number of publishing
events the
driver can process.

Has anybody a solution /explanation for this?

Regards Felix


--
fwitt
------------------------------------------------------------------------
fwitt's Profile: https://forums.netiq.com/member.php?userid=8759
View this thread: https://forums.netiq.com/showthread.php?t=53242