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-165271831200427.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-S16C06, examination is QuasiLiveness
Time confinement is 1800 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r144-tall-165271831200427
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 5.4M
-rw-r--r-- 1 mcc users 12K Apr 29 16:37 CTLCardinality.txt
-rw-r--r-- 1 mcc users 76K Apr 29 16:37 CTLCardinality.xml
-rw-r--r-- 1 mcc users 11K Apr 29 16:35 CTLFireability.txt
-rw-r--r-- 1 mcc users 63K Apr 29 16:35 CTLFireability.xml
-rw-r--r-- 1 mcc users 6.4K May 9 08:15 LTLCardinality.txt
-rw-r--r-- 1 mcc users 26K May 9 08:15 LTLCardinality.xml
-rw-r--r-- 1 mcc users 4.4K May 9 08:15 LTLFireability.txt
-rw-r--r-- 1 mcc users 19K May 9 08:15 LTLFireability.xml
-rw-r--r-- 1 mcc users 2.5K May 9 08:15 UpperBounds.txt
-rw-r--r-- 1 mcc users 4.5K May 9 08:15 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 5.2M 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 1652745880109

Running Version 0
[2022-05-17 00:04:41] [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:04:41] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2022-05-17 00:04:41] [INFO ] Load time of PNML (sax parser for PT used): 279 ms
[2022-05-17 00:04:41] [INFO ] Transformed 5568 places.
[2022-05-17 00:04:42] [INFO ] Transformed 7799 transitions.
[2022-05-17 00:04:42] [INFO ] Parsed PT model containing 5568 places and 7799 transitions in 380 ms.
Starting structural reductions, iteration 0 : 5568/5568 places, 7799/7799 transitions.
Reduce places removed 32 places and 0 transitions.
Drop transitions removed 1632 transitions
Trivial Post-agglo rules discarded 1632 transitions
Performed 1632 trivial Post agglomeration. Transition count delta: 1632
Iterating post reduction 0 with 1664 rules applied. Total rules applied 1664 place count 5536 transition count 6167
Reduce places removed 1632 places and 0 transitions.
Iterating post reduction 1 with 1632 rules applied. Total rules applied 3296 place count 3904 transition count 6167
Performed 204 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 2 with 204 Pre rules applied. Total rules applied 3296 place count 3904 transition count 5963
Deduced a syphon composed of 204 places in 23 ms
Reduce places removed 204 places and 0 transitions.
Iterating global reduction 2 with 408 rules applied. Total rules applied 3704 place count 3700 transition count 5963
Discarding 1428 places :
Symmetric choice reduction at 2 with 1428 rule applications. Total rules 5132 place count 2272 transition count 4535
Iterating global reduction 2 with 1428 rules applied. Total rules applied 6560 place count 2272 transition count 4535
Performed 12 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 2 with 12 Pre rules applied. Total rules applied 6560 place count 2272 transition count 4523
Deduced a syphon composed of 12 places in 7 ms
Reduce places removed 12 places and 0 transitions.
Iterating global reduction 2 with 24 rules applied. Total rules applied 6584 place count 2260 transition count 4523
Discarding 238 places :
Symmetric choice reduction at 2 with 238 rule applications. Total rules 6822 place count 2022 transition count 3095
Iterating global reduction 2 with 238 rules applied. Total rules applied 7060 place count 2022 transition count 3095
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 7094 place count 2005 transition count 3078
Applied a total of 7094 rules in 1702 ms. Remains 2005 /5568 variables (removed 3563) and now considering 3078/7799 (removed 4721) transitions.
[2022-05-17 00:04:43] [INFO ] Flow matrix only has 2806 transitions (discarded 272 similar events)
// Phase 1: matrix 2806 rows 2005 cols
[2022-05-17 00:04:43] [INFO ] Computed 541 place invariants in 189 ms
[2022-05-17 00:04:46] [INFO ] Implicit Places using invariants in 2946 ms returned [4, 7, 11, 12, 13, 14, 15, 16, 17, 22, 29, 38, 49, 62, 77, 93, 109, 110, 111, 112, 113, 114, 115, 128, 139, 148, 155, 160, 163, 178, 184, 187, 188, 189, 190, 191, 192, 193, 196, 201, 208, 217, 228, 241, 255, 269, 270, 271, 272, 273, 274, 275, 286, 295, 302, 307, 310, 312, 327, 333, 336, 337, 338, 339, 340, 341, 342, 344, 347, 352, 359, 368, 379, 391, 403, 404, 405, 406, 407, 408, 409, 418, 425, 430, 433, 435, 437, 452, 458, 461, 462, 463, 464, 465, 466, 467, 469, 471, 474, 479, 486, 495, 505, 515, 516, 517, 518, 519, 520, 521, 528, 533, 536, 538, 540, 542, 557, 563, 566, 567, 568, 569, 570, 571, 572, 574, 576, 578, 581, 586, 593, 601, 609, 610, 611, 612, 613, 614, 615, 620, 623, 625, 627, 629, 631, 646, 652, 655, 656, 657, 658, 659, 660, 661, 663, 665, 667, 669, 672, 677, 683, 689, 690, 691, 692, 693, 694, 695, 698, 700, 702, 704, 706, 708, 723, 729, 732, 733, 734, 735, 736, 737, 738, 740, 742, 744, 746, 748, 751, 755, 759, 760, 761, 762, 763, 764, 765, 767, 769, 771, 773, 775, 777, 792, 798, 801, 802, 803, 804, 805, 806, 807, 809, 811, 813, 815, 817, 819, 821, 824, 825, 826, 827, 828, 829, 830, 832, 834, 836, 838, 840, 842, 857, 859, 862, 865, 866, 867, 868, 869, 870, 871, 873, 875, 877, 879, 881, 883, 885, 888, 889, 890, 891, 892, 893, 894, 896, 898, 900, 902, 904, 906, 921, 927, 930, 931, 932, 933, 934, 935, 936, 938, 940, 942, 944, 946, 948, 950, 953, 954, 955, 956, 957, 958, 959, 961, 963, 965, 967, 969, 971, 986, 992, 995, 996, 997, 998, 999, 1000, 1001, 1003, 1005, 1007, 1009, 1011, 1013, 1016, 1021, 1022, 1023, 1024, 1025, 1026, 1027, 1030, 1032, 1034, 1036, 1038, 1040, 1055, 1061, 1064, 1065, 1066, 1067, 1068, 1069, 1070, 1072, 1074, 1076, 1078, 1080, 1083, 1088, 1095, 1096, 1097, 1098, 1099, 1100, 1101, 1106, 1109, 1111, 1113, 1115, 1117, 1132, 1138, 1141, 1142, 1143, 1144, 1145, 1146, 1147, 1149, 1151, 1153, 1155, 1158, 1163, 1170, 1179, 1180, 1181, 1182, 1183, 1184, 1185, 1192, 1197, 1200, 1202, 1204, 1206, 1221, 1227, 1230, 1231, 1232, 1233, 1234, 1235, 1236, 1238, 1240, 1242, 1245, 1250, 1257, 1266, 1277, 1278, 1279, 1280, 1281, 1282, 1283, 1292, 1299, 1304, 1307, 1309, 1311, 1326, 1332, 1335, 1336, 1337, 1338, 1339, 1340, 1341, 1343, 1345, 1348, 1353, 1360, 1369, 1380, 1393, 1394, 1395, 1396, 1397, 1398, 1399, 1410, 1419, 1426, 1431, 1434, 1436, 1451, 1457, 1460, 1461, 1462, 1463, 1464, 1465, 1466, 1468, 1471, 1476, 1483, 1492, 1503, 1516, 1531, 1532, 1533, 1534, 1535, 1536, 1537, 1550, 1561, 1570, 1577, 1582, 1585, 1600, 1602, 1605, 1608, 1609, 1610, 1611, 1612, 1613, 1614, 1617, 1622, 1629, 1638, 1649, 1662, 1677, 1694, 1695, 1696, 1697, 1698, 1699, 1700, 1715, 1728, 1739, 1748, 1755, 1760, 1776]
Discarding 496 places :
Implicit Place search using SMT only with invariants took 2980 ms to find 496 implicit places.
[2022-05-17 00:04:46] [INFO ] Flow matrix only has 2806 transitions (discarded 272 similar events)
// Phase 1: matrix 2806 rows 1509 cols
[2022-05-17 00:04:46] [INFO ] Computed 45 place invariants in 36 ms
[2022-05-17 00:04:48] [INFO ] Dead Transitions using invariants and state equation in 1285 ms returned []
Starting structural reductions, iteration 1 : 1509/5568 places, 3078/7799 transitions.
Discarding 192 places :
Symmetric choice reduction at 0 with 192 rule applications. Total rules 192 place count 1317 transition count 2886
Iterating global reduction 0 with 192 rules applied. Total rules applied 384 place count 1317 transition count 2886
Discarding 192 places :
Symmetric choice reduction at 0 with 192 rule applications. Total rules 576 place count 1125 transition count 2694
Iterating global reduction 0 with 192 rules applied. Total rules applied 768 place count 1125 transition count 2694
Discarding 32 places :
Symmetric choice reduction at 0 with 32 rule applications. Total rules 800 place count 1093 transition count 2502
Iterating global reduction 0 with 32 rules applied. Total rules applied 832 place count 1093 transition count 2502
Applied a total of 832 rules in 206 ms. Remains 1093 /1509 variables (removed 416) and now considering 2502/3078 (removed 576) transitions.
[2022-05-17 00:04:48] [INFO ] Flow matrix only has 2230 transitions (discarded 272 similar events)
// Phase 1: matrix 2230 rows 1093 cols
[2022-05-17 00:04:48] [INFO ] Computed 45 place invariants in 29 ms
[2022-05-17 00:04:49] [INFO ] Implicit Places using invariants in 879 ms returned []
[2022-05-17 00:04:49] [INFO ] Flow matrix only has 2230 transitions (discarded 272 similar events)
// Phase 1: matrix 2230 rows 1093 cols
[2022-05-17 00:04:49] [INFO ] Computed 45 place invariants in 19 ms
[2022-05-17 00:04:49] [INFO ] State equation strengthened by 845 read => feed constraints.
[2022-05-17 00:04:49] [INFO ] Implicit Places using invariants and state equation in 893 ms returned []
Implicit Place search using SMT with State Equation took 1775 ms to find 0 implicit places.
Finished structural reductions, in 2 iterations. Remains : 1093/5568 places, 2502/7799 transitions.
[2022-05-17 00:04:50] [INFO ] Initial state test concluded for 17 properties.
Incomplete random walk after 10000 steps, including 227 resets, run finished after 1097 ms. (steps per millisecond=9 ) properties (out of 2485) seen :717
Running SMT prover for 1768 properties.
[2022-05-17 00:04:51] [INFO ] Flow matrix only has 2230 transitions (discarded 272 similar events)
// Phase 1: matrix 2230 rows 1093 cols
[2022-05-17 00:04:51] [INFO ] Computed 45 place invariants in 25 ms
[2022-05-17 00:05:16] [WARNING] SMT solver failed with error :SMT solver raised an error when submitting script.... while checking expressions.
Fused 1768 Parikh solutions to 1 different solutions.
Support contains 983 out of 1093 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 1093/1093 places, 2502/2502 transitions.
Free-agglomeration rule (complex) applied 9 times.
Iterating global reduction 0 with 9 rules applied. Total rules applied 9 place count 1093 transition count 2493
Reduce places removed 9 places and 0 transitions.
Iterating post reduction 0 with 9 rules applied. Total rules applied 18 place count 1084 transition count 2493
Applied a total of 18 rules in 167 ms. Remains 1084 /1093 variables (removed 9) and now considering 2493/2502 (removed 9) transitions.
Finished structural reductions, in 1 iterations. Remains : 1084/1093 places, 2493/2502 transitions.
[2022-05-17 00:05:16] [INFO ] Flatten gal took : 225 ms
[2022-05-17 00:05:17] [INFO ] Flatten gal took : 150 ms
[2022-05-17 00:05:17] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality1505725679228880944.gal : 40 ms
[2022-05-17 00:05:17] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality7513899285035943689.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/ReachabilityCardinality1505725679228880944.gal, -t, CGAL, -reachable-file, /tmp/ReachabilityCardinality7513899285035943689.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/ReachabilityCardinality1505725679228880944.gal -t CGAL -reachable-file /tmp/ReachabilityCardinality7513899285035943689.prop --nowitness --gen-order FOLLOW
Loading property file /tmp/ReachabilityCardinality7513899285035943689.prop.
SDD proceeding with computation,1768 properties remain. new max is 4
SDD size :1 after 6
SDD proceeding with computation,1768 properties remain. new max is 8
SDD size :6 after 11
SDD proceeding with computation,1768 properties remain. new max is 16
SDD size :11 after 27
Detected timeout of ITS tools.
[2022-05-17 00:05:32] [INFO ] Flatten gal took : 102 ms
[2022-05-17 00:05:32] [INFO ] Applying decomposition
[2022-05-17 00:05:32] [INFO ] Flatten gal took : 93 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/graph14106956131961200476.txt, -o, /tmp/graph14106956131961200476.bin, -w, /tmp/graph14106956131961200476.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/graph14106956131961200476.bin, -l, -1, -v, -w, /tmp/graph14106956131961200476.weights, -q, 0, -e, 0.001], workingDir=null]
[2022-05-17 00:05:32] [INFO ] Decomposing Gal with order
[2022-05-17 00:05:32] [INFO ] Rewriting arrays to variables to allow decomposition.
[2022-05-17 00:05:33] [INFO ] Removed a total of 2253 redundant transitions.
[2022-05-17 00:05:33] [INFO ] Flatten gal took : 649 ms
[2022-05-17 00:05:33] [INFO ] Fuse similar labels procedure discarded/fused a total of 1505 labels/synchronizations in 141 ms.
[2022-05-17 00:05:33] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality6584909253300839437.gal : 22 ms
[2022-05-17 00:05:33] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality16213615392750794738.prop : 7 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/ReachabilityCardinality6584909253300839437.gal, -t, CGAL, -reachable-file, /tmp/ReachabilityCardinality16213615392750794738.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/ReachabilityCardinality6584909253300839437.gal -t CGAL -reachable-file /tmp/ReachabilityCardinality16213615392750794738.prop --nowitness
Loading property file /tmp/ReachabilityCardinality16213615392750794738.prop.
SDD proceeding with computation,1768 properties remain. new max is 4
SDD size :1 after 9
SDD proceeding with computation,1768 properties remain. new max is 8
SDD size :9 after 13
SDD proceeding with computation,1768 properties remain. new max is 16
SDD size :13 after 26
SDD proceeding with computation,1768 properties remain. new max is 32
SDD size :26 after 35
Reachability property qltransition_1391 is true.
SDD proceeding with computation,1767 properties remain. new max is 32
SDD size :35 after 40
SDD proceeding with computation,1767 properties remain. new max is 64
SDD size :40 after 42
SDD proceeding with computation,1767 properties remain. new max is 128
SDD size :42 after 46
SDD proceeding with computation,1767 properties remain. new max is 256
SDD size :46 after 52
SDD proceeding with computation,1767 properties remain. new max is 512
SDD size :52 after 60
SDD proceeding with computation,1767 properties remain. new max is 1024
SDD size :60 after 75
SDD proceeding with computation,1767 properties remain. new max is 2048
SDD size :75 after 83
SDD proceeding with computation,1767 properties remain. new max is 4096
SDD size :83 after 149
SDD proceeding with computation,1767 properties remain. new max is 8192
SDD size :149 after 312
SDD proceeding with computation,1767 properties remain. new max is 16384
SDD size :312 after 352
SDD proceeding with computation,1767 properties remain. new max is 32768
SDD size :352 after 601
Detected timeout of ITS tools.
Built C files in :
/tmp/ltsmin2659268165364468043
[2022-05-17 00:05:49] [INFO ] Built C files in 107ms conformant to PINS (ltsmin variant)in folder :/tmp/ltsmin2659268165364468043
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/ltsmin2659268165364468043]
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/ltsmin2659268165364468043] 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/ltsmin2659268165364468043] 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 409826 steps, including 9300 resets, run timeout after 30001 ms. (steps per millisecond=13 ) properties seen :{5=1, 6=1, 7=1, 38=1, 39=1, 49=1, 50=1, 51=1, 62=1, 63=1, 64=1, 65=1, 75=1, 76=1, 129=1, 130=1, 162=1, 163=1, 164=1, 173=1, 174=1, 183=1, 184=1, 193=1, 202=1, 224=1, 225=1, 226=1, 241=1, 248=1, 249=1, 250=1, 251=1, 252=1, 264=1, 265=1, 272=1, 293=1, 294=1, 305=1, 310=1, 311=1, 312=1, 317=1, 323=1, 324=1, 325=1, 326=1, 330=1, 344=1, 345=1, 353=1, 356=1, 357=1, 358=1, 361=1, 365=1, 366=1, 367=1, 368=1, 370=1, 379=1, 380=1, 381=1, 388=1, 389=1, 390=1, 391=1, 392=1, 393=1, 394=1, 395=1, 396=1, 397=1, 398=1, 405=1, 412=1, 413=1, 464=1, 465=1, 472=1, 473=1, 474=1, 481=1, 482=1, 488=1, 489=1, 490=1, 491=1, 492=1, 493=1, 494=1, 501=1, 502=1, 509=1, 510=1, 512=1, 513=1, 516=1, 519=1, 520=1, 521=1, 533=1, 534=1, 535=1, 545=1, 546=1, 550=1, 551=1, 552=1, 557=1, 558=1, 559=1, 564=1, 568=1, 569=1, 570=1, 583=1, 584=1, 599=1, 600=1, 606=1, 607=1, 608=1, 622=1, 623=1, 630=1, 631=1, 651=1, 652=1, 674=1, 675=1, 684=1, 692=1, 693=1, 703=1, 704=1, 713=1, 722=1, 743=1, 744=1, 745=1, 746=1, 788=1, 789=1, 790=1, 791=1, 792=1, 801=1, 802=1, 814=1, 815=1, 816=1, 826=1, 1142=1, 1144=1, 1155=1, 1163=1, 1169=1, 1178=1, 1198=1, 1211=1, 1213=1, 1218=1, 1219=1, 1220=1, 1221=1, 1222=1, 1223=1, 1224=1, 1225=1, 1226=1, 1227=1, 1228=1, 1229=1, 1230=1, 1231=1, 1232=1, 1233=1, 1234=1, 1235=1, 1236=1, 1237=1, 1238=1, 1239=1, 1246=1, 1247=1, 1248=1, 1249=1, 1256=1, 1257=1, 1258=1, 1259=1, 1260=1, 1261=1, 1262=1, 1264=1, 1265=1, 1266=1, 1267=1, 1269=1, 1270=1, 1272=1, 1273=1, 1274=1, 1276=1, 1277=1, 1278=1, 1279=1, 1280=1, 1281=1, 1282=1, 1290=1, 1298=1, 1299=1, 1300=1, 1301=1, 1302=1, 1303=1, 1304=1, 1305=1, 1306=1, 1323=1, 1324=1, 1325=1, 1326=1, 1327=1, 1328=1, 1329=1, 1330=1, 1331=1, 1332=1, 1347=1, 1348=1, 1349=1, 1350=1, 1351=1, 1353=1, 1357=1, 1358=1, 1359=1, 1360=1, 1361=1, 1363=1, 1364=1, 1365=1, 1367=1, 1368=1, 1369=1, 1371=1, 1372=1, 1373=1, 1374=1, 1375=1, 1382=1, 1383=1, 1384=1, 1385=1, 1392=1, 1393=1, 1394=1, 1395=1, 1396=1, 1397=1, 1398=1, 1399=1, 1400=1, 1402=1, 1403=1, 1404=1, 1405=1, 1406=1, 1408=1, 1409=1, 1410=1, 1425=1, 1447=1, 1448=1, 1450=1, 1451=1, 1458=1, 1464=1, 1467=1, 1468=1, 1470=1, 1474=1, 1477=1, 1483=1, 1485=1}
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 16 ms. (steps per millisecond=62 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 16 ms. (steps per millisecond=62 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 16 ms. (steps per millisecond=62 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 16 ms. (steps per millisecond=62 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 16 ms. (steps per millisecond=62 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 16 ms. (steps per millisecond=62 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 16 ms. (steps per millisecond=62 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 3 resets, run finished after 35 ms. (steps per millisecond=28 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 3 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 3 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1000 steps, including 3 resets, run finished after 13 ms. (steps per millisecond=76 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1000 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=76 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1000 steps, including 4 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1000 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=76 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 3 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1000 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=76 ) properties (out of 1478) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1478) seen :2
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1000 steps, including 3 resets, run finished after 13 ms. (steps per millisecond=76 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1000 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=76 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1000 steps, including 4 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1000 steps, including 3 resets, run finished after 13 ms. (steps per millisecond=76 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 1476) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 1476) seen :0
Running SMT prover for 1476 properties.
[2022-05-17 00:06:21] [INFO ] Flow matrix only has 2213 transitions (discarded 280 similar events)
// Phase 1: matrix 2213 rows 1084 cols
[2022-05-17 00:06:21] [INFO ] Computed 45 place invariants in 33 ms
[2022-05-17 00:06:47] [INFO ] [Real]Absence check using 31 positive place invariants in 33 ms returned sat
[2022-05-17 00:06:47] [INFO ] [Real]Absence check using 31 positive and 14 generalized place invariants in 5 ms returned sat
[2022-05-17 00:07:13] [INFO ] SMT Verify possible in real domain returnedunsat :0 sat :0 real:1476
[2022-05-17 00:07:38] [INFO ] [Nat]Absence check using 31 positive place invariants in 31 ms returned sat
[2022-05-17 00:07:38] [INFO ] [Nat]Absence check using 31 positive and 14 generalized place invariants in 3 ms returned sat
[2022-05-17 00:08:02] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2022-05-17 00:09:24] [INFO ] [Nat]Absence check using state equation in 82400 ms returned unsat :0 sat :1476
[2022-05-17 00:09:24] [INFO ] State equation strengthened by 845 read => feed constraints.
[2022-05-17 00:09:24] [INFO ] [Nat]Added 845 Read/Feed constraints in 79 ms returned sat
Attempting to minimize the solution found.
Minimization took 2 ms.
[2022-05-17 00:10:58] [INFO ] SMT Verify possible in nat domain returned unsat :364 sat :1111
FORMULA QuasiLiveness FALSE TECHNIQUES RANDOM_WALK STRUCTURAL_REDUCTION DECISION_DIAGRAMS COLLATERAL_PROCESSING BESTFIRST_WALK TOPOLOGICAL INITIAL_STATE USE_NUPN SAT_SMT

BK_STOP 1652746260132

--------------------
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-S16C06"
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-S16C06, 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-165271831200427"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

tar xzf /home/mcc/BenchKit/INPUTS/MultiCrashLeafsetExtension-PT-S16C06.tgz
mv MultiCrashLeafsetExtension-PT-S16C06 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 ;