fond
Model Checking Contest 2021
11th edition, Paris, France, June 23, 2021
Execution of r159-oct2-162089267900137
Last Updated
Jun 28, 2021

About the Execution of ITS-Tools for PolyORBLF-COL-S04J04T10

Execution Summary
Max Memory
Used (MB)
Time wait (ms) CPU Usage (ms) I/O Wait (ms) Computed Result Execution
Status
16248.180 3600000.00 3783885.00 173210.90 TTFT??FF???T???F normal

Execution Chart

We display below the execution chart for this examination (boot time has been removed).

Trace from the execution

Formatting '/data/fko/mcc2021-input.r159-oct2-162089267900137.qcow2', fmt=qcow2 size=4294967296 backing_file=/data/fko/mcc2021-input.qcow2 cluster_size=65536 lazy_refcounts=off refcount_bits=16
Waiting for the VM to be ready (probing ssh)
......................................................................................................................................................................................................
=====================================================================
Generated by BenchKit 2-4028
Executing tool itstools
Input is PolyORBLF-COL-S04J04T10, examination is CTLCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r159-oct2-162089267900137
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 548K
-rw-r--r-- 1 mcc users 19K May 5 16:58 CTLCardinality.txt
-rw-r--r-- 1 mcc users 119K May 10 09:43 CTLCardinality.xml
-rw-r--r-- 1 mcc users 13K May 5 16:58 CTLFireability.txt
-rw-r--r-- 1 mcc users 93K May 10 09:43 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.2K May 6 14:48 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 6.3K May 6 14:48 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 4.1K Mar 28 16:27 LTLCardinality.txt
-rw-r--r-- 1 mcc users 27K Mar 28 16:27 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.2K Mar 28 16:27 LTLFireability.txt
-rw-r--r-- 1 mcc users 17K Mar 28 16:27 LTLFireability.xml
-rw-r--r-- 1 mcc users 4.0K Mar 27 09:22 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 18K Mar 27 09:22 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 2.7K Mar 25 11:58 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 13K Mar 25 11:57 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.9K Mar 22 09:16 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.9K Mar 22 09:16 UpperBounds.xml
-rw-r--r-- 1 mcc users 5 May 5 16:51 equiv_pt
-rw-r--r-- 1 mcc users 10 May 5 16:51 instance
-rw-r--r-- 1 mcc users 5 May 5 16:51 iscolored
-rw-r--r-- 1 mcc users 154K May 5 16:51 model.pnml

--------------------
content from stdout:

=== Data for post analysis generated by BenchKit (invocation template)

The expected result is a vector of booleans
BOOL_VECTOR

here is the order used to build the result vector(from text file)
FORMULA_NAME PolyORBLF-COL-S04J04T10-CTLCardinality-00
FORMULA_NAME PolyORBLF-COL-S04J04T10-CTLCardinality-01
FORMULA_NAME PolyORBLF-COL-S04J04T10-CTLCardinality-02
FORMULA_NAME PolyORBLF-COL-S04J04T10-CTLCardinality-03
FORMULA_NAME PolyORBLF-COL-S04J04T10-CTLCardinality-04
FORMULA_NAME PolyORBLF-COL-S04J04T10-CTLCardinality-05
FORMULA_NAME PolyORBLF-COL-S04J04T10-CTLCardinality-06
FORMULA_NAME PolyORBLF-COL-S04J04T10-CTLCardinality-07
FORMULA_NAME PolyORBLF-COL-S04J04T10-CTLCardinality-08
FORMULA_NAME PolyORBLF-COL-S04J04T10-CTLCardinality-09
FORMULA_NAME PolyORBLF-COL-S04J04T10-CTLCardinality-10
FORMULA_NAME PolyORBLF-COL-S04J04T10-CTLCardinality-11
FORMULA_NAME PolyORBLF-COL-S04J04T10-CTLCardinality-12
FORMULA_NAME PolyORBLF-COL-S04J04T10-CTLCardinality-13
FORMULA_NAME PolyORBLF-COL-S04J04T10-CTLCardinality-14
FORMULA_NAME PolyORBLF-COL-S04J04T10-CTLCardinality-15

=== Now, execution of the tool begins

BK_START 1621186639482

