Execution Chart

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

Trace from the execution

Formatting '/data/fkordon/mcc2022-input.r144-tall-165271831200417.qcow2', fmt=qcow2 size=4294967296 backing_file=/data/fkordon/mcc2022-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 gold2021
Input is MultiCrashLeafsetExtension-PT-S16C04, examination is QuasiLiveness
Time confinement is 1800 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r144-tall-165271831200417
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 4.3M
-rw-r--r-- 1 mcc users 15K Apr 29 16:14 CTLCardinality.txt
-rw-r--r-- 1 mcc users 101K Apr 29 16:14 CTLCardinality.xml
-rw-r--r-- 1 mcc users 8.9K Apr 29 16:10 CTLFireability.txt
-rw-r--r-- 1 mcc users 48K Apr 29 16:10 CTLFireability.xml
-rw-r--r-- 1 mcc users 6.3K May 9 08:14 LTLCardinality.txt
-rw-r--r-- 1 mcc users 27K May 9 08:14 LTLCardinality.xml
-rw-r--r-- 1 mcc users 4.8K May 9 08:14 LTLFireability.txt
-rw-r--r-- 1 mcc users 20K May 9 08:14 LTLFireability.xml
-rw-r--r-- 1 mcc users 2.5K May 9 08:14 UpperBounds.txt
-rw-r--r-- 1 mcc users 4.5K May 9 08:14 UpperBounds.xml
-rw-r--r-- 1 mcc users 6 May 10 09:34 equiv_col
-rw-r--r-- 1 mcc users 7 May 10 09:34 instance
-rw-r--r-- 1 mcc users 6 May 10 09:34 iscolored
-rw-r--r-- 1 mcc users 4.1M May 10 09:34 model.pnml

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

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

The expected result is a vector of booleans
BOOL_VECTOR

FORMULA_NAME QuasiLiveness

=== Now, execution of the tool begins

BK_START 1652745721851

