Attachment 55244 Details for Bug 165948 – test3_two-pauses_events-no_servicelog.log

Some Eclipse Foundation services are deprecated, or will be soon. Please ensure you've read this important communication.

test3_two-pauses_events-no_servicelog.log

test3_two-pauses_events-no_servicelog.log (text/plain), 17.51 KB, created by Michael Spivak-Baranov

on 2006-12-07 11:26:59 EST

(hide)

Description:

Filename:

MIME Type:

Creator: Michael Spivak-Baranov

Created: 2006-12-07 11:26:59 EST

Size: 17.51 KB

patch

obsolete

>createTransportListener (socket)
>Successfully loaded transport layer: socketTL
>
>Successfully loaded command extractor: tptpCmdExtr
>createTransportListener (named pipe).
>Successfully loaded transport layer: namedPipeTL
>
>Successfully loaded command extractor: tptpCmdExtr
>createTransportListener (named pipe).
>Successfully loaded transport layer: namedPipeTL
>
>Successfully loaded command extractor: tptpCmdExtr
>createTransportListener (shared memory).
>Successfully loaded transport layer: sharedMemTL
>
>Successfully loaded command extractor: tptpCmdExtr
>Process polling thread created, tid = 2328
>CLASSPATH used for staring file server = D:\tptpAC\plugins\org.eclipse.tptp.platform.collection.framework_4.1.100.v200606131519\hcframe.jar;D:\tptpAC\plugins\org.eclipse.hyades.execution_4.2.2.v200609010912\hexr.jar;D:\tptpAC\plugins\org.eclipse.hyades.execution_4.2.2.v200609010912\hexl.jar;D:\tptpAC\plugins\org.eclipse.hyades.execution_4.2.2.v200609010912\hexcore.jar;;D:\tptpAC\plugins\org.eclipse.core.runtime_3.2.0.v20060603.jar;D:\tptpAC\plugins\org.eclipse.equinox.common_3.2.0.v20060603.jar;D:\tptpAC\plugins\org.eclipse.osgi_3.2.1.R32x_v20060823.jar;D:\tptpAC\plugins\com.ibm.icu_3.4.5.jar
>Loaded JVM library C:\Program Files\Java\j2re1.4.2_12\bin\client\jvm.dll
>Resolved entrypoint for JNI_CreateJavaVM
>Successfully loaded transport layer: tptpCCTL
>
>Successfully loaded command extractor: tptpCmdExtr
>Successfully loaded transport layer: tptpACTL
>
>Successfully loaded command extractor: tptpCmdExtr
>Ready to start servers
>startTransportListener (socket)
>Named pipe server is running and listening at "\\.\pipe\IBMAC\acmaster" pipe.
>Ready to accept next named pipe request.
>ConnectionManger - successfully added connectionID 100 for transportID 1004
>
>Received command for unrecognized interface: iid=org.eclipse.tptp.eventProvider, cmd=listenerAccepted
>Named pipe server is running and listening at "\\.\pipe\IBMAC\acmasterlog" pipe.
>Ready to accept next named pipe request.
>Shared memory server is running and listening at "acbuffer" name.
>Socket server is running at port number of 10006.
>Starting Process Controller:D:\tptpAC\bin\tptpProcessController.exe
>SUCCESSFULLY started Process Controller (pid=3356)
>Everything is running
>Ready to accept next named pipe request.
>Received(49 bytes).
>Validated message of 49 bytes
>ConnectionManger - successfully added connectionID 101 for transportID 1002
>
>NamedPipe getInitRequestDataBlock: returning Connection ID: 101.
>UUID: 3f08c349-07bc-464f-8358-b054df984ac2.
>NamedPipe: Sent 16 bytes on connection ID 101
>Ready to accept next named pipe request.
>Received(189 bytes).
>Validated message of 189 bytes
>Agent's (ProcessController) connection id is - 101
>Ready to accept next named pipe request.
>Received(189 bytes).
>Validated message of 189 bytes
>Agent(101): Bytes in msg left to be processed: 0 bytes.
>Ready to accept next named pipe request.
>Received(201 bytes).
>Validated message of 201 bytes
>BaseAgent registerAgent: Agent (ProcessController) connected to AC 
>Ready to accept next named pipe request.
>Received(171 bytes).
>Validated message of 171 bytes
>Received(137 bytes).
>Validated message of 137 bytes
>Try count 1 and connect result - 1908
>getApplicationAliases called
>getApplicationAliases sending response
>Ready to accept next named pipe request.
>sendMessage (named pipe) to this connection id(101).
>NamedPipe: Sent 5967 bytes on connection ID 101
>Received(164 bytes).
>Validated message of 164 bytes
>Ready to accept next named pipe request.
>Agent(101): processRecdMsgs().
>Ready to accept next named pipe request.
>Received(186 bytes).
>Validated message of 186 bytes
>Agent 'ProcessController' handling xml cmd
>Ready to accept next named pipe request.
>Received(6141 bytes).
>Validated message of 6141 bytes
>Agent 'ProcessController' parsed xml cmd <Cmd src="1" dest="101" ctxt="3"><applicationAliases iid="org.eclipse.tptp.agentManager"><aliases><ApplicationAliases>
>		<Application configuration="default" executable="java.exe" location="%SYS_TEMP_DIR%" path="%JAVA_PATH%">
>			<Variable name="CLASSPATH" position="append" value="%CLASSPATH_ORG_ECLIPSE_EQUINOX_COMMON%"/>
>			<Variable name="PATH" position="prepend" value="%RASERVER_HOME%\bin"/>
>		</Application>
>	<Application configuration="default" executable="RemoteLogParserLoader" location="%SYS_TEMP_DIR%" path="%JAVA_PATH%">
>		<Variable name="GLA_CONFIG_PATH" position="replace" value="%PLUGINS_HOME%\org.eclipse.hyades.logging.parsers_4.2.1.v200608241753\config"/>
>		<Variable name="CLASSPATH" position="replace" value="%CLASSPATH_ORG_ECLIPSE_HYADES_LOGGING_PARSERS%"/>
>		<Variable name="CLASSPATH" position="append" value="%CLASSPATH_ORG_ECLIPSE_HYADES_LOGGING_ADAPTER%"/>
>		<Variable name="CLASSPATH" position="append" value="%CLASSPATH_ORG_ECLIPSE_HYADES_LOGGING_CORE%"/>
>		<Variable name="CLASSPATH" position="append" value="%CLASSPATH_ORG_APACHE_JAKARTA_COMMONS_LOGGING%"/>
>		<Variable name="CLASSPATH" position="append" value="%CLASSPATH_ORG_ECLIPSE_EMF_ECORE%"/>
>		<Variable name="CLASSPATH" position="append" value="%CLASSPATH_ORG_ECLIPSE_EMF_COMMON%"/>
>		<Variable name="CLASSPATH" position="append" value="%CLASSPATH_ORG_ECLIPSE_HYADES_EXECUTION%"/>
>		<Variable name="CLASSPATH" position="append" value="%CLASSPATH_COM_IBM_ICU%"/>
>		<Parameter position="prepend" value="org.eclipse.hyades.logging.parsers.importer.RemoteLogParserLoader"/>
>		<Parameter position="prepend" value="-DGLA_HOME=&quot;%GLA_HOME%&quot;"/>
>		<Parameter position="prepend" value="-Djava.version=1.4"/>
>		<Parameter position="append" value="&quot;config_path=%GLA_CONFIG_PATH%&quot;"/>
>	</Application><Application configuration="default" executable="PerfmonAgent" location="%RASERVER_HOME%\bin" path="%RASERVER_HOME%\bin\PerfmonAgent.exe">
>		<Variable name="CLASSPATH" position="append" value="%CLASSPATH_ORG_ECLIPSE_HYADES_LOGGING_CORE%"/>
>		<Variable name="CLASSPATH" position="append" value="%CLASSPATH_ORG_ECLIPSE_HYADES_EXECUTION%"/>
>		<Variable name="CLASSPATH" position="append" value="%CLASSPATH_ORG_ECLIPSE_TPTP_PLATFORM_COLLECTION_FRAMEWORK%"/>
>	</Application><Application configuration="default" executable="JonasAgent" location="%SYS_TEMP_DIR%" path="%JAVA_PATH%">
>		<Variable name="CLASSPATH" position="append" value="%PLUGINS_HOME%\org.eclipse.hyades.perfmon.agents_4.0.0\jmx\lib\jmxagent.jar"/>
>		<Variable name="CLASSPATH" position="append" value="%CLASSPATH_ORG_ECLIPSE_HYADES_PERFMON_AGENTS%"/>
>		<Parameter position="append" value="-Dapp_home=%JONAS_HOME%"/>
>		<Parameter position="append" value="-DagentXML=%PLUGINS_HOME%\org.eclipse.hyades.perfmon.agents_4.0.0\jmx\agentXML\JOnAS.xml org.eclipse.hyades.perfmon.agents.jmx.JmxAgent"/>
>	</Application><Application configuration="default" executable="JBossAgent" location="%SYS_TEMP_DIR%" path="%JAVA_PATH%">
>		<Variable name="CLASSPATH" position="append" value="%PLUGINS_HOME%\org.eclipse.hyades.perfmon.agents_4.0.0\jmx\lib\jmxagent.jar"/>
>		<Variable name="CLASSPATH" position="append" value="%CLASSPATH_ORG_ECLIPSE_HYADES_PERFMON_AGENTS%"/>
>		<Parameter position="append" value="-Dapp_home=%JBOSS_HOME%"/>
>		<Parameter position="append" value="-DagentXML=%PLUGINS_HOME%\org.eclipse.hyades.perfmon.agents_4.0.0\jmx\agentXML\JBoss.xml org.eclipse.hyades.perfmon.agents.jmx.JmxAgent"/>
>	</Application><Application configuration="default" executable="ApacheAgent" location="%SYS_TEMP_DIR%" path="%JAVA_PATH%">
>		<Variable name="CLASSPATH" position="append" value="%CLASSPATH_ORG_ECLIPSE_HYADES_PERFMON_AGENTS%"/>
>		<Variable name="CLASSPATH" position="append" value="%PLUGINS_HOME%\org.eclipse.hyades.perfmon.agents_4.0.0\apache\lib\apacheagent.jar"/>
>		<Parameter position="prepend" value="org.eclipse.hyades.perfmon.agents.apache.ApacheAgent"/>
>	</Application><Application configuration="default" executable="MySQLAgent" location="%SYS_TEMP_DIR%" path="%JAVA_PATH%">
>		<Variable name="CLASSPATH" position="append" value="%CLASSPATH_OR
>Ready to accept next named pipe request.
>Received(186 bytes).
>Validated message of 186 bytes
>PC processCommand: processing cmd:applicationAliases
>Ready to accept next named pipe request.
>Received(189 bytes).
>Validated message of 189 bytes
>Agent(101): Bytes in msg left to be processed: 0 bytes.
>Ready to accept next named pipe request.
>Received(172 bytes).
>Validated message of 172 bytes
>Received(210 bytes).
>Validated message of 210 bytes
>registerAgent( ProcessController, 101 ) called
>sendMessage (named pipe) to this connection id(101).
>NamedPipe: Sent 123 bytes on connection ID 101
>Ready to accept next named pipe request.
>Try count 1 and connect result - 1908
>Ready to accept next named pipe request.
>Received(165 bytes).
>Validated message of 165 bytes
>Agent(101): processRecdMsgs().
>Ready to accept next named pipe request.
>Received(187 bytes).
>Validated message of 187 bytes
>Agent 'ProcessController' handling xml cmd
>Ready to accept next named pipe request.
>Received(361 bytes).
>Validated message of 361 bytes
>Agent 'ProcessController' parsed xml cmd <Cmd src="1" dest="101" ctxt="10"><agentRegistered iid="org.eclipse.tptp.agentManager"></agentRegistered></Cmd>
>Ready to accept next named pipe request.
>Received(212 bytes).
>Validated message of 212 bytes
>BaseAgent registerAgent: Agent register with AC completed (ProcessController)
>Ready to accept next named pipe request.
>Received(191 bytes).
>Validated message of 191 bytes
>PC processCommand: BaseAgent handled cmd:agentRegistered
>Ready to accept next named pipe request.
>Received(197 bytes).
>Validated message of 197 bytes
>ProcessController: Starting the monitorProcessEvents thread...
>Ready to accept next named pipe request.
>Received(190 bytes).
>Validated message of 190 bytes
>Agent(101): Bytes in msg left to be processed: 0 bytes.
>Ready to accept next named pipe request.
>Received(181 bytes).
>Validated message of 181 bytes
>PC handleProcessEvents: # of running procs = 0
>Ready to accept next named pipe request.
>File server started listening on port 10005
>Socket processClientRequest: Read 12 bytes.
>Socket processRecdMsgs: Process msg from Control channel.
>Socket: Read at least one complete message, process it.
>Socket processRecdMsgs: Process msg from Control channel.
>Socket: handle CONNECT request (Control channel).
>ConnectionManger - successfully added connectionID 102 for transportID 1000
>
>Socket handleCONNECT: using Connection ID: 102
>Socket: Sent 21 bytes on connection ID 102
>Socket processClientRequest: Read 164 bytes.
>Socket processRecdMsgs: Process msg from Control channel.
>Socket: Read at least one complete message, process it.
>Socket processRecdMsgs: Process msg from Control channel.
>Socket processTheMessageHeader: Stripped header from non-TL message.
>getAgent( ProcessController ) called
>findActiveAgentByName looking for ProcessController
>findActiveAgentByName comparing to for ProcessController
>findActiveAgentByName match ProcessController
>sendMessage (named pipe) to this connection id(101).
>NamedPipe: Sent 156 bytes on connection ID 101
>sendMessage (socket) to this connection id(102)
>Socket: Sent 167 bytes on connection ID 102
>Received(165 bytes).
>Validated message of 165 bytes
>Agent(101): processRecdMsgs().
>Ready to accept next named pipe request.
>Received(187 bytes).
>Validated message of 187 bytes
>Agent 'ProcessController' handling xml cmd
>Ready to accept next named pipe request.
>Received(418 bytes).
>Validated message of 418 bytes
>Agent 'ProcessController' parsed xml cmd <Cmd src="1" dest="101" ctxt="-1"><notifyReference iid="org.eclipse.tptp.Agent"><clientID>102</clientID><flags>0</flags></notifyReference></Cmd>
>Ready to accept next named pipe request.
>Received(191 bytes).
>Validated message of 191 bytes
>PC processCommand: BaseAgent handled cmd:notifyReference
>Ready to accept next named pipe request.
>Received(190 bytes).
>Validated message of 190 bytes
>Agent(101): Bytes in msg left to be processed: 0 bytes.
>Ready to accept next named pipe request.
>Socket processClientRequest: Read 219 bytes.
>Socket processRecdMsgs: Process msg from Control channel.
>Socket: Read at least one complete message, process it.
>Socket processRecdMsgs: Process msg from Control channel.
>Socket processTheMessageHeader: Stripped header from non-TL message.
>sendMessage (named pipe) to this connection id(101).
>NamedPipe: Sent 219 bytes on connection ID 101
>Received(165 bytes).
>Validated message of 165 bytes
>Agent(101): processRecdMsgs().
>Ready to accept next named pipe request.
>Received(187 bytes).
>Validated message of 187 bytes
>Agent 'ProcessController' handling xml cmd
>Ready to accept next named pipe request.
>Received(481 bytes).
>Validated message of 481 bytes
>Agent 'ProcessController' parsed xml cmd <Cmd ctxt="2" dest="101" src="102"><validateProcessToLaunch iid="org.eclipse.tptp.processController"><applicationName>d:\temp\1.bat</applicationName><workingDir>.</workingDir></validateProcessToLaunch></Cmd>
>Ready to accept next named pipe request.
>Received(192 bytes).
>Validated message of 192 bytes
>PC processCommand: processing cmd:validateProcessToLaunch
>Ready to accept next named pipe request.
>Received(215 bytes).
>Validated message of 215 bytes
>PC validateProcessToLaunch sending reply with validApp=1, validWorkingDir=1
>
>Ready to accept next named pipe request.
>Received(172 bytes).
>Validated message of 172 bytes
>Received(207 bytes).
>Validated message of 207 bytes
>sendMessage (socket) to this connection id(102)
>Socket: Sent 206 bytes on connection ID 102
>Try count 1 and connect result - 1904
>Ready to accept next named pipe request.
>Received(190 bytes).
>Validated message of 190 bytes
>Agent(101): Bytes in msg left to be processed: 0 bytes.
>Ready to accept next named pipe request.
>Ready to accept next named pipe request.
>Socket processClientRequest: Read 288 bytes.
>Socket processRecdMsgs: Process msg from Control channel.
>Socket: Read at least one complete message, process it.
>Socket processRecdMsgs: Process msg from Control channel.
>Socket processTheMessageHeader: Stripped header from non-TL message.
>sendMessage (named pipe) to this connection id(101).
>NamedPipe: Sent 288 bytes on connection ID 101
>Received(165 bytes).
>Validated message of 165 bytes
>Agent(101): processRecdMsgs().
>Ready to accept next named pipe request.
>Received(187 bytes).
>Validated message of 187 bytes
>Agent 'ProcessController' handling xml cmd
>Ready to accept next named pipe request.
>Received(610 bytes).
>Validated message of 610 bytes
>Agent 'ProcessController' parsed xml cmd <Cmd ctxt="4" dest="101" src="102"><startProcess iid="org.eclipse.tptp.processController"><launchInfo><Application executable="d:\temp\1.bat" location="."><Parameter value=""/></Application><keepRunning>0</keepRunning><noNotices>0</noNotices></launchInfo></startProcess></Cmd>
>Ready to accept next named pipe request.
>Received(181 bytes).
>Validated message of 181 bytes
>PC processCommand: processing cmd:startProcess
>Ready to accept next named pipe request.
>Received(204 bytes).
>Validated message of 204 bytes
>PC processCommand: Notified startProcesses thread of new item on list
>Ready to accept next named pipe request.
>Received(204 bytes).
>Validated message of 204 bytes
>startProcesses Thread: Received notification of new process to launch
>Ready to accept next named pipe request.
>Received(190 bytes).
>Validated message of 190 bytes
>Agent(101): Bytes in msg left to be processed: 0 bytes.
>Ready to accept next named pipe request.
>Received(204 bytes).
>Validated message of 204 bytes
>PC startProcess: Retrieving process launch info from startProcessList
>Ready to accept next named pipe request.
>Received(224 bytes).
>Validated message of 224 bytes
>PC doCreateProcess: Successfully launched process exe 'd:\temp\1.bat', pid 3696
>Ready to accept next named pipe request.
>Received(202 bytes).
>Validated message of 202 bytes
>PC handleProcessEvents: got new list of running procs, numProcs = 1
>Ready to accept next named pipe request.
>Received(172 bytes).
>Received(8096 bytes).
>Validated message of 172 bytes
>Validated message of 13701 bytes
>Overfolow -- reallocating message buffer (13702 bytes).
>Received(13701 bytes).
>Validated message of 13701 bytes
>Try count 1 and connect result - 1892
>Ready to accept next named pipe request.
>sendMessage (socket) to this connection id(102)
>Socket: Sent 13700 bytes on connection ID 102
>Ready to accept next named pipe request.
>Received(192 bytes).
>Validated message of 192 bytes
>PC handleProcessEvents: Process has exited with status 1.
>Ready to accept next named pipe request.
>Received(201 bytes).
>Validated message of 201 bytes
>PC handleProcessEvents: Found the exited process 3696 in our list.
>Ready to accept next named pipe request.
>Received(173 bytes).
>Validated message of 173 bytes
>PC: Sending event to Owner of pid 3696
>Ready to accept next named pipe request.
>Received(172 bytes).
>Validated message of 172 bytes
>Try count 1 and connect result - 1892
>Ready to accept next named pipe request.
>Received(186 bytes).
>Validated message of 186 bytes
>sendMessage (socket) to this connection id(102)
>Socket: Sent 185 bytes on connection ID 102
>Ready to accept next named pipe request.
>Received(178 bytes).
>Validated message of 178 bytes
>PC: Sending event to 0 Monitors of pid 3696
>Ready to accept next named pipe request.
>Received(180 bytes).
>Validated message of 180 bytes
>PC: Sending event to 0 Listeners for pid 3696
>Ready to accept next named pipe request.
>Received(181 bytes).
>Validated message of 181 bytes
>PC handleProcessEvents: # of running procs = 0
>Ready to accept next named pipe request.
>Received(202 bytes).
>Validated message of 202 bytes
>PC handleProcessEvents: got new list of running procs, numProcs = 0
>Ready to accept next named pipe request.

Actions: View

Attachments on bug 165948: 55240 | 55241 | 55242 | 55243 | 55244 | 55245 | 55246 | 55247 | 57719 | 58241 | 58962