Running Version 0
[2021-05-16 17:37:23] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, CTLCardinality, -spotpath, /home/mcc/BenchKit/bin//..//ltlfilt, -z3path, /home/mcc/BenchKit/bin//..//z3/bin/z3, -yices2path, /home/mcc/BenchKit/bin//..//yices/bin/yices, -its, -ltsmin, -greatspnpath, /home/mcc/BenchKit/bin//..//greatspn/, -order, META, -manyOrder, -smt, -timeout, 3600]
[2021-05-16 17:37:23] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2021-05-16 17:37:23] [INFO ] Detected file is not PT type :http://www.pnml.org/version-2009/grammar/symmetricnet
log4j:WARN No appenders could be found for logger (org.apache.axiom.locator.DefaultOMMetaFactoryLocator).
log4j:WARN Please initialize the log4j system properly.
[2021-05-16 17:37:23] [WARNING] Using fallBack plugin, rng conformance not checked
[2021-05-16 17:37:24] [INFO ] Load time of PNML (colored model parsed with PNMLFW) : 896 ms
[2021-05-16 17:37:24] [INFO ] ms1 symmetric to ms2 in transition T_1124
[2021-05-16 17:37:24] [INFO ] ms1 symmetric to ms3 in transition T_1125
[2021-05-16 17:37:24] [INFO ] ms3 symmetric to ms2 in transition T_1125
[2021-05-16 17:37:24] [INFO ] ms1 symmetric to ms3 in transition T_1126
[2021-05-16 17:37:24] [INFO ] ms3 symmetric to ms2 in transition T_1126
[2021-05-16 17:37:24] [INFO ] ms2 symmetric to ms4 in transition T_1126
[2021-05-16 17:37:24] [INFO ] Imported 81 HL places and 65 HL transitions for a total of 870 PT places and 5136.0 transition bindings in 60 ms.
Parsed 16 properties from file /home/mcc/execution/CTLCardinality.xml in 45 ms.
[2021-05-16 17:37:24] [INFO ] Built PT skeleton of HLPN with 81 places and 65 transitions in 4 ms.
[2021-05-16 17:37:24] [INFO ] Skeletonized HLPN properties in 1 ms.
Successfully produced net in file /tmp/petri1000_7592633454079410113.dot
Incomplete random walk after 100000 steps, including 28 resets, run finished after 1260 ms. (steps per millisecond=79 ) properties (out of 82) seen :29
Running SMT prover for 53 properties.
[2021-05-16 17:37:25] [INFO ] Flow matrix only has 64 transitions (discarded 1 similar events)
// Phase 1: matrix 64 rows 81 cols
[2021-05-16 17:37:25] [INFO ] Computed 26 place invariants in 12 ms
[2021-05-16 17:37:26] [INFO ] [Real]Absence check using 11 positive place invariants in 5 ms returned sat
[2021-05-16 17:37:26] [INFO ] [Real]Absence check using 11 positive and 15 generalized place invariants in 10 ms returned sat
[2021-05-16 17:37:26] [INFO ] SMT Verify possible in real domain returnedunsat :2 sat :0 real:51
[2021-05-16 17:37:26] [INFO ] [Nat]Absence check using 11 positive place invariants in 3 ms returned sat
[2021-05-16 17:37:26] [INFO ] [Nat]Absence check using 11 positive and 15 generalized place invariants in 4 ms returned sat
[2021-05-16 17:37:27] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2021-05-16 17:37:27] [INFO ] [Nat]Absence check using state equation in 81 ms returned unsat :50 sat :3
[2021-05-16 17:37:27] [INFO ] State equation strengthened by 9 read => feed constraints.
[2021-05-16 17:37:27] [INFO ] [Nat]Added 9 Read/Feed constraints in 1 ms returned sat
Attempting to minimize the solution found.
Minimization took 20 ms.
[2021-05-16 17:37:27] [INFO ] SMT Verify possible in nat domain returned unsat :50 sat :3
Successfully simplified 52 atomic propositions for a total of 16 simplifications.
FORMULA PolyORBLF-COL-S04J04T10-CTLCardinality-00 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBLF-COL-S04J04T10-CTLCardinality-01 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBLF-COL-S04J04T10-CTLCardinality-07 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBLF-COL-S04J04T10-CTLCardinality-15 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
[2021-05-16 17:37:27] [INFO ] Initial state reduction rules for CTL removed 3 formulas.
[2021-05-16 17:37:27] [INFO ] Flatten gal took : 91 ms
[2021-05-16 17:37:27] [INFO ] Initial state reduction rules for CTL removed 1 formulas.
FORMULA PolyORBLF-COL-S04J04T10-CTLCardinality-11 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBLF-COL-S04J04T10-CTLCardinality-06 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBLF-COL-S04J04T10-CTLCardinality-03 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBLF-COL-S04J04T10-CTLCardinality-02 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
[2021-05-16 17:37:27] [INFO ] Flatten gal took : 21 ms
[2021-05-16 17:37:27] [INFO ] Unfolded HLPN to a Petri net with 870 places and 2324 transitions in 76 ms.
[2021-05-16 17:37:27] [INFO ] Unfolded HLPN properties in 1 ms.
Successfully produced net in file /tmp/petri1001_1931191302725450993.dot
Support contains 870 out of 870 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 870/870 places, 2324/2324 transitions.
Applied a total of 0 rules in 107 ms. Remains 870 /870 variables (removed 0) and now considering 2324/2324 (removed 0) transitions.
[2021-05-16 17:37:27] [INFO ] Flow matrix only has 2284 transitions (discarded 40 similar events)
// Phase 1: matrix 2284 rows 870 cols
[2021-05-16 17:37:28] [INFO ] Computed 58 place invariants in 209 ms
[2021-05-16 17:37:29] [INFO ] Dead Transitions using invariants and state equation in 1428 ms returned [1104, 1105, 1106, 1107, 1108, 1109, 1110, 1111, 1112, 1113, 1124, 1125, 1126, 1127, 1128, 1129, 1130, 1131, 1132, 1133, 1154, 1155, 1156, 1157, 1158, 1159, 1160, 1161, 1162, 1163, 1194, 1195, 1196, 1197, 1198, 1199, 1200, 1201, 1202, 1203, 1204, 1205, 1206, 1207, 1208, 1209, 1210, 1211, 1212, 1213, 1214, 1215, 1216, 1217, 1218, 1219, 1220, 1221, 1222, 1223, 1224, 1225, 1226, 1227, 1228, 1229, 1230, 1231, 1232, 1233, 1234, 1235, 1236, 1237, 1238, 1239, 1240, 1241, 1242, 1243, 1244, 1245, 1246, 1247, 1248, 1249, 1250, 1251, 1252, 1253, 1264, 1265, 1266, 1267, 1268, 1269, 1270, 1271, 1272, 1273, 1274, 1275, 1276, 1277, 1278, 1279, 1280, 1281, 1282, 1283, 1284, 1285, 1286, 1287, 1288, 1289, 1290, 1291, 1292, 1293, 1294, 1295, 1296, 1297, 1298, 1299, 1300, 1301, 1302, 1303, 1304, 1305, 1306, 1307, 1308, 1309, 1310, 1311, 1312, 1313, 1324, 1325, 1326, 1327, 1328, 1329, 1330, 1331, 1332, 1333, 1354, 1355, 1356, 1357, 1358, 1359, 1360, 1361, 1362, 1363, 1364, 1365, 1366, 1367, 1368, 1369, 1370, 1371, 1372, 1373, 1374, 1375, 1376, 1377, 1378, 1379, 1380, 1381, 1382, 1383, 1384, 1385, 1386, 1387, 1388, 1389, 1390, 1391, 1392, 1393, 1394, 1395, 1396, 1397, 1398, 1399, 1400, 1401, 1402, 1403, 1404, 1405, 1406, 1407, 1408, 1409, 1410, 1411, 1412, 1413, 1414, 1415, 1416, 1417, 1418, 1419, 1420, 1421, 1422, 1423, 1424, 1425, 1426, 1427, 1428, 1429, 1430, 1431, 1432, 1433, 1434, 1435, 1436, 1437, 1438, 1439, 1440, 1441, 1442, 1443, 1444, 1445, 1446, 1447, 1448, 1449, 1450, 1451, 1452, 1453, 1454, 1455, 1456, 1457, 1458, 1459, 1460, 1461, 1462, 1463, 1464, 1465, 1466, 1467, 1468, 1469, 1470, 1471, 1472, 1473, 1474, 1475, 1476, 1477, 1478, 1479, 1480, 1481, 1482, 1483, 1484, 1485, 1486, 1487, 1488, 1489, 1490, 1491, 1492, 1493, 1494, 1495, 1496, 1497, 1498, 1499, 1500, 1501, 1502, 1503, 1504, 1505, 1506, 1507, 1508, 1509, 1510, 1511, 1512, 1513, 1514, 1515, 1516, 1517, 1518, 1519, 1520, 1521, 1522, 1523, 1524, 1525, 1526, 1527, 1528, 1529, 1530, 1531, 1532, 1533, 1534, 1535, 1536, 1537, 1538, 1539, 1540, 1541, 1542, 1543, 1544, 1545, 1546, 1547, 1548, 1549, 1550, 1551, 1552, 1553, 1554, 1555, 1556, 1557, 1558, 1559, 1560, 1561, 1562, 1563, 1564, 1565, 1566, 1567, 1568, 1569, 1570, 1571, 1572, 1573, 1574, 1575, 1576, 1577, 1578, 1579, 1580, 1581, 1582, 1583, 1584, 1585, 1586, 1587, 1588, 1589, 1590, 1591, 1592, 1593, 1594, 1595, 1596, 1597, 1598, 1599, 1600, 1601, 1602, 1603, 1614, 1615, 1616, 1617, 1618, 1619, 1620, 1621, 1622, 1623, 1624, 1625, 1626, 1627, 1628, 1629, 1630, 1631, 1632, 1633, 1634, 1635, 1636, 1637, 1638, 1639, 1640, 1641, 1642, 1643, 1644, 1645, 1646, 1647, 1648, 1649, 1650, 1651, 1652, 1653, 1654, 1655, 1656, 1657, 1658, 1659, 1660, 1661, 1662, 1663, 1664, 1665, 1666, 1667, 1668, 1669, 1670, 1671, 1672, 1673, 1674, 1675, 1676, 1677, 1678, 1679, 1680, 1681, 1682, 1683, 1684, 1685, 1686, 1687, 1688, 1689, 1690, 1691, 1692, 1693, 1694, 1695, 1696, 1697, 1698, 1699, 1700, 1701, 1702, 1703, 1704, 1705, 1706, 1707, 1708, 1709, 1710, 1711, 1712, 1713, 1714, 1715, 1716, 1717, 1718, 1719, 1720, 1721, 1722, 1723, 1724, 1725, 1726, 1727, 1728, 1729, 1730, 1731, 1732, 1733, 1734, 1735, 1736, 1737, 1738, 1739, 1740, 1741, 1742, 1743, 1744, 1745, 1746, 1747, 1748, 1749, 1750, 1751, 1752, 1753]
Found 540 dead transitions using SMT.
Drop transitions removed 540 transitions
Dead transitions reduction (with SMT) triggered by suspicious arc values removed 540 transitions :[1753, 1752, 1751, 1750, 1749, 1748, 1747, 1746, 1745, 1744, 1743, 1742, 1741, 1740, 1739, 1738, 1737, 1736, 1735, 1734, 1733, 1732, 1731, 1730, 1729, 1728, 1727, 1726, 1725, 1724, 1723, 1722, 1721, 1720, 1719, 1718, 1717, 1716, 1715, 1714, 1713, 1712, 1711, 1710, 1709, 1708, 1707, 1706, 1705, 1704, 1703, 1702, 1701, 1700, 1699, 1698, 1697, 1696, 1695, 1694, 1693, 1692, 1691, 1690, 1689, 1688, 1687, 1686, 1685, 1684, 1683, 1682, 1681, 1680, 1679, 1678, 1677, 1676, 1675, 1674, 1673, 1672, 1671, 1670, 1669, 1668, 1667, 1666, 1665, 1664, 1663, 1662, 1661, 1660, 1659, 1658, 1657, 1656, 1655, 1654, 1653, 1652, 1651, 1650, 1649, 1648, 1647, 1646, 1645, 1644, 1643, 1642, 1641, 1640, 1639, 1638, 1637, 1636, 1635, 1634, 1633, 1632, 1631, 1630, 1629, 1628, 1627, 1626, 1625, 1624, 1623, 1622, 1621, 1620, 1619, 1618, 1617, 1616, 1615, 1614, 1603, 1602, 1601, 1600, 1599, 1598, 1597, 1596, 1595, 1594, 1593, 1592, 1591, 1590, 1589, 1588, 1587, 1586, 1585, 1584, 1583, 1582, 1581, 1580, 1579, 1578, 1577, 1576, 1575, 1574, 1573, 1572, 1571, 1570, 1569, 1568, 1567, 1566, 1565, 1564, 1563, 1562, 1561, 1560, 1559, 1558, 1557, 1556, 1555, 1554, 1553, 1552, 1551, 1550, 1549, 1548, 1547, 1546, 1545, 1544, 1543, 1542, 1541, 1540, 1539, 1538, 1537, 1536, 1535, 1534, 1533, 1532, 1531, 1530, 1529, 1528, 1527, 1526, 1525, 1524, 1523, 1522, 1521, 1520, 1519, 1518, 1517, 1516, 1515, 1514, 1513, 1512, 1511, 1510, 1509, 1508, 1507, 1506, 1505, 1504, 1503, 1502, 1501, 1500, 1499, 1498, 1497, 1496, 1495, 1494, 1493, 1492, 1491, 1490, 1489, 1488, 1487, 1486, 1485, 1484, 1483, 1482, 1481, 1480, 1479, 1478, 1477, 1476, 1475, 1474, 1473, 1472, 1471, 1470, 1469, 1468, 1467, 1466, 1465, 1464, 1463, 1462, 1461, 1460, 1459, 1458, 1457, 1456, 1455, 1454, 1453, 1452, 1451, 1450, 1449, 1448, 1447, 1446, 1445, 1444, 1443, 1442, 1441, 1440, 1439, 1438, 1437, 1436, 1435, 1434, 1433, 1432, 1431, 1430, 1429, 1428, 1427, 1426, 1425, 1424, 1423, 1422, 1421, 1420, 1419, 1418, 1417, 1416, 1415, 1414, 1413, 1412, 1411, 1410, 1409, 1408, 1407, 1406, 1405, 1404, 1403, 1402, 1401, 1400, 1399, 1398, 1397, 1396, 1395, 1394, 1393, 1392, 1391, 1390, 1389, 1388, 1387, 1386, 1385, 1384, 1383, 1382, 1381, 1380, 1379, 1378, 1377, 1376, 1375, 1374, 1373, 1372, 1371, 1370, 1369, 1368, 1367, 1366, 1365, 1364, 1363, 1362, 1361, 1360, 1359, 1358, 1357, 1356, 1355, 1354, 1333, 1332, 1331, 1330, 1329, 1328, 1327, 1326, 1325, 1324, 1313, 1312, 1311, 1310, 1309, 1308, 1307, 1306, 1305, 1304, 1303, 1302, 1301, 1300, 1299, 1298, 1297, 1296, 1295, 1294, 1293, 1292, 1291, 1290, 1289, 1288, 1287, 1286, 1285, 1284, 1283, 1282, 1281, 1280, 1279, 1278, 1277, 1276, 1275, 1274, 1273, 1272, 1271, 1270, 1269, 1268, 1267, 1266, 1265, 1264, 1253, 1252, 1251, 1250, 1249, 1248, 1247, 1246, 1245, 1244, 1243, 1242, 1241, 1240, 1239, 1238, 1237, 1236, 1235, 1234, 1233, 1232, 1231, 1230, 1229, 1228, 1227, 1226, 1225, 1224, 1223, 1222, 1221, 1220, 1219, 1218, 1217, 1216, 1215, 1214, 1213, 1212, 1211, 1210, 1209, 1208, 1207, 1206, 1205, 1204, 1203, 1202, 1201, 1200, 1199, 1198, 1197, 1196, 1195, 1194, 1163, 1162, 1161, 1160, 1159, 1158, 1157, 1156, 1155, 1154, 1133, 1132, 1131, 1130, 1129, 1128, 1127, 1126, 1125, 1124, 1113, 1112, 1111, 1110, 1109, 1108, 1107, 1106, 1105, 1104]
[2021-05-16 17:37:29] [INFO ] Flow matrix only has 1744 transitions (discarded 40 similar events)
// Phase 1: matrix 1744 rows 870 cols
[2021-05-16 17:37:29] [INFO ] Computed 58 place invariants in 83 ms
[2021-05-16 17:37:29] [INFO ] Implicit Places using invariants in 195 ms returned []
[2021-05-16 17:37:29] [INFO ] Flow matrix only has 1744 transitions (discarded 40 similar events)
// Phase 1: matrix 1744 rows 870 cols
[2021-05-16 17:37:29] [INFO ] Computed 58 place invariants in 39 ms
[2021-05-16 17:37:30] [INFO ] State equation strengthened by 210 read => feed constraints.
[2021-05-16 17:37:30] [INFO ] Implicit Places using invariants and state equation in 865 ms returned []
Implicit Place search using SMT with State Equation took 1076 ms to find 0 implicit places.
[2021-05-16 17:37:30] [INFO ] Flow matrix only has 1744 transitions (discarded 40 similar events)
// Phase 1: matrix 1744 rows 870 cols
[2021-05-16 17:37:30] [INFO ] Computed 58 place invariants in 45 ms
[2021-05-16 17:37:31] [INFO ] Dead Transitions using invariants and state equation in 777 ms returned []
Starting structural reductions, iteration 1 : 870/870 places, 1784/2324 transitions.
Applied a total of 0 rules in 25 ms. Remains 870 /870 variables (removed 0) and now considering 1784/1784 (removed 0) transitions.
[2021-05-16 17:37:31] [INFO ] Flow matrix only has 1744 transitions (discarded 40 similar events)
// Phase 1: matrix 1744 rows 870 cols
[2021-05-16 17:37:31] [INFO ] Computed 58 place invariants in 53 ms
[2021-05-16 17:37:31] [INFO ] Dead Transitions using invariants and state equation in 864 ms returned []
Finished structural reductions, in 2 iterations. Remains : 870/870 places, 1784/2324 transitions.
[2021-05-16 17:37:32] [INFO ] Flatten gal took : 172 ms
[2021-05-16 17:37:32] [INFO ] Flatten gal took : 106 ms
[2021-05-16 17:37:32] [INFO ] Input system was already deterministic with 1784 transitions.
Incomplete random walk after 100000 steps, including 5 resets, run finished after 3119 ms. (steps per millisecond=32 ) properties (out of 45) seen :19
Running SMT prover for 26 properties.
[2021-05-16 17:37:35] [INFO ] Flow matrix only has 1744 transitions (discarded 40 similar events)
// Phase 1: matrix 1744 rows 870 cols
[2021-05-16 17:37:35] [INFO ] Computed 58 place invariants in 44 ms
[2021-05-16 17:37:36] [INFO ] [Real]Absence check using 14 positive place invariants in 7 ms returned sat
[2021-05-16 17:37:36] [INFO ] [Real]Absence check using 14 positive and 44 generalized place invariants in 37 ms returned sat
[2021-05-16 17:37:36] [INFO ] SMT Verify possible in real domain returnedunsat :2 sat :0 real:24
[2021-05-16 17:37:37] [INFO ] [Nat]Absence check using 14 positive place invariants in 8 ms returned sat
[2021-05-16 17:37:37] [INFO ] [Nat]Absence check using 14 positive and 44 generalized place invariants in 47 ms returned sat
[2021-05-16 17:37:37] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2021-05-16 17:37:39] [INFO ] [Nat]Absence check using state equation in 2115 ms returned unsat :22 sat :4
[2021-05-16 17:37:39] [INFO ] State equation strengthened by 210 read => feed constraints.
[2021-05-16 17:37:39] [INFO ] [Nat]Added 210 Read/Feed constraints in 41 ms returned sat
Attempting to minimize the solution found.
Minimization took 124 ms.
[2021-05-16 17:37:40] [INFO ] SMT Verify possible in nat domain returned unsat :22 sat :4
Successfully simplified 24 atomic propositions for a total of 8 simplifications.
Ensure Unique test removed 4 places
Drop transitions removed 80 transitions
Trivial Post-agglo rules discarded 80 transitions
Performed 80 trivial Post agglomeration. Transition count delta: 80
Iterating post reduction 0 with 80 rules applied. Total rules applied 80 place count 866 transition count 1704
Reduce places removed 80 places and 0 transitions.
Iterating post reduction 1 with 80 rules applied. Total rules applied 160 place count 786 transition count 1704
Performed 100 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 2 with 100 Pre rules applied. Total rules applied 160 place count 786 transition count 1604
Deduced a syphon composed of 100 places in 2 ms
Reduce places removed 100 places and 0 transitions.
Iterating global reduction 2 with 200 rules applied. Total rules applied 360 place count 686 transition count 1604
Performed 80 Post agglomeration using F-continuation condition.Transition count delta: 80
Deduced a syphon composed of 80 places in 2 ms
Reduce places removed 80 places and 0 transitions.
Iterating global reduction 2 with 160 rules applied. Total rules applied 520 place count 606 transition count 1524
Applied a total of 520 rules in 157 ms. Remains 606 /870 variables (removed 264) and now considering 1524/1784 (removed 260) transitions.
[2021-05-16 17:37:41] [INFO ] Flatten gal took : 124 ms
[2021-05-16 17:37:41] [INFO ] Flatten gal took : 72 ms
[2021-05-16 17:37:41] [INFO ] Input system was already deterministic with 1524 transitions.
[2021-05-16 17:37:41] [INFO ] Flatten gal took : 64 ms
[2021-05-16 17:37:41] [INFO ] Flatten gal took : 62 ms
[2021-05-16 17:37:41] [INFO ] Time to serialize gal into /tmp/CTLCardinality12235796352689915550.gal : 41 ms
[2021-05-16 17:37:41] [INFO ] Time to serialize properties into /tmp/CTLCardinality13681205843813564647.ctl : 1 ms
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-ctl-linux64, --gc-threshold, 2000000, --quiet, -i, /tmp/CTLCardinality12235796352689915550.gal, -t, CGAL, -ctl, /tmp/CTLCardinality13681205843813564647.ctl, --gen-order, FOLLOW], workingDir=/home/mcc/execution]