Running Version 0
[2022-05-17 00:02:03] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, QuasiLiveness, -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, 1800]
[2022-05-17 00:02:03] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2022-05-17 00:02:03] [INFO ] Load time of PNML (sax parser for PT used): 392 ms
[2022-05-17 00:02:03] [INFO ] Transformed 4260 places.
[2022-05-17 00:02:03] [INFO ] Transformed 6027 transitions.
[2022-05-17 00:02:03] [INFO ] Parsed PT model containing 4260 places and 6027 transitions in 463 ms.
Starting structural reductions, iteration 0 : 4260/4260 places, 6027/6027 transitions.
Reduce places removed 28 places and 0 transitions.
Drop transitions removed 1088 transitions
Trivial Post-agglo rules discarded 1088 transitions
Performed 1088 trivial Post agglomeration. Transition count delta: 1088
Iterating post reduction 0 with 1116 rules applied. Total rules applied 1116 place count 4232 transition count 4939
Reduce places removed 1088 places and 0 transitions.
Iterating post reduction 1 with 1088 rules applied. Total rules applied 2204 place count 3144 transition count 4939
Performed 136 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 2 with 136 Pre rules applied. Total rules applied 2204 place count 3144 transition count 4803
Deduced a syphon composed of 136 places in 17 ms
Reduce places removed 136 places and 0 transitions.
Iterating global reduction 2 with 272 rules applied. Total rules applied 2476 place count 3008 transition count 4803
Discarding 952 places :
Symmetric choice reduction at 2 with 952 rule applications. Total rules 3428 place count 2056 transition count 3851
Iterating global reduction 2 with 952 rules applied. Total rules applied 4380 place count 2056 transition count 3851
Performed 8 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 2 with 8 Pre rules applied. Total rules applied 4380 place count 2056 transition count 3843
Deduced a syphon composed of 8 places in 5 ms
Reduce places removed 8 places and 0 transitions.
Iterating global reduction 2 with 16 rules applied. Total rules applied 4396 place count 2048 transition count 3843
Discarding 238 places :
Symmetric choice reduction at 2 with 238 rule applications. Total rules 4634 place count 1810 transition count 2891
Iterating global reduction 2 with 238 rules applied. Total rules applied 4872 place count 1810 transition count 2891
Performed 17 Post agglomeration using F-continuation condition.Transition count delta: 17
Deduced a syphon composed of 17 places in 2 ms
Reduce places removed 17 places and 0 transitions.
Iterating global reduction 2 with 34 rules applied. Total rules applied 4906 place count 1793 transition count 2874
Applied a total of 4906 rules in 1064 ms. Remains 1793 /4260 variables (removed 2467) and now considering 2874/6027 (removed 3153) transitions.
[2022-05-17 00:02:04] [INFO ] Flow matrix only has 2602 transitions (discarded 272 similar events)
// Phase 1: matrix 2602 rows 1793 cols
[2022-05-17 00:02:05] [INFO ] Computed 469 place invariants in 158 ms
[2022-05-17 00:02:07] [INFO ] Implicit Places using invariants in 2336 ms returned [4, 7, 11, 12, 13, 14, 15, 20, 27, 36, 47, 60, 75, 91, 107, 108, 109, 110, 111, 124, 135, 144, 151, 156, 159, 170, 176, 179, 180, 181, 182, 183, 186, 191, 198, 207, 218, 231, 245, 259, 260, 261, 262, 263, 274, 283, 290, 295, 298, 300, 311, 317, 320, 321, 322, 323, 324, 326, 329, 334, 341, 350, 361, 373, 385, 386, 387, 388, 389, 398, 405, 410, 413, 415, 417, 428, 434, 437, 438, 439, 440, 441, 443, 445, 448, 453, 460, 469, 479, 489, 490, 491, 492, 493, 500, 505, 508, 510, 512, 514, 525, 531, 534, 535, 536, 537, 538, 540, 542, 544, 547, 552, 559, 567, 575, 576, 577, 578, 579, 584, 587, 589, 591, 593, 595, 606, 612, 615, 616, 617, 618, 619, 621, 623, 625, 627, 630, 635, 641, 647, 648, 649, 650, 651, 654, 656, 658, 660, 662, 664, 675, 681, 684, 685, 686, 687, 688, 690, 692, 694, 696, 698, 701, 705, 709, 710, 711, 712, 713, 715, 717, 719, 721, 723, 725, 736, 742, 745, 746, 747, 748, 749, 751, 753, 755, 757, 759, 761, 763, 766, 767, 768, 769, 770, 772, 774, 776, 778, 780, 782, 793, 795, 798, 801, 802, 803, 804, 805, 807, 809, 811, 813, 815, 817, 819, 822, 823, 824, 825, 826, 828, 830, 832, 834, 836, 838, 849, 855, 858, 859, 860, 861, 862, 864, 866, 868, 870, 872, 874, 876, 879, 880, 881, 882, 883, 885, 887, 889, 891, 893, 895, 906, 912, 915, 916, 917, 918, 919, 921, 923, 925, 927, 929, 931, 934, 939, 940, 941, 942, 943, 946, 948, 950, 952, 954, 956, 967, 973, 976, 977, 978, 979, 980, 982, 984, 986, 988, 990, 993, 998, 1005, 1006, 1007, 1008, 1009, 1014, 1017, 1019, 1021, 1023, 1025, 1036, 1042, 1045, 1046, 1047, 1048, 1049, 1051, 1053, 1055, 1057, 1060, 1065, 1072, 1081, 1082, 1083, 1084, 1085, 1092, 1097, 1100, 1102, 1104, 1106, 1117, 1123, 1126, 1127, 1128, 1129, 1130, 1132, 1134, 1136, 1139, 1144, 1151, 1160, 1171, 1172, 1173, 1174, 1175, 1184, 1191, 1196, 1199, 1201, 1203, 1214, 1220, 1223, 1224, 1225, 1226, 1227, 1229, 1231, 1234, 1239, 1246, 1255, 1266, 1279, 1280, 1281, 1282, 1283, 1294, 1303, 1310, 1315, 1318, 1320, 1331, 1337, 1340, 1341, 1342, 1343, 1344, 1346, 1349, 1354, 1361, 1370, 1381, 1394, 1409, 1410, 1411, 1412, 1413, 1426, 1437, 1446, 1453, 1458, 1461, 1472, 1474, 1477, 1480, 1481, 1482, 1483, 1484, 1487, 1492, 1499, 1508, 1519, 1532, 1547, 1564, 1565, 1566, 1567, 1568, 1583, 1596, 1607, 1616, 1623, 1628, 1640]
Discarding 428 places :
Implicit Place search using SMT only with invariants took 2369 ms to find 428 implicit places.
[2022-05-17 00:02:07] [INFO ] Flow matrix only has 2602 transitions (discarded 272 similar events)
// Phase 1: matrix 2602 rows 1365 cols
[2022-05-17 00:02:07] [INFO ] Computed 41 place invariants in 68 ms
[2022-05-17 00:02:08] [INFO ] Dead Transitions using invariants and state equation in 1107 ms returned []
Starting structural reductions, iteration 1 : 1365/4260 places, 2874/6027 transitions.
Discarding 128 places :
Symmetric choice reduction at 0 with 128 rule applications. Total rules 128 place count 1237 transition count 2746
Iterating global reduction 0 with 128 rules applied. Total rules applied 256 place count 1237 transition count 2746
Discarding 128 places :
Symmetric choice reduction at 0 with 128 rule applications. Total rules 384 place count 1109 transition count 2618
Iterating global reduction 0 with 128 rules applied. Total rules applied 512 place count 1109 transition count 2618
Discarding 32 places :
Symmetric choice reduction at 0 with 32 rule applications. Total rules 544 place count 1077 transition count 2490
Iterating global reduction 0 with 32 rules applied. Total rules applied 576 place count 1077 transition count 2490
Applied a total of 576 rules in 172 ms. Remains 1077 /1365 variables (removed 288) and now considering 2490/2874 (removed 384) transitions.
[2022-05-17 00:02:08] [INFO ] Flow matrix only has 2218 transitions (discarded 272 similar events)
// Phase 1: matrix 2218 rows 1077 cols
[2022-05-17 00:02:08] [INFO ] Computed 41 place invariants in 45 ms
[2022-05-17 00:02:09] [INFO ] Implicit Places using invariants in 824 ms returned []
[2022-05-17 00:02:09] [INFO ] Flow matrix only has 2218 transitions (discarded 272 similar events)
// Phase 1: matrix 2218 rows 1077 cols
[2022-05-17 00:02:09] [INFO ] Computed 41 place invariants in 24 ms
[2022-05-17 00:02:09] [INFO ] State equation strengthened by 841 read => feed constraints.
[2022-05-17 00:02:10] [INFO ] Implicit Places using invariants and state equation in 791 ms returned []
Implicit Place search using SMT with State Equation took 1618 ms to find 0 implicit places.
Finished structural reductions, in 2 iterations. Remains : 1077/4260 places, 2490/6027 transitions.
[2022-05-17 00:02:10] [INFO ] Initial state test concluded for 17 properties.
Incomplete random walk after 10000 steps, including 339 resets, run finished after 978 ms. (steps per millisecond=10 ) properties (out of 2473) seen :661
Running SMT prover for 1812 properties.
[2022-05-17 00:02:11] [INFO ] Flow matrix only has 2218 transitions (discarded 272 similar events)
// Phase 1: matrix 2218 rows 1077 cols
[2022-05-17 00:02:11] [INFO ] Computed 41 place invariants in 16 ms
[2022-05-17 00:02:36] [WARNING] SMT solver failed with error :SMT solver raised an error when submitting script.... while checking expressions.
Fused 1812 Parikh solutions to 1 different solutions.
Support contains 998 out of 1077 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 1077/1077 places, 2490/2490 transitions.
Free-agglomeration rule (complex) applied 5 times.
Iterating global reduction 0 with 5 rules applied. Total rules applied 5 place count 1077 transition count 2485
Reduce places removed 5 places and 0 transitions.
Iterating post reduction 0 with 5 rules applied. Total rules applied 10 place count 1072 transition count 2485
Applied a total of 10 rules in 154 ms. Remains 1072 /1077 variables (removed 5) and now considering 2485/2490 (removed 5) transitions.
Finished structural reductions, in 1 iterations. Remains : 1072/1077 places, 2485/2490 transitions.
[2022-05-17 00:02:36] [INFO ] Flatten gal took : 223 ms
[2022-05-17 00:02:37] [INFO ] Flatten gal took : 137 ms
[2022-05-17 00:02:37] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality7055276104297432008.gal : 40 ms
[2022-05-17 00:02:37] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality3227903480530274583.prop : 8 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-reach-linux64, --gc-threshold, 2000000, --quiet, -i, /tmp/ReachabilityCardinality7055276104297432008.gal, -t, CGAL, -reachable-file, /tmp/ReachabilityCardinality3227903480530274583.prop, --nowitness, --gen-order, FOLLOW], workingDir=/home/mcc/execution]

