http://git-wip-us.apache.org/repos/asf/incubator-ignite/blob/23fd3d73/modules/core/src/test/resources/log/ignite.log.tst ---------------------------------------------------------------------- diff --git a/modules/core/src/test/resources/log/ignite.log.tst b/modules/core/src/test/resources/log/ignite.log.tst new file mode 100644 index 0000000..ea74097 --- /dev/null +++ b/modules/core/src/test/resources/log/ignite.log.tst @@ -0,0 +1,13706 @@ +[14:14:22,515][INFO ][main][GridListenActorSelfTest] + +>>> _____ _ _______ _ +>>> / ___/____(_)___/ / ___/___ _(_)___ +>>> / (_ // __/ // _ / (_ // _ `/ // _ \ +>>> \___//_/ /_/ \_,_/\___/ \_,_/_//_//_/ +>>> +>>> ---==++ IN-MEMORY BIG DATA ++==--- +>>> ver. x.x.x-DDMMYYYY +>>> Copyright (C) 2012 GridGain Systems + +[14:14:22,515][INFO ][main][GridListenActorSelfTest] << Enterprise Edition >> +[14:14:22,516][INFO ][main][GridListenActorSelfTest] Config URL: n/a +[14:14:22,516][INFO ][main][GridListenActorSelfTest] Daemon mode: off +[14:14:22,516][INFO ][main][GridListenActorSelfTest] Language runtime: Java Platform API Specification ver. 1.6 +[14:14:22,516][INFO ][main][GridListenActorSelfTest] JVM name: Java HotSpot(TM) 64-Bit Server VM +[14:14:22,516][INFO ][main][GridListenActorSelfTest] Remote Management [restart: off, REST: on, JMX (remote: off)] +[14:14:22,516][INFO ][main][GridListenActorSelfTest] GRIDGAIN_HOME=/usr/local/TeamCityAgent/work/d46fc9c3d71112c2 +[14:14:22,516][INFO ][main][GridListenActorSelfTest] VM arguments: [-ea, -XX:MaxPermSize=128m, -Xms512m, -Xmx1024m, -Duser.name=bamboo, -DGRIDGAIN_UPDATE_NOTIFIER=false, -DGRIDGAIN_DISABLED=true, -DGRIDGAIN_HOME=/usr/local/TeamCityAgent/work/d46fc9c3d71112c2, -DGRIDGAIN_STABLE_HOME=/usr/local/TeamCityAgent/work/d46fc9c3d71112c2, -DGRIDGAIN_ROUTER_PREFER_REMOTE=true, -DGRIDGAIN_NO_DISCO_ORDER=true, -DGRIDGAIN_QUIET=false, -DGG_TEST_HOME=/usr/local/TeamCityAgent/work/d46fc9c3d71112c2, -Dteamcity.build.id=34324, -Dteamcity.buildType.id=bt5, -Dagent.ownPort=9090, -Dteamcity.build.checkoutDir=/usr/local/TeamCityAgent/work/d46fc9c3d71112c2, -Dteamcity.build.workingDir=/usr/local/TeamCityAgent/work/d46fc9c3d71112c2, -Dagent.work.dir=/usr/local/TeamCityAgent/work, -Dagent.name=teamcity-4, -Dagent.home.dir=/usr/local/TeamCityAgent, -Dteamcity.runtime.props.file=/usr/local/TeamCityAgent/temp/agentTmp/ant2684847485530994862runtime] +[14:14:22,517][WARN ][main][GridListenActorSelfTest] SMTP is not configured - email notifications are off. +[14:14:22,517][WARN ][main][GridListenActorSelfTest] Cache is not configured - data grid is off. +[14:14:22,521][INFO ][main][GridListenActorSelfTest] 3-rd party licenses can be found at: /usr/local/TeamCityAgent/work/d46fc9c3d71112c2/libs/licenses +[14:14:22,522][INFO ][main][GridListenActorSelfTest] Non-loopback local IPs: fe80:0:0:0:ca60:ff:fe68:582c%2, 192.168.2.14 +[14:14:22,522][INFO ][main][GridListenActorSelfTest] Enabled local MACs: C8600068582C +[14:14:23,112][INFO ][main][GridJdkLocalMetricsSpi] Hyperic Sigar 'CpuPerc.getCombined()' method will be used to detect average CPU load. +[14:14:23,165][INFO ][main][GridTcpCommunicationSpi] Successfully bound to TCP port [port=45010, locHost=/192.168.2.14] +[14:14:23,462][INFO ][main][GridListenActorSelfTest] Security status [authentication=on, secure-session=on] +[14:14:23,504][WARN ][main][GridMulticastDiscoverySpi] Heartbeat frequency is too low (at least 2000 ms): 1000 +[14:14:23,505][INFO ][main][GridMulticastDiscoverySpi] Successfully bound to TCP port: 55010 +[14:14:23,507][INFO ][main][GridMulticastDiscoverySpi] Successfully bound to Multicast port: 50001 +[14:14:23,516][INFO ][main][GridMulticastDiscoverySpi] Local node: GridMulticastDiscoveryNode [id=353d63b5-a2f0-41d1-a30e-37016f357233, state=READY, lastHeartbeat=1353320063506, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55010, startTime=1353320063496] +[14:14:23,526][INFO ][main][GridDiscoveryManager] Topology snapshot [nodes=1, CPUs=4, hash=0x8C20EE0] +[14:14:23,529][INFO ][main][GridMulticastDiscoverySpi] Waiting for initial heartbeat timeout (1000 ms) +[14:14:24,707][INFO ][main][GridJettyRestProtocol] Command protocol successfully started: Jetty REST +[14:14:24,720][INFO ][main][GridTcpRestProtocol] Command protocol successfully started: TCP binary +[14:14:24,721][INFO ][main][GridLicenseControllerImpl] Licensed to 'GridGain Systems, Internal Development Only' on Feb 3, 2011 +[14:14:24,721][INFO ][main][GridLicenseControllerImpl] License [ID=7D5CB773-225C-4165-8162-3BB67337894B, type=ENT] +[14:14:24,721][INFO ][main][GridLicenseControllerImpl] License limits [expire-date: never] +[14:14:24,740][INFO ][main][GridListenActorSelfTest] + +>>> +--------------------------+ +>>> GridGain ver. x.x.x-DDMMYYYY +>>> +--------------------------+ +>>> OS name: Linux 2.6.32-38-generic amd64 +>>> OS user: bamboo +>>> CPU(s): 4 +>>> VM information: Java(TM) SE Runtime Environment 1.6.0_30-b12 Sun Microsystems Inc. Java HotSpot(TM) 64-Bit Server VM 20.5-b03 +>>> VM name: 573@gg-teamcity-4 +>>> Grid name: kernal.GridListenActorSelfTest +>>> Local node [ID=353D63B5-A2F0-41D1-A30E-37016F357233, order=1353320063496] +>>> Local node addresses: [192.168.2.14] +>>> Local ports: TCP:8080 TCP:11211 TCP:45010 UDP:50001 TCP:55010 +>>> GridGain documentation: http://www.gridgain.com/product.html + +[14:14:24,740][INFO ][main][GridListenActorSelfTest] >>> Starting test: testListenByClosure <<< +[14:14:26,895][INFO ][main][GridListenActorSelfTest] >>> Stopping test: testListenByClosure in 2155 ms <<< +[14:14:26,902][INFO ][main][GridListenActorSelfTest] >>> Starting test: testBasicFlow <<< +[14:14:28,919][INFO ][main][GridListenActorSelfTest] >>> Stopping test: testBasicFlow in 2016 ms <<< +[14:14:28,925][INFO ][main][GridListenActorSelfTest] >>> Starting test: testImmediateStop <<< +[14:14:30,930][INFO ][main][GridListenActorSelfTest] >>> Stopping test: testImmediateStop in 2005 ms <<< +[14:14:30,938][INFO ][main][GridListenActorSelfTest] >>> Starting test: testReceiveAll <<< +[14:14:32,948][INFO ][main][GridListenActorSelfTest] >>> Stopping test: testReceiveAll in 2010 ms <<< +[14:14:32,956][INFO ][main][GridListenActorSelfTest] >>> Starting test: testRespondToRemote <<< +[14:14:32,960][INFO ][test-runner][GridListenActorSelfTest1] + +>>> _____ _ _______ _ +>>> / ___/____(_)___/ / ___/___ _(_)___ +>>> / (_ // __/ // _ / (_ // _ `/ // _ \ +>>> \___//_/ /_/ \_,_/\___/ \_,_/_//_//_/ +>>> +>>> ---==++ IN-MEMORY BIG DATA ++==--- +>>> ver. x.x.x-DDMMYYYY +>>> Copyright (C) 2012 GridGain Systems + +[14:14:32,960][INFO ][test-runner][GridListenActorSelfTest1] << Enterprise Edition >> +[14:14:32,960][INFO ][test-runner][GridListenActorSelfTest1] Config URL: n/a +[14:14:32,960][INFO ][test-runner][GridListenActorSelfTest1] Daemon mode: off +[14:14:32,961][INFO ][test-runner][GridListenActorSelfTest1] Language runtime: Java Platform API Specification ver. 1.6 +[14:14:32,961][INFO ][test-runner][GridListenActorSelfTest1] JVM name: Java HotSpot(TM) 64-Bit Server VM +[14:14:32,961][INFO ][test-runner][GridListenActorSelfTest1] Remote Management [restart: off, REST: on, JMX (remote: off)] +[14:14:32,961][INFO ][test-runner][GridListenActorSelfTest1] GRIDGAIN_HOME=/usr/local/TeamCityAgent/work/d46fc9c3d71112c2 +[14:14:32,961][INFO ][test-runner][GridListenActorSelfTest1] VM arguments: [-ea, -XX:MaxPermSize=128m, -Xms512m, -Xmx1024m, -Duser.name=bamboo, -DGRIDGAIN_UPDATE_NOTIFIER=false, -DGRIDGAIN_DISABLED=true, -DGRIDGAIN_HOME=/usr/local/TeamCityAgent/work/d46fc9c3d71112c2, -DGRIDGAIN_STABLE_HOME=/usr/local/TeamCityAgent/work/d46fc9c3d71112c2, -DGRIDGAIN_ROUTER_PREFER_REMOTE=true, -DGRIDGAIN_NO_DISCO_ORDER=true, -DGRIDGAIN_QUIET=false, -DGG_TEST_HOME=/usr/local/TeamCityAgent/work/d46fc9c3d71112c2, -Dteamcity.build.id=34324, -Dteamcity.buildType.id=bt5, -Dagent.ownPort=9090, -Dteamcity.build.checkoutDir=/usr/local/TeamCityAgent/work/d46fc9c3d71112c2, -Dteamcity.build.workingDir=/usr/local/TeamCityAgent/work/d46fc9c3d71112c2, -Dagent.work.dir=/usr/local/TeamCityAgent/work, -Dagent.name=teamcity-4, -Dagent.home.dir=/usr/local/TeamCityAgent, -Dteamcity.runtime.props.file=/usr/local/TeamCityAgent/temp/agentTmp/ant2684847485530994862runtime] +[14:14:32,961][WARN ][test-runner][GridListenActorSelfTest1] SMTP is not configured - email notifications are off. +[14:14:32,961][WARN ][test-runner][GridListenActorSelfTest1] Cache is not configured - data grid is off. +[14:14:32,964][INFO ][test-runner][GridListenActorSelfTest1] 3-rd party licenses can be found at: /usr/local/TeamCityAgent/work/d46fc9c3d71112c2/libs/licenses +[14:14:32,965][INFO ][test-runner][GridListenActorSelfTest1] Non-loopback local IPs: fe80:0:0:0:ca60:ff:fe68:582c%2, 192.168.2.14 +[14:14:32,966][INFO ][test-runner][GridListenActorSelfTest1] Enabled local MACs: C8600068582C +[14:14:33,480][INFO ][test-runner][GridJdkLocalMetricsSpi] Hyperic Sigar 'CpuPerc.getCombined()' method will be used to detect average CPU load. +[14:14:33,499][INFO ][test-runner][GridTcpCommunicationSpi] Successfully bound to TCP port [port=45011, locHost=/192.168.2.14] +[14:14:33,559][INFO ][test-runner][GridListenActorSelfTest1] Security status [authentication=on, secure-session=on] +[14:14:33,565][WARN ][test-runner][GridMulticastDiscoverySpi] Heartbeat frequency is too low (at least 2000 ms): 1000 +[14:14:33,566][INFO ][test-runner][GridMulticastDiscoverySpi] Successfully bound to TCP port: 55011 +[14:14:33,566][INFO ][test-runner][GridMulticastDiscoverySpi] Successfully bound to Multicast port: 50001 +[14:14:33,567][INFO ][test-runner][GridMulticastDiscoverySpi] Local node: GridMulticastDiscoveryNode [id=1f7e8040-8a17-4e14-a513-1709bebe265b, state=READY, lastHeartbeat=1353320073559, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55011, startTime=1353320073559] +[14:14:33,568][INFO ][test-runner][GridDiscoveryManager] Topology snapshot [nodes=1, CPUs=4, hash=0xAB3F3CCB] +[14:14:33,568][INFO ][test-runner][GridMulticastDiscoverySpi] Waiting for initial heartbeat timeout (1000 ms) +[14:14:33,637][INFO ][disco-event-worker-#15%kernal.GridListenActorSelfTest%][GridDiscoveryManager] Added new node to topology: GridMulticastDiscoveryNode [id=1f7e8040-8a17-4e14-a513-1709bebe265b, state=READY, lastHeartbeat=1353320073570, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55011, startTime=1353320073559] +[14:14:33,637][INFO ][disco-event-worker-#55%kernal.GridListenActorSelfTest1%][GridDiscoveryManager] Added new node to topology: GridMulticastDiscoveryNode [id=353d63b5-a2f0-41d1-a30e-37016f357233, state=READY, lastHeartbeat=1353320073600, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55010, startTime=1353320063496] +[14:14:33,638][INFO ][disco-event-worker-#15%kernal.GridListenActorSelfTest%][GridDiscoveryManager] Topology snapshot [nodes=2, CPUs=4, hash=0x93B555F6] +[14:14:34,571][INFO ][disco-event-worker-#55%kernal.GridListenActorSelfTest1%][GridDiscoveryManager] Topology snapshot [nodes=2, CPUs=4, hash=0x93B555F6] +[14:14:35,650][WARN ][test-runner][GridJettyRestProtocol] Jetty failed to start (retrying every 3000 ms). Another node on this host? +[14:14:35,651][WARN ][test-runner][GridTcpRestProtocol] TCP binary REST server failed to start (retrying every 3000 ms). Another node on this host? +[14:14:35,652][INFO ][test-runner][GridLicenseControllerImpl] Licensed to 'GridGain Systems, Internal Development Only' on Feb 3, 2011 +[14:14:35,652][INFO ][test-runner][GridLicenseControllerImpl] License [ID=7D5CB773-225C-4165-8162-3BB67337894B, type=ENT] +[14:14:35,652][INFO ][test-runner][GridLicenseControllerImpl] License limits [expire-date: never] +[14:14:35,667][INFO ][test-runner][GridListenActorSelfTest1] + +>>> +--------------------------+ +>>> GridGain ver. x.x.x-DDMMYYYY +>>> +--------------------------+ +>>> OS name: Linux 2.6.32-38-generic amd64 +>>> OS user: bamboo +>>> CPU(s): 4 +>>> VM information: Java(TM) SE Runtime Environment 1.6.0_30-b12 Sun Microsystems Inc. Java HotSpot(TM) 64-Bit Server VM 20.5-b03 +>>> VM name: 573@gg-teamcity-4 +>>> Grid name: kernal.GridListenActorSelfTest1 +>>> Local node [ID=1F7E8040-8A17-4E14-A513-1709BEBE265B, order=1353320073559] +>>> Local node addresses: [192.168.2.14] +>>> Local ports: TCP:45011 UDP:50001 TCP:55011 +>>> GridGain documentation: http://www.gridgain.com/product.html + +[14:14:36,672][INFO ][test-runner][GridListenActorSelfTest] >>> Stopping grid [name=kernal.GridListenActorSelfTest1, id=1f7e8040-8a17-4e14-a513-1709bebe265b] +[14:14:36,674][INFO ][test-runner][GridJettyRestProtocol] Command protocol successfully stopped: Jetty REST +[14:14:36,674][INFO ][test-runner][GridTcpRestProtocol] Command protocol successfully stopped: TCP binary +[14:14:36,679][INFO ][disco-event-worker-#15%kernal.GridListenActorSelfTest%][GridDiscoveryManager] Node left topology: GridMulticastDiscoveryNode [id=1f7e8040-8a17-4e14-a513-1709bebe265b, state=LEFT, lastHeartbeat=1353320076673, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55011, startTime=1353320073559] +[14:14:36,680][INFO ][disco-event-worker-#15%kernal.GridListenActorSelfTest%][GridDiscoveryManager] Topology snapshot [nodes=1, CPUs=4, hash=0x8C20EE0] +[14:14:36,693][INFO ][test-runner][GridDeploymentLocalStore] Removed undeployed class: GridDeployment [ts=1353320075676, depMode=SHARED, clsLdr=sun.misc.Launcher$AppClassLoader@3326b249, clsLdrId=e4269281b31-1f7e8040-8a17-4e14-a513-1709bebe265b, userVer=0, loc=true, sampleCls=class java.lang.String, sampleClsName=java.lang.String, undeployed=true, pendingUndeploy=false, usage=0] +[14:14:36,701][INFO ][test-runner][GridListenActorSelfTest1] + +>>> +-------------------------------------+ +>>> GridGain ver. x.x.x-DDMMYYYY stopped OK +>>> +-------------------------------------+ +>>> Grid name: kernal.GridListenActorSelfTest1 +>>> Grid uptime: 00:00:01:28 + + +[14:14:36,703][INFO ][main][GridListenActorSelfTest] >>> Stopping test: testRespondToRemote in 3747 ms <<< +[14:14:36,712][INFO ][main][GridListenActorSelfTest] >>> Starting test: testPingPong <<< +[14:14:36,726][INFO ][main][GridListenActorSelfTest] >>> Stopping test: testPingPong in 14 ms <<< +[14:14:36,726][INFO ][main][GridListenActorSelfTest] >>> Stopping grid [name=kernal.GridListenActorSelfTest, id=353d63b5-a2f0-41d1-a30e-37016f357233] +[14:14:37,780][INFO ][main][GridJettyRestProtocol] Command protocol successfully stopped: Jetty REST +[14:14:37,781][INFO ][main][GridTcpRestProtocol] Command protocol successfully stopped: TCP binary +[14:14:37,794][INFO ][main][GridDeploymentLocalStore] Removed undeployed class: GridDeployment [ts=1353320064744, depMode=SHARED, clsLdr=sun.misc.Launcher$AppClassLoader@3326b249, clsLdrId=a2269281b31-353d63b5-a2f0-41d1-a30e-37016f357233, userVer=0, loc=true, sampleCls=class org.gridgain.grid.kernal.GridListenActorSelfTest$1, sampleClsName=org.gridgain.grid.kernal.GridListenActorSelfTest$1, undeployed=true, pendingUndeploy=false, usage=0] +[14:14:37,799][INFO ][main][GridListenActorSelfTest] + +>>> +-------------------------------------+ +>>> GridGain ver. x.x.x-DDMMYYYY stopped OK +>>> +-------------------------------------+ +>>> Grid name: kernal.GridListenActorSelfTest +>>> Grid uptime: 00:00:13:57 + + +[14:14:37,814][INFO ][main][GridSessionCancelSiblingsFromFutureSelfTest] + +>>> _____ _ _______ _ +>>> / ___/____(_)___/ / ___/___ _(_)___ +>>> / (_ // __/ // _ / (_ // _ `/ // _ \ +>>> \___//_/ /_/ \_,_/\___/ \_,_/_//_//_/ +>>> +>>> ---==++ IN-MEMORY BIG DATA ++==--- +>>> ver. x.x.x-DDMMYYYY +>>> Copyright (C) 2012 GridGain Systems + +[14:14:37,814][INFO ][main][GridSessionCancelSiblingsFromFutureSelfTest] << Enterprise Edition >> +[14:14:37,814][INFO ][main][GridSessionCancelSiblingsFromFutureSelfTest] Config URL: n/a +[14:14:37,814][INFO ][main][GridSessionCancelSiblingsFromFutureSelfTest] Daemon mode: off +[14:14:37,814][INFO ][main][GridSessionCancelSiblingsFromFutureSelfTest] Language runtime: Java Platform API Specification ver. 1.6 +[14:14:37,814][INFO ][main][GridSessionCancelSiblingsFromFutureSelfTest] JVM name: Java HotSpot(TM) 64-Bit Server VM +[14:14:37,814][INFO ][main][GridSessionCancelSiblingsFromFutureSelfTest] Remote Management [restart: off, REST: on, JMX (remote: off)] +[14:14:37,814][INFO ][main][GridSessionCancelSiblingsFromFutureSelfTest] GRIDGAIN_HOME=/usr/local/TeamCityAgent/work/d46fc9c3d71112c2 +[14:14:37,814][INFO ][main][GridSessionCancelSiblingsFromFutureSelfTest] VM arguments: [-ea, -XX:MaxPermSize=128m, -Xms512m, -Xmx1024m, -Duser.name=bamboo, -DGRIDGAIN_UPDATE_NOTIFIER=false, -DGRIDGAIN_DISABLED=true, -DGRIDGAIN_HOME=/usr/local/TeamCityAgent/work/d46fc9c3d71112c2, -DGRIDGAIN_STABLE_HOME=/usr/local/TeamCityAgent/work/d46fc9c3d71112c2, -DGRIDGAIN_ROUTER_PREFER_REMOTE=true, -DGRIDGAIN_NO_DISCO_ORDER=true, -DGRIDGAIN_QUIET=false, -DGG_TEST_HOME=/usr/local/TeamCityAgent/work/d46fc9c3d71112c2, -Dteamcity.build.id=34324, -Dteamcity.buildType.id=bt5, -Dagent.ownPort=9090, -Dteamcity.build.checkoutDir=/usr/local/TeamCityAgent/work/d46fc9c3d71112c2, -Dteamcity.build.workingDir=/usr/local/TeamCityAgent/work/d46fc9c3d71112c2, -Dagent.work.dir=/usr/local/TeamCityAgent/work, -Dagent.name=teamcity-4, -Dagent.home.dir=/usr/local/TeamCityAgent, -Dteamcity.runtime.props.file=/usr/local/TeamCityAgent/temp/agentTmp/ant2684847485530994862runtime] +[14:14:37,814][WARN ][main][GridSessionCancelSiblingsFromFutureSelfTest] SMTP is not configured - email notifications are off. +[14:14:37,815][WARN ][main][GridSessionCancelSiblingsFromFutureSelfTest] Cache is not configured - data grid is off. +[14:14:37,815][INFO ][main][GridSessionCancelSiblingsFromFutureSelfTest] 3-rd party licenses can be found at: /usr/local/TeamCityAgent/work/d46fc9c3d71112c2/libs/licenses +[14:14:37,815][INFO ][main][GridSessionCancelSiblingsFromFutureSelfTest] Non-loopback local IPs: fe80:0:0:0:ca60:ff:fe68:582c%2, 192.168.2.14 +[14:14:37,815][INFO ][main][GridSessionCancelSiblingsFromFutureSelfTest] Enabled local MACs: C8600068582C +[14:14:38,322][INFO ][main][GridJdkLocalMetricsSpi] Hyperic Sigar 'CpuPerc.getCombined()' method will be used to detect average CPU load. +[14:14:38,339][INFO ][main][GridTcpCommunicationSpi] Successfully bound to TCP port [port=45020, locHost=/192.168.2.14] +[14:14:38,398][INFO ][main][GridSessionCancelSiblingsFromFutureSelfTest] Security status [authentication=on, secure-session=on] +[14:14:38,403][WARN ][main][GridMulticastDiscoverySpi] Heartbeat frequency is too low (at least 2000 ms): 1000 +[14:14:38,404][INFO ][main][GridMulticastDiscoverySpi] Successfully bound to TCP port: 55020 +[14:14:38,404][INFO ][main][GridMulticastDiscoverySpi] Successfully bound to Multicast port: 50002 +[14:14:38,406][INFO ][main][GridMulticastDiscoverySpi] Local node: GridMulticastDiscoveryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398] +[14:14:38,407][INFO ][main][GridDiscoveryManager] Topology snapshot [nodes=1, CPUs=4, hash=0x52EFDFF2] +[14:14:38,408][INFO ][main][GridMulticastDiscoverySpi] Waiting for initial heartbeat timeout (1000 ms) +[14:14:39,443][INFO ][main][GridJettyRestProtocol] Command protocol successfully started: Jetty REST +[14:14:39,448][INFO ][main][GridTcpRestProtocol] Command protocol successfully started: TCP binary +[14:14:39,448][INFO ][main][GridLicenseControllerImpl] Licensed to 'GridGain Systems, Internal Development Only' on Feb 3, 2011 +[14:14:39,448][INFO ][main][GridLicenseControllerImpl] License [ID=7D5CB773-225C-4165-8162-3BB67337894B, type=ENT] +[14:14:39,448][INFO ][main][GridLicenseControllerImpl] License limits [expire-date: never] +[14:14:39,468][INFO ][main][GridSessionCancelSiblingsFromFutureSelfTest] + +>>> +--------------------------+ +>>> GridGain ver. x.x.x-DDMMYYYY +>>> +--------------------------+ +>>> OS name: Linux 2.6.32-38-generic amd64 +>>> OS user: bamboo +>>> CPU(s): 4 +>>> VM information: Java(TM) SE Runtime Environment 1.6.0_30-b12 Sun Microsystems Inc. Java HotSpot(TM) 64-Bit Server VM 20.5-b03 +>>> VM name: 573@gg-teamcity-4 +>>> Grid name: session.GridSessionCancelSiblingsFromFutureSelfTest +>>> Local node [ID=741AF89C-78C4-453D-83D5-86B9A66DCA08, order=1353320078398] +>>> Local node addresses: [192.168.2.14] +>>> Local ports: TCP:8080 TCP:11211 TCP:45020 UDP:50002 TCP:55020 +>>> GridGain documentation: http://www.gridgain.com/product.html + +[14:14:39,468][INFO ][main][GridSessionCancelSiblingsFromFutureSelfTest] >>> Starting test: testCancelSiblings <<< +[14:14:39,478][INFO ][gridgain-#95%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Splitting jobs [task=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@4b90725e, gridSize=1, arg=0] +[14:14:39,484][INFO ][gridgain-#96%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Computing job [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@54eeabe8, arg=5] +[14:14:39,484][INFO ][gridgain-#97%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Computing job [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@39b1ff47, arg=4] +[14:14:39,485][INFO ][gridgain-#98%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Computing job [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@1a0283e, arg=3] +[14:14:39,486][INFO ][gridgain-#99%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Computing job [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@31f9b804, arg=2] +[14:14:39,486][INFO ][gridgain-#100%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Computing job [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@3a8bd3bb, arg=1] +[14:14:39,487][INFO ][gridgain-#96%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Job got interrupted [arg=5, e=java.lang.InterruptedException: sleep interrupted] +[14:14:39,488][INFO ][gridgain-#98%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Job got interrupted [arg=3, e=java.lang.InterruptedException: sleep interrupted] +[14:14:39,491][INFO ][gridgain-#100%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Job got interrupted [arg=1, e=java.lang.InterruptedException: sleep interrupted] +[14:14:39,491][INFO ][gridgain-#99%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Job got interrupted [arg=2, e=java.lang.InterruptedException: sleep interrupted] +[14:14:39,492][INFO ][gridgain-#97%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Job got interrupted [arg=4, e=java.lang.InterruptedException: sleep interrupted] +[14:14:39,497][INFO ][gridgain-#106%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Received job result [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@4b90725e, result=GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@54eeabe8, sib=GridJobSiblingImpl [sesId=c5269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=e5269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063582--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063582--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=false], jobCtx=GridJobContextImpl [jobId=e5269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDisco veryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=true]] +[14:14:39,498][INFO ][gridgain-#106%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Received job result [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@4b90725e, result=GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@1a0283e, sib=GridJobSiblingImpl [sesId=c5269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=26269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063586--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063586--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=false], jobCtx=GridJobContextImpl [jobId=26269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDiscov eryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=true]] +[14:14:39,499][INFO ][gridgain-#106%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Received job result [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@4b90725e, result=GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@31f9b804, sib=GridJobSiblingImpl [sesId=c5269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=46269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063588--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063588--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=false], jobCtx=GridJobContextImpl [jobId=46269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDisco veryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=true]] +[14:14:39,500][INFO ][gridgain-#106%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Received job result [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@4b90725e, result=GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@3a8bd3bb, sib=GridJobSiblingImpl [sesId=c5269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=66269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063590--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063590--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=false], jobCtx=GridJobContextImpl [jobId=66269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDisco veryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=true]] +[14:14:39,500][INFO ][gridgain-#106%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Received job result [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@4b90725e, result=GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@39b1ff47, sib=GridJobSiblingImpl [sesId=c5269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=06269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063584--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063584--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=false], jobCtx=GridJobContextImpl [jobId=06269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDisco veryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=true]] +[14:14:39,502][INFO ][gridgain-#106%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Aggregating job [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@4b90725e, results=[GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@54eeabe8, sib=GridJobSiblingImpl [sesId=c5269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=e5269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063582--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063582--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=true], jobCtx=GridJobContextImpl [jobId=e5269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDiscover yNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=false], GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@39b1ff47, sib=GridJobSiblingImpl [sesId=c5269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=06269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063584--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063584--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=true], jobCtx=GridJobContextImpl [jobId=06269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], n ode=GridRichNodeImpl [node=GridMulticastDiscoveryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=true], GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@1a0283e, sib=GridJobSiblingImpl [sesId=c5269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=26269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063586--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063586--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=true], jobCtx=GridJobContextImpl [jobId=26269281b31-4ffa f88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDiscoveryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=false], GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@31f9b804, sib=GridJobSiblingImpl [sesId=c5269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=46269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063588--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063588--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=true], j obCtx=GridJobContextImpl [jobId=46269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDiscoveryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=false], GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@3a8bd3bb, sib=GridJobSiblingImpl [sesId=c5269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=66269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063590--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063590--8947096952782337528-8366272608718832957, nodeId=741af89c -78c4-453d-83d5-86b9a66dca08, isJobDone=true], jobCtx=GridJobContextImpl [jobId=66269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDiscoveryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=false]]] +[14:14:39,503][INFO ][gridgain-#111%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Splitting jobs [task=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@4e0bd5df, gridSize=1, arg=1] +[14:14:39,505][INFO ][gridgain-#112%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Computing job [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@591bfcbe, arg=1] +[14:14:39,506][INFO ][gridgain-#113%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Computing job [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@3c6e4ba6, arg=2] +[14:14:39,507][INFO ][gridgain-#114%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Computing job [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@5afc0f5, arg=4] +[14:14:39,507][INFO ][gridgain-#115%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Computing job [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@55a517bd, arg=5] +[14:14:39,508][INFO ][gridgain-#116%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Computing job [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@6d289e48, arg=3] +[14:14:39,508][INFO ][gridgain-#112%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Job got interrupted [arg=1, e=java.lang.InterruptedException: sleep interrupted] +[14:14:39,509][INFO ][gridgain-#113%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Job got interrupted [arg=2, e=java.lang.InterruptedException: sleep interrupted] +[14:14:39,511][INFO ][gridgain-#115%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Job got interrupted [arg=5, e=java.lang.InterruptedException: sleep interrupted] +[14:14:39,511][INFO ][gridgain-#114%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Job got interrupted [arg=4, e=java.lang.InterruptedException: sleep interrupted] +[14:14:39,511][INFO ][gridgain-#116%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Job got interrupted [arg=3, e=java.lang.InterruptedException: sleep interrupted] +[14:14:39,512][INFO ][gridgain-#121%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Received job result [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@4e0bd5df, result=GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@591bfcbe, sib=GridJobSiblingImpl [sesId=88269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=a8269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063626--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063626--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=false], jobCtx=GridJobContextImpl [jobId=a8269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDisco veryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=true]] +[14:14:39,513][INFO ][gridgain-#121%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Received job result [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@4e0bd5df, result=GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@5afc0f5, sib=GridJobSiblingImpl [sesId=88269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=e8269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063630--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063630--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=false], jobCtx=GridJobContextImpl [jobId=e8269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDiscov eryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=true]] +[14:14:39,513][INFO ][gridgain-#121%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Received job result [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@4e0bd5df, result=GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@6d289e48, sib=GridJobSiblingImpl [sesId=88269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=29269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063634--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063634--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=false], jobCtx=GridJobContextImpl [jobId=29269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDisco veryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=true]] +[14:14:39,513][INFO ][gridgain-#121%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Received job result [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@4e0bd5df, result=GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@55a517bd, sib=GridJobSiblingImpl [sesId=88269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=09269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063632--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063632--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=false], jobCtx=GridJobContextImpl [jobId=09269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDisco veryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=true]] +[14:14:39,514][INFO ][gridgain-#121%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Received job result [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@4e0bd5df, result=GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@3c6e4ba6, sib=GridJobSiblingImpl [sesId=88269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=c8269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063628--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063628--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=false], jobCtx=GridJobContextImpl [jobId=c8269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDisco veryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=true]] +[14:14:39,515][INFO ][gridgain-#121%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Aggregating job [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@4e0bd5df, results=[GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@591bfcbe, sib=GridJobSiblingImpl [sesId=88269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=a8269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063626--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063626--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=true], jobCtx=GridJobContextImpl [jobId=a8269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDiscover yNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=false], GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@55a517bd, sib=GridJobSiblingImpl [sesId=88269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=09269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063632--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063632--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=true], jobCtx=GridJobContextImpl [jobId=09269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], n ode=GridRichNodeImpl [node=GridMulticastDiscoveryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=false], GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@5afc0f5, sib=GridJobSiblingImpl [sesId=88269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=e8269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063630--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063630--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=true], jobCtx=GridJobContextImpl [jobId=e8269281b31-4ff af88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDiscoveryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=false], GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@6d289e48, sib=GridJobSiblingImpl [sesId=88269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=29269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063634--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063634--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=true], jobCtx=GridJobContextImpl [jobId=29269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDiscoveryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=false], GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@3c6e4ba6, sib=GridJobSiblingImpl [sesId=88269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=c8269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063628--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063628--8947096952782337528-8366272608718832957, nodeId=741af89 c-78c4-453d-83d5-86b9a66dca08, isJobDone=true], jobCtx=GridJobContextImpl [jobId=c8269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDiscoveryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=true]]] +[14:14:39,516][INFO ][gridgain-#127%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Splitting jobs [task=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@28c4b5f, gridSize=1, arg=2] +[14:14:39,518][INFO ][gridgain-#128%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Computing job [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@637644c8, arg=5] +[14:14:39,519][INFO ][gridgain-#129%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Computing job [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@3fa9b4a4, arg=3] +[14:14:39,519][INFO ][gridgain-#130%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Computing job [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@1e929ba3, arg=4] +[14:14:39,520][INFO ][gridgain-#131%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Computing job [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@4fe2fe5d, arg=2] +[14:14:39,521][INFO ][gridgain-#132%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Computing job [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@6e659812, arg=1] +[14:14:39,521][INFO ][gridgain-#128%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Job got interrupted [arg=5, e=java.lang.InterruptedException: sleep interrupted] +[14:14:39,521][INFO ][gridgain-#130%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Job got interrupted [arg=4, e=java.lang.InterruptedException: sleep interrupted] +[14:14:39,522][INFO ][gridgain-#129%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Job got interrupted [arg=3, e=java.lang.InterruptedException: sleep interrupted] +[14:14:39,522][INFO ][gridgain-#131%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Job got interrupted [arg=2, e=java.lang.InterruptedException: sleep interrupted] +[14:14:39,523][INFO ][gridgain-#132%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Job got interrupted [arg=1, e=java.lang.InterruptedException: sleep interrupted] +[14:14:39,525][INFO ][gridgain-#138%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Received job result [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@28c4b5f, result=GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@1e929ba3, sib=GridJobSiblingImpl [sesId=4b269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=ab269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063674--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063674--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=false], jobCtx=GridJobContextImpl [jobId=ab269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDiscov eryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=true]] +[14:14:39,526][INFO ][gridgain-#138%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Received job result [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@28c4b5f, result=GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@3fa9b4a4, sib=GridJobSiblingImpl [sesId=4b269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=8b269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063672--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063672--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=false], jobCtx=GridJobContextImpl [jobId=8b269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDiscov eryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=true]] +[14:14:39,527][INFO ][gridgain-#138%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Received job result [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@28c4b5f, result=GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@4fe2fe5d, sib=GridJobSiblingImpl [sesId=4b269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=cb269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063676--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063676--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=false], jobCtx=GridJobContextImpl [jobId=cb269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDiscov eryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=true]] +[14:14:39,527][INFO ][gridgain-#138%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Received job result [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@28c4b5f, result=GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@637644c8, sib=GridJobSiblingImpl [sesId=4b269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=6b269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063670--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063670--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=false], jobCtx=GridJobContextImpl [jobId=6b269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDiscov eryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=true]] +[14:14:39,528][INFO ][gridgain-#142%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Received job result [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@28c4b5f, result=GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@6e659812, sib=GridJobSiblingImpl [sesId=4b269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=eb269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063678--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063678--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=false], jobCtx=GridJobContextImpl [jobId=eb269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDiscov eryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=true]] +[14:14:39,530][INFO ][gridgain-#142%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Aggregating job [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@28c4b5f, results=[GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@1e929ba3, sib=GridJobSiblingImpl [sesId=4b269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=ab269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063674--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063674--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=true], jobCtx=GridJobContextImpl [jobId=ab269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDiscovery Node [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=false], GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@3fa9b4a4, sib=GridJobSiblingImpl [sesId=4b269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=8b269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063672--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063672--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=true], jobCtx=GridJobContextImpl [jobId=8b269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], no de=GridRichNodeImpl [node=GridMulticastDiscoveryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=false], GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@637644c8, sib=GridJobSiblingImpl [sesId=4b269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=6b269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063670--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063670--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=true], jobCtx=GridJobContextImpl [jobId=6b269281b31-4ff af88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDiscoveryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=false], GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@6e659812, sib=GridJobSiblingImpl [sesId=4b269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=eb269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063678--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063678--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=true], jobCtx=GridJobContextImpl [jobId=eb269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDiscoveryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=true], GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@4fe2fe5d, sib=GridJobSiblingImpl [sesId=4b269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=cb269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063676--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063676--8947096952782337528-8366272608718832957, nodeId=741af89c -78c4-453d-83d5-86b9a66dca08, isJobDone=true], jobCtx=GridJobContextImpl [jobId=cb269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDiscoveryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=false]]] +[14:14:39,531][INFO ][gridgain-#143%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Splitting jobs [task=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@f8b7298, gridSize=1, arg=3] +[14:14:39,533][INFO ][gridgain-#144%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Computing job [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@44ec366a, arg=5] +[14:14:39,535][INFO ][gridgain-#145%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Computing job [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@377e4cec, arg=4] +[14:14:39,536][INFO ][gridgain-#146%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Computing job [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@12d91987, arg=2] +[14:14:39,537][INFO ][gridgain-#147%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Computing job [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@6b1af7bb, arg=3] +[14:14:39,537][INFO ][gridgain-#148%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Computing job [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@54992725, arg=1] +[14:14:39,538][INFO ][gridgain-#144%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Job got interrupted [arg=5, e=java.lang.InterruptedException: sleep interrupted] +[14:14:39,538][INFO ][gridgain-#147%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Job got interrupted [arg=3, e=java.lang.InterruptedException: sleep interrupted] +[14:14:39,539][INFO ][gridgain-#146%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Job got interrupted [arg=2, e=java.lang.InterruptedException: sleep interrupted] +[14:14:39,539][INFO ][gridgain-#145%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Job got interrupted [arg=4, e=java.lang.InterruptedException: sleep interrupted] +[14:14:39,541][INFO ][gridgain-#148%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Job got interrupted [arg=1, e=java.lang.InterruptedException: sleep interrupted] +[14:14:39,543][INFO ][gridgain-#154%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Received job result [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@f8b7298, result=GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@44ec366a, sib=GridJobSiblingImpl [sesId=0e269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=2e269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063714--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063714--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=false], jobCtx=GridJobContextImpl [jobId=2e269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDiscov eryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=true]] +[14:14:39,543][INFO ][gridgain-#154%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Received job result [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@f8b7298, result=GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@12d91987, sib=GridJobSiblingImpl [sesId=0e269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=6e269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063718--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063718--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=false], jobCtx=GridJobContextImpl [jobId=6e269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDiscov eryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=true]] +[14:14:39,544][INFO ][gridgain-#154%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Received job result [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@f8b7298, result=GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@6b1af7bb, sib=GridJobSiblingImpl [sesId=0e269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=8e269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063720--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063720--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=false], jobCtx=GridJobContextImpl [jobId=8e269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDiscov eryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=true]] +[14:14:39,544][INFO ][gridgain-#154%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Received job result [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@f8b7298, result=GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@54992725, sib=GridJobSiblingImpl [sesId=0e269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=ae269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063722--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063722--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=false], jobCtx=GridJobContextImpl [jobId=ae269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDiscov eryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=true]] +[14:14:39,545][INFO ][gridgain-#154%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Received job result [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@f8b7298, result=GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@377e4cec, sib=GridJobSiblingImpl [sesId=0e269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=4e269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063716--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063716--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=false], jobCtx=GridJobContextImpl [jobId=4e269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDiscov eryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=true]] +[14:14:39,546][INFO ][gridgain-#154%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Aggregating job [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@f8b7298, results=[GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@377e4cec, sib=GridJobSiblingImpl [sesId=0e269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=4e269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063716--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063716--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=true], jobCtx=GridJobContextImpl [jobId=4e269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDiscovery Node [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=true], GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@12d91987, sib=GridJobSiblingImpl [sesId=0e269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=6e269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063718--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063718--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=true], jobCtx=GridJobContextImpl [jobId=6e269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], nod e=GridRichNodeImpl [node=GridMulticastDiscoveryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=false], GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@6b1af7bb, sib=GridJobSiblingImpl [sesId=0e269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=8e269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063720--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063720--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=true], jobCtx=GridJobContextImpl [jobId=8e269281b31-4ffa f88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDiscoveryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=false], GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@54992725, sib=GridJobSiblingImpl [sesId=0e269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=ae269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063722--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063722--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=true], j obCtx=GridJobContextImpl [jobId=ae269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDiscoveryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=false], GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@44ec366a, sib=GridJobSiblingImpl [sesId=0e269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=2e269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063714--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063714--8947096952782337528-8366272608718832957, nodeId=741af89c -78c4-453d-83d5-86b9a66dca08, isJobDone=true], jobCtx=GridJobContextImpl [jobId=2e269281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDiscoveryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=false]]] +[14:14:39,547][INFO ][gridgain-#159%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Splitting jobs [task=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@1330b13c, gridSize=1, arg=4] +[14:14:39,549][INFO ][gridgain-#160%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Computing job [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@742136c6, arg=3] +[14:14:39,550][INFO ][gridgain-#161%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Computing job [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@5e8518d4, arg=2] +[14:14:39,550][INFO ][gridgain-#162%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Computing job [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@1277f040, arg=5] +[14:14:39,551][INFO ][gridgain-#163%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Computing job [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@30933cba, arg=4] +[14:14:39,551][INFO ][gridgain-#164%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Computing job [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@3bbe9a50, arg=1] +[14:14:39,552][INFO ][gridgain-#161%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Job got interrupted [arg=2, e=java.lang.InterruptedException: sleep interrupted] +[14:14:39,552][INFO ][gridgain-#162%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Job got interrupted [arg=5, e=java.lang.InterruptedException: sleep interrupted] +[14:14:39,553][INFO ][gridgain-#160%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Job got interrupted [arg=3, e=java.lang.InterruptedException: sleep interrupted] +[14:14:39,553][INFO ][gridgain-#163%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Job got interrupted [arg=4, e=java.lang.InterruptedException: sleep interrupted] +[14:14:39,553][INFO ][gridgain-#164%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Job got interrupted [arg=1, e=java.lang.InterruptedException: sleep interrupted] +[14:14:39,554][INFO ][gridgain-#103%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Received job result [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@1330b13c, result=GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@5e8518d4, sib=GridJobSiblingImpl [sesId=c0369281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=01369281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063760--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063760--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=false], jobCtx=GridJobContextImpl [jobId=01369281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDisco veryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=true]] +[14:14:39,554][INFO ][gridgain-#107%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Received job result [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@1330b13c, result=GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@1277f040, sib=GridJobSiblingImpl [sesId=c0369281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=21369281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063762--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063762--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=false], jobCtx=GridJobContextImpl [jobId=21369281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDisco veryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=true]] +[14:14:39,555][INFO ][gridgain-#107%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Received job result [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@1330b13c, result=GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@742136c6, sib=GridJobSiblingImpl [sesId=c0369281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=e0369281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063758--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063758--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=false], jobCtx=GridJobContextImpl [jobId=e0369281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDisco veryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], addr=/192.168.2.14, tcpPort=55020, startTime=1353320078398], p=GridNodePredicate [ids=[741af89c-78c4-453d-83d5-86b9a66dca08]], isLoc=true, hash=694612240, daemon=false], ex=null, hasRes=true, isCancelled=true, isOccupied=true]] +[14:14:39,555][INFO ][gridgain-#107%session.GridSessionCancelSiblingsFromFutureSelfTest%][GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask] Received job result [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask@1330b13c, result=GridJobResultImpl [job=org.gridgain.grid.session.GridSessionCancelSiblingsFromFutureSelfTest$GridTaskSessionTestTask$1@3bbe9a50, sib=GridJobSiblingImpl [sesId=c0369281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, jobId=61369281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, taskTopic=TOPIC_TASK--5725799524765009754-5763191950221394699-1353320063766--8947096952782337528-8366272608718832957, jobTopic=TOPIC_JOB--5725799524765009754-5763191950221394699-1353320063766--8947096952782337528-8366272608718832957, nodeId=741af89c-78c4-453d-83d5-86b9a66dca08, isJobDone=false], jobCtx=GridJobContextImpl [jobId=61369281b31-4ffaf88b-4556-430b-b089-dfab3747f8a6, attrs={}], node=GridRichNodeImpl [node=GridMulticastDisco veryNode [id=741af89c-78c4-453d-83d5-86b9a66dca08, state=READY, lastHeartbeat=1353320078398, addrs=[192.168.2.14], add
<TRUNCATED>