its-ctl command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-ctl-linux64 --gc-threshold 2000000 --quiet -i /tmp/CTLCardinality12235796352689915550.gal -t CGAL -ctl /tmp/CTLCardinality13681205843813564647.ctl --gen-order FOLLOW
No direction supplied, using forward translation only.
Parsed 1 CTL formulae.
Detected timeout of ITS tools.
[2021-05-16 17:38:11] [INFO ] Flatten gal took : 174 ms
[2021-05-16 17:38:11] [INFO ] Applying decomposition
[2021-05-16 17:38:11] [INFO ] Flatten gal took : 71 ms
Converted graph to binary with : CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202104292328/bin/convert-linux64, -i, /tmp/graph10754115640475243585.txt, -o, /tmp/graph10754115640475243585.bin, -w, /tmp/graph10754115640475243585.weights], workingDir=null]
Built communities with : CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202104292328/bin/louvain-linux64, /tmp/graph10754115640475243585.bin, -l, -1, -v, -w, /tmp/graph10754115640475243585.weights, -q, 0, -e, 0.001], workingDir=null]
[2021-05-16 17:38:12] [INFO ] Decomposing Gal with order
[2021-05-16 17:38:12] [INFO ] Rewriting arrays to variables to allow decomposition.
[2021-05-16 17:38:12] [INFO ] Removed a total of 1336 redundant transitions.
[2021-05-16 17:38:12] [INFO ] Flatten gal took : 338 ms
[2021-05-16 17:38:12] [INFO ] Fuse similar labels procedure discarded/fused a total of 506 labels/synchronizations in 50 ms.
[2021-05-16 17:38:13] [INFO ] Time to serialize gal into /tmp/CTLCardinality18023788521775490949.gal : 10 ms
[2021-05-16 17:38:13] [INFO ] Time to serialize properties into /tmp/CTLCardinality13041330561379996132.ctl : 1 ms
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-ctl-linux64, --gc-threshold, 2000000, --quiet, -i, /tmp/CTLCardinality18023788521775490949.gal, -t, CGAL, -ctl, /tmp/CTLCardinality13041330561379996132.ctl, --gen-order, FOLLOW], workingDir=/home/mcc/execution]