its-reach command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-reach-linux64 --gc-threshold 2000000 --quiet -i /tmp/ReachabilityCardinality7055276104297432008.gal -t CGAL -reachable-file /tmp/ReachabilityCardinality3227903480530274583.prop --nowitness --gen-order FOLLOW
Loading property file /tmp/ReachabilityCardinality3227903480530274583.prop.
SDD proceeding with computation,1812 properties remain. new max is 4
SDD size :1 after 20
SDD proceeding with computation,1812 properties remain. new max is 8
SDD size :20 after 21
SDD proceeding with computation,1812 properties remain. new max is 16
SDD size :21 after 23
SDD proceeding with computation,1812 properties remain. new max is 32
SDD size :23 after 31
Detected timeout of ITS tools.
[2022-05-17 00:02:52] [INFO ] Flatten gal took : 105 ms
[2022-05-17 00:02:52] [INFO ] Applying decomposition
[2022-05-17 00:02:52] [INFO ] Flatten gal took : 90 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/graph8164606755576430631.txt, -o, /tmp/graph8164606755576430631.bin, -w, /tmp/graph8164606755576430631.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/graph8164606755576430631.bin, -l, -1, -v, -w, /tmp/graph8164606755576430631.weights, -q, 0, -e, 0.001], workingDir=null]
[2022-05-17 00:02:52] [INFO ] Decomposing Gal with order
[2022-05-17 00:02:52] [INFO ] Rewriting arrays to variables to allow decomposition.
[2022-05-17 00:02:53] [INFO ] Removed a total of 2259 redundant transitions.
[2022-05-17 00:02:53] [INFO ] Flatten gal took : 721 ms
[2022-05-17 00:02:53] [INFO ] Fuse similar labels procedure discarded/fused a total of 1390 labels/synchronizations in 116 ms.
[2022-05-17 00:02:53] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality1645562263870630240.gal : 23 ms
[2022-05-17 00:02:54] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality13437601208448344589.prop : 16 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-reach-linux64, --gc-threshold, 2000000, --quiet, -i, /tmp/ReachabilityCardinality1645562263870630240.gal, -t, CGAL, -reachable-file, /tmp/ReachabilityCardinality13437601208448344589.prop, --nowitness], workingDir=/home/mcc/execution]