its-ctl command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-ctl-linux64 --gc-threshold 2000000 --quiet -i /tmp/CTLCardinality18023788521775490949.gal -t CGAL -ctl /tmp/CTLCardinality13041330561379996132.ctl --gen-order FOLLOW
No direction supplied, using forward translation only.
Parsed 1 CTL formulae.
Detected timeout of ITS tools.
Ensure Unique test removed 4 places
Drop transitions removed 90 transitions
Trivial Post-agglo rules discarded 90 transitions
Performed 90 trivial Post agglomeration. Transition count delta: 90
Iterating post reduction 0 with 90 rules applied. Total rules applied 90 place count 866 transition count 1694
Reduce places removed 90 places and 0 transitions.
Iterating post reduction 1 with 90 rules applied. Total rules applied 180 place count 776 transition count 1694
Performed 100 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 2 with 100 Pre rules applied. Total rules applied 180 place count 776 transition count 1594
Deduced a syphon composed of 100 places in 1 ms
Reduce places removed 100 places and 0 transitions.
Iterating global reduction 2 with 200 rules applied. Total rules applied 380 place count 676 transition count 1594
Performed 80 Post agglomeration using F-continuation condition.Transition count delta: 80
Deduced a syphon composed of 80 places in 1 ms
Reduce places removed 80 places and 0 transitions.
Iterating global reduction 2 with 160 rules applied. Total rules applied 540 place count 596 transition count 1514
Applied a total of 540 rules in 326 ms. Remains 596 /870 variables (removed 274) and now considering 1514/1784 (removed 270) transitions.
[2021-05-16 17:38:43] [INFO ] Flatten gal took : 222 ms
[2021-05-16 17:38:43] [INFO ] Flatten gal took : 130 ms
[2021-05-16 17:38:44] [INFO ] Input system was already deterministic with 1514 transitions.
[2021-05-16 17:38:44] [INFO ] Flatten gal took : 62 ms
[2021-05-16 17:38:44] [INFO ] Flatten gal took : 63 ms
[2021-05-16 17:38:44] [INFO ] Time to serialize gal into /tmp/CTLCardinality16989039826106292582.gal : 31 ms
[2021-05-16 17:38:44] [INFO ] Time to serialize properties into /tmp/CTLCardinality15628350248944669334.ctl : 0 ms
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-ctl-linux64, --gc-threshold, 2000000, --quiet, -i, /tmp/CTLCardinality16989039826106292582.gal, -t, CGAL, -ctl, /tmp/CTLCardinality15628350248944669334.ctl, --gen-order, FOLLOW], workingDir=/home/mcc/execution]

its-ctl command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-ctl-linux64 --gc-threshold 2000000 --quiet -i /tmp/CTLCardinality16989039826106292582.gal -t CGAL -ctl /tmp/CTLCardinality15628350248944669334.ctl --gen-order FOLLOW
No direction supplied, using forward translation only.
Parsed 1 CTL formulae.
Detected timeout of ITS tools.
[2021-05-16 17:39:14] [INFO ] Flatten gal took : 92 ms
[2021-05-16 17:39:14] [INFO ] Applying decomposition
[2021-05-16 17:39:14] [INFO ] Flatten gal took : 68 ms
Converted graph to binary with : CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202104292328/bin/convert-linux64, -i, /tmp/graph463260283730273736.txt, -o, /tmp/graph463260283730273736.bin, -w, /tmp/graph463260283730273736.weights], workingDir=null]
Built communities with : CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202104292328/bin/louvain-linux64, /tmp/graph463260283730273736.bin, -l, -1, -v, -w, /tmp/graph463260283730273736.weights, -q, 0, -e, 0.001], workingDir=null]
[2021-05-16 17:39:15] [INFO ] Decomposing Gal with order
[2021-05-16 17:39:15] [INFO ] Rewriting arrays to variables to allow decomposition.
[2021-05-16 17:39:15] [INFO ] Removed a total of 1541 redundant transitions.
[2021-05-16 17:39:15] [INFO ] Flatten gal took : 291 ms
[2021-05-16 17:39:15] [INFO ] Fuse similar labels procedure discarded/fused a total of 696 labels/synchronizations in 64 ms.
[2021-05-16 17:39:15] [INFO ] Time to serialize gal into /tmp/CTLCardinality14550198670851789396.gal : 23 ms
[2021-05-16 17:39:15] [INFO ] Time to serialize properties into /tmp/CTLCardinality1054923565604500542.ctl : 0 ms
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-ctl-linux64, --gc-threshold, 2000000, --quiet, -i, /tmp/CTLCardinality14550198670851789396.gal, -t, CGAL, -ctl, /tmp/CTLCardinality1054923565604500542.ctl, --gen-order, FOLLOW], workingDir=/home/mcc/execution]