its-reach command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-reach-linux64 --gc-threshold 2000000 --quiet -i /tmp/ReachabilityCardinality1645562263870630240.gal -t CGAL -reachable-file /tmp/ReachabilityCardinality13437601208448344589.prop --nowitness
Loading property file /tmp/ReachabilityCardinality13437601208448344589.prop.
SDD proceeding with computation,1812 properties remain. new max is 4
SDD size :1 after 8
SDD proceeding with computation,1812 properties remain. new max is 8
SDD size :8 after 12
SDD proceeding with computation,1812 properties remain. new max is 16
SDD size :12 after 25
SDD proceeding with computation,1812 properties remain. new max is 32
SDD size :25 after 34
SDD proceeding with computation,1812 properties remain. new max is 64
SDD size :34 after 39
SDD proceeding with computation,1812 properties remain. new max is 128
SDD size :39 after 43
SDD proceeding with computation,1812 properties remain. new max is 256
SDD size :43 after 49
SDD proceeding with computation,1812 properties remain. new max is 512
SDD size :49 after 57
SDD proceeding with computation,1812 properties remain. new max is 1024
SDD size :57 after 72
SDD proceeding with computation,1812 properties remain. new max is 2048
SDD size :72 after 79
SDD proceeding with computation,1812 properties remain. new max is 4096
SDD size :79 after 143
SDD proceeding with computation,1812 properties remain. new max is 8192
SDD size :143 after 198
SDD proceeding with computation,1812 properties remain. new max is 16384
SDD size :198 after 258
SDD proceeding with computation,1812 properties remain. new max is 32768
SDD size :258 after 588
SDD proceeding with computation,1812 properties remain. new max is 65536
SDD size :588 after 912
Detected timeout of ITS tools.
Built C files in :
/tmp/ltsmin7536505591856594542
[2022-05-17 00:03:09] [INFO ] Built C files in 60ms conformant to PINS (ltsmin variant)in folder :/tmp/ltsmin7536505591856594542
Running compilation step : CommandLine [args=[gcc, -c, -I/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202104292328/bin/include/, -I., -std=c99, -fPIC, -O2, model.c], workingDir=/tmp/ltsmin7536505591856594542]
WARNING : LTS min runner thread failed on error :java.lang.RuntimeException: Compilation or link of executable timed out.java.util.concurrent.TimeoutException: Subprocess running CommandLine [args=[gcc, -c, -I/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202104292328/bin/include/, -I., -std=c99, -fPIC, -O2, model.c], workingDir=/tmp/ltsmin7536505591856594542] killed by timeout after 1 SECONDS
java.lang.RuntimeException: Compilation or link of executable timed out.java.util.concurrent.TimeoutException: Subprocess running CommandLine [args=[gcc, -c, -I/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202104292328/bin/include/, -I., -std=c99, -fPIC, -O2, model.c], workingDir=/tmp/ltsmin7536505591856594542] killed by timeout after 1 SECONDS
at fr.lip6.move.gal.application.LTSminRunner$1.run(LTSminRunner.java:79)
at java.base/java.lang.Thread.run(Thread.java:834)
Interrupted random walk after 380714 steps, including 12720 resets, run timeout after 30001 ms. (steps per millisecond=12 ) properties seen :{6=1, 7=1, 30=1, 40=1, 51=1, 52=1, 64=1, 76=1, 77=1, 78=1, 131=1, 132=1, 155=1, 164=1, 165=1, 175=1, 185=1, 186=1, 227=1, 228=1, 251=1, 259=1, 260=1, 261=1, 268=1, 269=1, 277=1, 299=1, 300=1, 316=1, 317=1, 323=1, 330=1, 331=1, 332=1, 352=1, 353=1, 364=1, 365=1, 369=1, 370=1, 374=1, 375=1, 389=1, 390=1, 398=1, 399=1, 400=1, 401=1, 402=1, 404=1, 405=1, 406=1, 414=1, 415=1, 422=1, 423=1, 474=1, 475=1, 482=1, 483=1, 484=1, 492=1, 499=1, 500=1, 502=1, 503=1, 505=1, 506=1, 515=1, 516=1, 527=1, 531=1, 535=1, 536=1, 537=1, 550=1, 551=1, 567=1, 568=1, 569=1, 574=1, 575=1, 581=1, 582=1, 583=1, 596=1, 604=1, 605=1, 628=1, 629=1, 630=1, 637=1, 645=1, 646=1, 654=1, 676=1, 677=1, 700=1, 709=1, 710=1, 720=1, 721=1, 731=1, 732=1, 733=1, 773=1, 774=1, 817=1, 818=1, 830=1, 843=1, 844=1, 856=1, 1248=1, 1249=1, 1250=1, 1252=1, 1253=1, 1254=1, 1256=1, 1257=1, 1258=1, 1259=1, 1260=1, 1262=1, 1264=1, 1265=1, 1266=1, 1268=1, 1269=1, 1270=1, 1278=1, 1279=1, 1280=1, 1294=1, 1296=1, 1298=1, 1300=1, 1303=1, 1306=1, 1311=1, 1312=1, 1313=1, 1314=1, 1315=1, 1316=1, 1317=1, 1318=1, 1326=1, 1334=1, 1335=1, 1336=1, 1337=1, 1338=1, 1339=1, 1340=1, 1341=1, 1342=1, 1343=1, 1344=1, 1345=1, 1362=1, 1363=1, 1364=1, 1365=1, 1366=1, 1367=1, 1368=1, 1369=1, 1370=1, 1371=1, 1379=1, 1387=1, 1388=1, 1389=1, 1390=1, 1391=1, 1392=1, 1395=1, 1396=1, 1402=1, 1407=1, 1413=1, 1415=1, 1423=1, 1425=1, 1432=1, 1433=1, 1434=1, 1435=1, 1437=1, 1438=1, 1439=1, 1441=1, 1442=1, 1443=1, 1445=1, 1446=1, 1447=1, 1448=1, 1449=1, 1450=1, 1451=1, 1453=1, 1455=1}
Incomplete Best-First random walk after 1000 steps, including 6 resets, run finished after 17 ms. (steps per millisecond=58 ) properties (out of 1606) seen :0
Incomplete Best-First random walk after 1000 steps, including 6 resets, run finished after 16 ms. (steps per millisecond=62 ) properties (out of 1606) seen :0
Incomplete Best-First random walk after 1001 steps, including 6 resets, run finished after 16 ms. (steps per millisecond=62 ) properties (out of 1606) seen :0
Incomplete Best-First random walk after 1001 steps, including 6 resets, run finished after 16 ms. (steps per millisecond=62 ) properties (out of 1606) seen :0
Incomplete Best-First random walk after 1001 steps, including 6 resets, run finished after 16 ms. (steps per millisecond=62 ) properties (out of 1606) seen :0
Incomplete Best-First random walk after 1000 steps, including 6 resets, run finished after 17 ms. (steps per millisecond=58 ) properties (out of 1606) seen :0
Incomplete Best-First random walk after 1000 steps, including 6 resets, run finished after 17 ms. (steps per millisecond=58 ) properties (out of 1606) seen :0
Incomplete Best-First random walk after 1001 steps, including 6 resets, run finished after 17 ms. (steps per millisecond=58 ) properties (out of 1606) seen :0
Incomplete Best-First random walk after 1000 steps, including 6 resets, run finished after 17 ms. (steps per millisecond=58 ) properties (out of 1606) seen :0
Incomplete Best-First random walk after 1001 steps, including 6 resets, run finished after 16 ms. (steps per millisecond=62 ) properties (out of 1606) seen :0
Incomplete Best-First random walk after 1000 steps, including 6 resets, run finished after 17 ms. (steps per millisecond=58 ) properties (out of 1606) seen :0
Incomplete Best-First random walk after 1001 steps, including 6 resets, run finished after 16 ms. (steps per millisecond=62 ) properties (out of 1606) seen :0
Incomplete Best-First random walk after 1001 steps, including 6 resets, run finished after 16 ms. (steps per millisecond=62 ) properties (out of 1606) seen :3
Incomplete Best-First random walk after 1001 steps, including 6 resets, run finished after 16 ms. (steps per millisecond=62 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1000 steps, including 5 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 6 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1000 steps, including 5 resets, run finished after 13 ms. (steps per millisecond=76 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1000 steps, including 5 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 6 resets, run finished after 16 ms. (steps per millisecond=62 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 6 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 6 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1000 steps, including 5 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1000 steps, including 5 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1000 steps, including 5 resets, run finished after 12 ms. (steps per millisecond=83 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1000 steps, including 5 resets, run finished after 13 ms. (steps per millisecond=76 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1000 steps, including 5 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1000 steps, including 5 resets, run finished after 13 ms. (steps per millisecond=76 ) properties (out of 1603) seen :0
Incomplete Best-First random walk after 1001 steps, including 5 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1603) seen :0
Running SMT prover for 1603 properties.
[2022-05-17 00:03:40] [INFO ] Flow matrix only has 2209 transitions (discarded 276 similar events)
// Phase 1: matrix 2209 rows 1072 cols
[2022-05-17 00:03:41] [INFO ] Computed 41 place invariants in 35 ms
[2022-05-17 00:04:07] [INFO ] [Real]Absence check using 31 positive place invariants in 37 ms returned sat
[2022-05-17 00:04:07] [INFO ] [Real]Absence check using 31 positive and 10 generalized place invariants in 2 ms returned sat
[2022-05-17 00:04:34] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2022-05-17 00:06:08] [INFO ] [Real]Absence check using state equation in 93388 ms returned unsat :0 sat :1016 real:587
[2022-05-17 00:06:08] [INFO ] State equation strengthened by 841 read => feed constraints.
[2022-05-17 00:06:08] [INFO ] [Real]Added 841 Read/Feed constraints in 80 ms returned sat
Attempting to minimize the solution found.
Minimization took 4 ms.
[2022-05-17 00:07:26] [INFO ] SMT Verify possible in real domain returnedunsat :0 sat :95 real:1508
[2022-05-17 00:07:52] [INFO ] [Nat]Absence check using 31 positive place invariants in 43 ms returned sat
[2022-05-17 00:07:52] [INFO ] [Nat]Absence check using 31 positive and 10 generalized place invariants in 8 ms returned sat
[2022-05-17 00:08:17] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2022-05-17 00:09:47] [INFO ] [Nat]Absence check using state equation in 90018 ms returned unsat :0 sat :1603
[2022-05-17 00:09:48] [INFO ] [Nat]Added 841 Read/Feed constraints in 70 ms returned sat
Attempting to minimize the solution found.
Minimization took 1 ms.
[2022-05-17 00:11:11] [INFO ] SMT Verify possible in nat domain returned unsat :840 sat :763
FORMULA QuasiLiveness FALSE TECHNIQUES RANDOM_WALK STRUCTURAL_REDUCTION BESTFIRST_WALK TOPOLOGICAL INITIAL_STATE SAT_SMT

BK_STOP 1652746271978

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

+ export BINDIR=/home/mcc/BenchKit/bin//../
+ BINDIR=/home/mcc/BenchKit/bin//../
++ pwd
+ export MODEL=/home/mcc/execution
+ MODEL=/home/mcc/execution
+ [[ QuasiLiveness = StateSpace ]]
+ /home/mcc/BenchKit/bin//..//runeclipse.sh /home/mcc/execution QuasiLiveness -its -ltsmin -greatspnpath /home/mcc/BenchKit/bin//..//greatspn/ -order META -manyOrder -smt -timeout 1800
+ 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 QuasiLiveness -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 1800 -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="MultiCrashLeafsetExtension-PT-S16C04"
export BK_EXAMINATION="QuasiLiveness"
export BK_TOOL="gold2021"
export BK_RESULT_DIR="/tmp/BK_RESULTS/OUTPUTS"
export BK_TIME_CONFINEMENT="1800"
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 gold2021"
echo " Input is MultiCrashLeafsetExtension-PT-S16C04, examination is QuasiLiveness"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 4"
echo " Run identifier is r144-tall-165271831200417"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

tar xzf /home/mcc/BenchKit/INPUTS/MultiCrashLeafsetExtension-PT-S16C04.tgz
mv MultiCrashLeafsetExtension-PT-S16C04 execution
cd execution
if [ "QuasiLiveness" = "ReachabilityDeadlock" ] || [ "QuasiLiveness" = "UpperBounds" ] || [ "QuasiLiveness" = "QuasiLiveness" ] || [ "QuasiLiveness" = "StableMarking" ] || [ "QuasiLiveness" = "Liveness" ] || [ "QuasiLiveness" = "OneSafe" ] || [ "QuasiLiveness" = "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 [ "QuasiLiveness" = "UpperBounds" ] ; then
echo "The expected result is a vector of positive values"
echo NUM_VECTOR
elif [ "QuasiLiveness" != "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 "QuasiLiveness.txt" ] ; then
echo "here is the order used to build the result vector(from text file)"
for x in $(grep Property QuasiLiveness.txt | cut -d ' ' -f 2 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ -f "QuasiLiveness.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 '' QuasiLiveness.xml | cut -d '>' -f 2 | cut -d '<' -f 1 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ "QuasiLiveness" = "ReachabilityDeadlock" ] || [ "QuasiLiveness" = "QuasiLiveness" ] || [ "QuasiLiveness" = "StableMarking" ] || [ "QuasiLiveness" = "Liveness" ] || [ "QuasiLiveness" = "OneSafe" ] ; then
echo "FORMULA_NAME QuasiLiveness"
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 ;