its-ctl command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-ctl-linux64 --gc-threshold 2000000 --quiet -i /tmp/CTLCardinality14550198670851789396.gal -t CGAL -ctl /tmp/CTLCardinality1054923565604500542.ctl --gen-order FOLLOW
No direction supplied, using forward translation only.
Parsed 1 CTL formulae.
Detected timeout of ITS tools.
[2021-05-16 17:39:45] [INFO ] Flatten gal took : 93 ms
[2021-05-16 17:39:46] [INFO ] Flatten gal took : 62 ms
[2021-05-16 17:39:46] [INFO ] Applying decomposition
[2021-05-16 17:39:46] [INFO ] Flatten gal took : 68 ms
Converted graph to binary with : CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202104292328/bin/convert-linux64, -i, /tmp/graph14995790677231189898.txt, -o, /tmp/graph14995790677231189898.bin, -w, /tmp/graph14995790677231189898.weights], workingDir=null]
Built communities with : CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202104292328/bin/louvain-linux64, /tmp/graph14995790677231189898.bin, -l, -1, -v, -w, /tmp/graph14995790677231189898.weights, -q, 0, -e, 0.001], workingDir=null]
[2021-05-16 17:39:46] [INFO ] Decomposing Gal with order
[2021-05-16 17:39:46] [INFO ] Rewriting arrays to variables to allow decomposition.
[2021-05-16 17:39:47] [INFO ] Removed a total of 2543 redundant transitions.
[2021-05-16 17:39:47] [INFO ] Flatten gal took : 717 ms
[2021-05-16 17:39:47] [INFO ] Fuse similar labels procedure discarded/fused a total of 342 labels/synchronizations in 70 ms.
[2021-05-16 17:39:47] [INFO ] Time to serialize gal into /tmp/CTLCardinality15996496640921073240.gal : 14 ms
[2021-05-16 17:39:47] [INFO ] Time to serialize properties into /tmp/CTLCardinality4849371664988363457.ctl : 5 ms
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-ctl-linux64, --gc-threshold, 2000000, --quiet, -i, /tmp/CTLCardinality15996496640921073240.gal, -t, CGAL, -ctl, /tmp/CTLCardinality4849371664988363457.ctl, --gen-order, FOLLOW], workingDir=/home/mcc/execution]

its-ctl command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-ctl-linux64 --gc-threshold 2000000 --quiet -i /tmp/CTLCardinality15996496640921073240.gal -t CGAL -ctl /tmp/CTLCardinality4849371664988363457.ctl --gen-order FOLLOW
No direction supplied, using forward translation only.
Parsed 8 CTL formulae.
Detected timeout of ITS tools.
[2021-05-16 18:00:37] [INFO ] Applying decomposition
[2021-05-16 18:00:40] [INFO ] Flatten gal took : 2281 ms
[2021-05-16 18:00:41] [INFO ] Decomposing Gal with order
[2021-05-16 18:00:41] [INFO ] Rewriting arrays to variables to allow decomposition.
[2021-05-16 18:00:43] [INFO ] Removed a total of 5327 redundant transitions.
[2021-05-16 18:00:44] [INFO ] Flatten gal took : 2362 ms
[2021-05-16 18:00:45] [INFO ] Fuse similar labels procedure discarded/fused a total of 100 labels/synchronizations in 632 ms.
[2021-05-16 18:00:46] [INFO ] Time to serialize gal into /tmp/CTLCardinality6627047329426196239.gal : 115 ms
[2021-05-16 18:00:46] [INFO ] Time to serialize properties into /tmp/CTLCardinality17753247723424053434.ctl : 11 ms
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-ctl-linux64, --gc-threshold, 2000000, --quiet, -i, /tmp/CTLCardinality6627047329426196239.gal, -t, CGAL, -ctl, /tmp/CTLCardinality17753247723424053434.ctl, --gen-order, FOLLOW], workingDir=/home/mcc/execution]

its-ctl command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-ctl-linux64 --gc-threshold 2000000 --quiet -i /tmp/CTLCardinality6627047329426196239.gal -t CGAL -ctl /tmp/CTLCardinality17753247723424053434.ctl --gen-order FOLLOW
No direction supplied, using forward translation only.
Parsed 8 CTL formulae.
Detected timeout of ITS tools.
[2021-05-16 18:21:36] [INFO ] Flatten gal took : 403 ms
[2021-05-16 18:21:37] [INFO ] Input system was already deterministic with 1784 transitions.
[2021-05-16 18:21:38] [INFO ] Transformed 870 places.
[2021-05-16 18:21:38] [INFO ] Transformed 1784 transitions.
Running greatSPN : CommandLine [args=[/home/mcc/BenchKit/bin//..//greatspn//bin/pinvar, /home/mcc/execution/gspn], workingDir=/home/mcc/execution]
P-invariant computation with GreatSPN timed out. Skipping.
Running greatSPN : CommandLine [args=[/home/mcc/BenchKit/bin//..//greatspn//bin/RGMEDD2, /home/mcc/execution/gspn, -META, -varord-only], workingDir=/home/mcc/execution]
Run of greatSPN captured in /home/mcc/execution/outPut.txt
Using order generated by GreatSPN with heuristic : META
[2021-05-16 18:22:08] [INFO ] Time to serialize gal into /tmp/CTLCardinality12702889606565418280.gal : 6 ms
[2021-05-16 18:22:08] [INFO ] Time to serialize properties into /tmp/CTLCardinality12909357478087679288.ctl : 21 ms
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-ctl-linux64, --gc-threshold, 2000000, --quiet, -i, /tmp/CTLCardinality12702889606565418280.gal, -t, CGAL, -ctl, /tmp/CTLCardinality12909357478087679288.ctl, --load-order, /home/mcc/execution/model.ord, --gen-order, FOLLOW], workingDir=/home/mcc/execution]

its-ctl command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-ctl-linux64 --gc-threshold 2000000 --quiet -i /tmp/CTLCardinality12702889606565418280.gal -t CGAL -ctl /tmp/CTLCardinality12909357478087679288.ctl --load-order /home/mcc/execution/model.ord --gen-order FOLLOW
Successfully loaded order from file /home/mcc/execution/model.ord
No direction supplied, using forward translation only.
Parsed 8 CTL formulae.

BK_TIME_CONFINEMENT_REACHED

--------------------
content from stderr:

+ export BINDIR=/home/mcc/BenchKit/bin//../
+ BINDIR=/home/mcc/BenchKit/bin//../
++ pwd
+ export MODEL=/home/mcc/execution
+ MODEL=/home/mcc/execution
+ [[ CTLCardinality = StateSpace ]]
+ /home/mcc/BenchKit/bin//..//runeclipse.sh /home/mcc/execution CTLCardinality -its -ltsmin -greatspnpath /home/mcc/BenchKit/bin//..//greatspn/ -order META -manyOrder -smt -timeout 3600
+ ulimit -s 65536
+ [[ -z '' ]]
+ export LTSMIN_MEM_SIZE=8589934592
+ LTSMIN_MEM_SIZE=8589934592
++ cut -d . -f 9
++ ls /home/mcc/BenchKit/bin//..//itstools/plugins/fr.lip6.move.gal.application.pnmcc_1.0.0.202104292328.jar
+ VERSION=0
+ echo 'Running Version 0'
+ /home/mcc/BenchKit/bin//..//itstools/its-tools -data /home/mcc/execution/workspace -pnfolder /home/mcc/execution -examination CTLCardinality -spotpath /home/mcc/BenchKit/bin//..//ltlfilt -z3path /home/mcc/BenchKit/bin//..//z3/bin/z3 -yices2path /home/mcc/BenchKit/bin//..//yices/bin/yices -its -ltsmin -greatspnpath /home/mcc/BenchKit/bin//..//greatspn/ -order META -manyOrder -smt -timeout 3600 -vmargs -Dosgi.locking=none -Declipse.stateSaveDelayInterval=-1 -Dosgi.configuration.area=/tmp/.eclipse -Xss128m -Xms40m -Xmx16000m

Sequence of Actions to be Executed by the VM

This is useful if one wants to reexecute the tool in the VM from the submitted image disk.

set -x
# this is for BenchKit: configuration of major elements for the test
export BK_INPUT="PolyORBLF-COL-S04J04T10"
export BK_EXAMINATION="CTLCardinality"
export BK_TOOL="itstools"
export BK_RESULT_DIR="/tmp/BK_RESULTS/OUTPUTS"
export BK_TIME_CONFINEMENT="3600"
export BK_MEMORY_CONFINEMENT="16384"
export BK_BIN_PATH="/home/mcc/BenchKit/bin/"

# this is specific to your benchmark or test

export BIN_DIR="$HOME/BenchKit/bin"

# remove the execution directoty if it exists (to avoid increse of .vmdk images)
if [ -d execution ] ; then
rm -rf execution
fi

# this is for BenchKit: explicit launching of the test
echo "====================================================================="
echo " Generated by BenchKit 2-4028"
echo " Executing tool itstools"
echo " Input is PolyORBLF-COL-S04J04T10, examination is CTLCardinality"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 4"
echo " Run identifier is r159-oct2-162089267900137"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

tar xzf /home/mcc/BenchKit/INPUTS/PolyORBLF-COL-S04J04T10.tgz
mv PolyORBLF-COL-S04J04T10 execution
cd execution
if [ "CTLCardinality" = "ReachabilityDeadlock" ] || [ "CTLCardinality" = "UpperBounds" ] || [ "CTLCardinality" = "QuasiLiveness" ] || [ "CTLCardinality" = "StableMarking" ] || [ "CTLCardinality" = "Liveness" ] || [ "CTLCardinality" = "OneSafe" ] || [ "CTLCardinality" = "StateSpace" ]; then
rm -f GenericPropertiesVerdict.xml
fi
pwd
ls -lh

echo
echo "--------------------"
echo "content from stdout:"
echo
echo "=== Data for post analysis generated by BenchKit (invocation template)"
echo
if [ "CTLCardinality" = "UpperBounds" ] ; then
echo "The expected result is a vector of positive values"
echo NUM_VECTOR
elif [ "CTLCardinality" != "StateSpace" ] ; then
echo "The expected result is a vector of booleans"
echo BOOL_VECTOR
else
echo "no data necessary for post analysis"
fi
echo
if [ -f "CTLCardinality.txt" ] ; then
echo "here is the order used to build the result vector(from text file)"
for x in $(grep Property CTLCardinality.txt | cut -d ' ' -f 2 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ -f "CTLCardinality.xml" ] ; then # for cunf (txt files deleted;-)
echo echo "here is the order used to build the result vector(from xml file)"
for x in $(grep '' CTLCardinality.xml | cut -d '>' -f 2 | cut -d '<' -f 1 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ "CTLCardinality" = "ReachabilityDeadlock" ] || [ "CTLCardinality" = "QuasiLiveness" ] || [ "CTLCardinality" = "StableMarking" ] || [ "CTLCardinality" = "Liveness" ] || [ "CTLCardinality" = "OneSafe" ] ; then
echo "FORMULA_NAME CTLCardinality"
fi
echo
echo "=== Now, execution of the tool begins"
echo
echo -n "BK_START "
date -u +%s%3N
echo
timeout -s 9 $BK_TIME_CONFINEMENT bash -c "/home/mcc/BenchKit/BenchKit_head.sh 2> STDERR ; echo ; echo -n \"BK_STOP \" ; date -u +%s%3N"
if [ $? -eq 137 ] ; then
echo
echo "BK_TIME_CONFINEMENT_REACHED"
fi
echo
echo "--------------------"
echo "content from stderr:"
echo
cat STDERR ;