Execution Chart

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

Trace from the execution

Formatting '/data/fkordon/mcc2021-input.r071-tall-162039089200462.qcow2', fmt=qcow2 size=4294967296 backing_file='/data/fkordon/mcc2021-input.qcow2' encryption=off cluster_size=65536 lazy_refcounts=off
Waiting for the VM to be ready (probing ssh)
..................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................
=====================================================================
Generated by BenchKit 2-4028
Executing tool itstools
Input is DatabaseWithMutex-PT-20, examination is QuasiLiveness
Time confinement is 1800 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r071-tall-162039089200462
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 32M
-rw-r--r-- 1 mcc users 2.4M May 5 16:58 CTLCardinality.txt
-rw-r--r-- 1 mcc users 10M May 5 16:58 CTLCardinality.xml
-rw-r--r-- 1 mcc users 2.1M May 5 16:58 CTLFireability.txt
-rw-r--r-- 1 mcc users 10M May 5 16:58 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.2K May 6 14:48 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 205K Mar 28 16:01 LTLCardinality.txt
-rw-r--r-- 1 mcc users 650K Mar 28 16:01 LTLCardinality.xml
-rw-r--r-- 1 mcc users 188K Mar 28 16:01 LTLFireability.txt
-rw-r--r-- 1 mcc users 691K Mar 28 16:01 LTLFireability.xml
-rw-r--r-- 1 mcc users 170K Mar 23 10:06 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 493K Mar 23 10:06 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 108K Mar 22 17:41 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 375K Mar 22 17:41 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 32K Mar 22 09:10 UpperBounds.txt
-rw-r--r-- 1 mcc users 67K Mar 22 09:10 UpperBounds.xml
-rw-r--r-- 1 mcc users 5 May 5 16:51 equiv_col
-rw-r--r-- 1 mcc users 3 May 5 16:51 instance
-rw-r--r-- 1 mcc users 6 May 5 16:51 iscolored
-rw-r--r-- 1 mcc users 4.1M 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

FORMULA_NAME QuasiLiveness

=== Now, execution of the tool begins

BK_START 1620481489261

Running Version 0
[2021-05-08 13:44:50] [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]
[2021-05-08 13:44:50] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2021-05-08 13:44:50] [INFO ] Load time of PNML (sax parser for PT used): 254 ms
[2021-05-08 13:44:50] [INFO ] Transformed 3260 places.
[2021-05-08 13:44:50] [INFO ] Transformed 3200 transitions.
[2021-05-08 13:44:50] [INFO ] Found NUPN structural information;
[2021-05-08 13:44:51] [INFO ] Parsed PT model containing 3260 places and 3200 transitions in 325 ms.
Starting structural reductions, iteration 0 : 3260/3260 places, 3200/3200 transitions.
Drop transitions removed 800 transitions
Trivial Post-agglo rules discarded 800 transitions
Performed 800 trivial Post agglomeration. Transition count delta: 800
Iterating post reduction 0 with 800 rules applied. Total rules applied 800 place count 3260 transition count 2400
Reduce places removed 820 places and 0 transitions.
Drop transitions removed 800 transitions
Trivial Post-agglo rules discarded 800 transitions
Performed 800 trivial Post agglomeration. Transition count delta: 800
Iterating post reduction 1 with 1620 rules applied. Total rules applied 2420 place count 2440 transition count 1600
Reduce places removed 800 places and 0 transitions.
Iterating post reduction 2 with 800 rules applied. Total rules applied 3220 place count 1640 transition count 1600
Performed 400 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 3 with 400 Pre rules applied. Total rules applied 3220 place count 1640 transition count 1200
Renaming transitions due to excessive name length > 1024 char.
Deduced a syphon composed of 400 places in 4 ms
Reduce places removed 400 places and 0 transitions.
Iterating global reduction 3 with 800 rules applied. Total rules applied 4020 place count 1240 transition count 1200
Applied a total of 4020 rules in 697 ms. Remains 1240 /3260 variables (removed 2020) and now considering 1200/3200 (removed 2000) transitions.
// Phase 1: matrix 1200 rows 1240 cols
[2021-05-08 13:44:51] [INFO ] Computed 440 place invariants in 114 ms
[2021-05-08 13:45:15] [INFO ] Implicit Places using invariants in 23562 ms returned [1, 2, 3, 4, 5, 6, 8, 10, 11, 12, 15, 19, 20, 21, 22, 23, 26, 27, 30, 33, 34, 35, 36, 37, 39, 41, 42, 44, 46, 47, 49, 53, 54, 55, 57, 58, 60, 61, 62, 63, 65, 67, 68, 69, 71, 72, 74, 75, 78, 79, 80, 81, 83, 84, 85, 86, 90, 91, 95, 97, 98, 99, 100, 101, 102, 103, 104, 105, 106, 107, 108, 111, 112, 113, 115, 116, 117, 119, 120, 122, 124, 125, 126, 128, 133, 135, 137, 139, 141, 142, 146, 147, 148, 149, 150, 153, 154, 156, 157, 158, 160, 161, 162, 163, 165, 166, 168, 174, 175, 176, 177, 179, 183, 185, 187, 188, 189, 190, 191, 192, 195, 196, 197, 198, 199, 200, 201, 202, 203, 204, 205, 209, 210, 211, 214, 215, 217, 218, 219, 220, 221, 222, 223, 224, 225, 226, 227, 228, 229, 232, 234, 235, 237, 241, 242, 243, 245, 247, 248, 249, 250, 252, 257, 258, 259, 261, 262, 264, 265, 267, 268, 269, 272, 273, 275, 276, 277, 278, 279, 280, 281, 282, 283, 284, 286, 287, 288, 289, 290, 291, 292, 293, 294, 295, 296, 297, 298, 300, 308, 310, 311, 312, 314, 315, 317, 318, 320, 322, 323, 324, 326, 327, 330, 331, 333, 335, 337, 338, 341, 342, 345, 346, 347, 348, 349, 350, 351, 353, 355, 356, 358, 359, 360, 361, 363, 364, 366, 367, 369, 372, 373, 376, 377, 378, 382, 385, 386, 387, 388, 389, 392, 393, 394, 395, 396, 402, 406, 408, 409, 410, 411, 414, 416, 417, 418, 419, 421, 423, 424, 425, 426, 427, 428, 429, 430, 432, 433, 434, 435, 436, 437, 438, 439, 441, 443, 444, 445, 446, 447, 448, 451, 452, 453, 455, 456, 458, 459, 460, 461, 463, 464, 465, 471, 472, 474, 475, 476, 479, 480, 481, 482, 485, 487, 488, 489, 491, 493, 494, 495, 496, 497, 498, 500, 502, 503, 504, 505, 506, 507, 508, 509, 510, 511, 512, 514, 515, 517, 519, 520, 521, 523, 524, 525, 526, 527, 528, 530, 531, 533, 534, 535, 536, 538, 539, 540, 541, 542, 543, 544, 546, 547, 548, 549, 551, 552, 554, 556, 558, 560, 561, 563, 564, 566, 567, 568, 569, 570, 572, 574, 576, 578, 580, 581, 584, 585, 588, 590, 591, 593, 594, 596, 597, 599, 601, 603, 604, 605, 606, 609, 610, 611, 612, 614, 615, 617, 619, 621, 624, 626, 629, 631, 634, 635, 636, 637, 639, 641, 642, 643, 644, 645, 647, 648, 649, 650, 651, 652, 653, 655, 658, 660, 662, 663, 666, 668, 669, 670, 671, 673, 675, 676, 677, 680, 681, 682, 685, 686, 687, 688, 691, 692, 693, 694, 695, 697, 698, 699, 700, 701, 702, 703, 704, 705, 708, 709, 711, 712, 714, 715, 716, 717, 718, 719, 720, 724, 726, 727, 728, 729, 731, 732, 733, 734, 735, 736, 737, 742, 744, 747, 748, 749, 750, 751, 752, 753, 754, 755, 758, 759, 760, 761, 764, 765, 766, 767, 768, 769, 770, 772, 773, 774, 775, 776, 777, 779, 781, 784, 785, 787, 788, 790, 793, 794, 795, 796, 799, 801, 802, 803, 804, 806, 807, 808, 811, 812, 813, 814, 815, 816, 819, 820, 821, 822, 823, 824, 825, 826, 828, 833, 834, 836, 838, 839, 841, 843, 845, 846, 849, 851, 852, 853, 854, 859, 860, 861, 862, 865, 867, 868, 871, 872, 873, 876, 878, 880, 882, 883, 885, 886, 889, 890, 891, 894, 896, 900, 901, 902, 903, 904, 908, 910, 911, 912, 913, 914, 915, 916, 917, 920, 921, 922, 923, 924, 925, 927, 928, 932, 933, 935, 936, 937, 938, 939, 940, 942, 944, 945, 946, 947, 952, 953, 955, 956, 957, 959, 960, 963, 965, 966, 967, 971, 972, 973, 975, 976, 977, 978, 980, 981, 984, 985, 986, 987, 988, 992, 993, 994, 996, 998, 999, 1000, 1002, 1003, 1005, 1008, 1009, 1011, 1013, 1015, 1016, 1019, 1021, 1023, 1025, 1027, 1028, 1029, 1031, 1032, 1033, 1034, 1036, 1037, 1038, 1040, 1041, 1042, 1044, 1045, 1046, 1049, 1050, 1052, 1053, 1055, 1057, 1058, 1059, 1060, 1061, 1062, 1063, 1064, 1065, 1067, 1069, 1071, 1072, 1073, 1076, 1077, 1080, 1082, 1083, 1084, 1085, 1089, 1090, 1091, 1092, 1094, 1096, 1098, 1099, 1101, 1104, 1106, 1108, 1109, 1111, 1112, 1113, 1116, 1117, 1118, 1120, 1121, 1122, 1123, 1124, 1127, 1128, 1129, 1130, 1132, 1134, 1135, 1136, 1137, 1138, 1139, 1140, 1141, 1143, 1145, 1148, 1149, 1152, 1153, 1154, 1155, 1156, 1157, 1158, 1160, 1161, 1163, 1164, 1165, 1166, 1167, 1169, 1173, 1177, 1178, 1183, 1184, 1185, 1186, 1187, 1188, 1191, 1192, 1193, 1195, 1198, 1200, 1203, 1205, 1206, 1208, 1211, 1213, 1214, 1216, 1219, 1220, 1221, 1224, 1225, 1228, 1232, 1233, 1235, 1236, 1237, 1239]
[2021-05-08 13:45:15] [INFO ] Actually due to overlaps returned [2, 3, 4, 10, 21, 26, 27, 30, 33, 34, 36, 37, 42, 49, 53, 54, 57, 58, 63, 67, 69, 71, 72, 74, 75, 85, 86, 90, 95, 98, 99, 100, 102, 105, 106, 107, 111, 112, 113, 120, 122, 125, 128, 135, 137, 142, 147, 149, 150, 153, 154, 156, 157, 162, 163, 165, 166, 174, 177, 179, 183, 188, 189, 190, 191, 195, 196, 199, 201, 204, 209, 210, 211, 218, 221, 223, 228, 229, 234, 237, 241, 242, 243, 249, 257, 262, 265, 267, 268, 275, 277, 279, 280, 282, 283, 286, 287, 289, 290, 295, 300, 308, 311, 314, 320, 327, 330, 335, 337, 345, 346, 347, 348, 350, 351, 353, 359, 361, 364, 367, 382, 386, 388, 392, 393, 394, 395, 396, 408, 409, 410, 416, 418, 419, 421, 423, 424, 428, 429, 430, 432, 434, 435, 439, 444, 445, 447, 453, 460, 461, 464, 471, 472, 475, 476, 482, 485, 487, 493, 494, 496, 497, 498, 505, 510, 511, 512, 515, 519, 520, 533, 538, 539, 542, 544, 546, 548, 551, 552, 554, 563, 566, 568, 570, 572, 576, 581, 584, 588, 593, 601, 605, 606, 609, 610, 611, 612, 617, 624, 631, 634, 639, 641, 645, 647, 648, 651, 655, 662, 663, 666, 669, 670, 671, 680, 681, 682, 688, 691, 694, 695, 697, 702, 705, 708, 709, 712, 715, 716, 717, 718, 719, 724, 727, 731, 736, 737, 742, 747, 752, 754, 760, 764, 766, 767, 768, 769, 770, 773, 776, 777, 781, 785, 787, 799, 801, 802, 803, 804, 806, 811, 812, 816, 820, 821, 822, 823, 824, 828, 834, 841, 845, 846, 852, 854, 859, 862, 867, 876, 878, 883, 886, 889, 890, 891, 894, 902, 903, 904, 911, 917, 920, 922, 923, 924, 927, 928, 932, 933, 938, 940, 942, 944, 945, 952, 953, 955, 956, 959, 963, 965, 967, 971, 973, 976, 977, 980, 984, 986, 988, 996, 998, 999, 1000, 1009, 1019, 1021, 1025, 1028, 1032, 1033, 1041, 1042, 1044, 1046, 1050, 1052, 1053, 1057, 1059, 1060, 1062, 1063, 1069, 1076, 1080, 1082, 1083, 1084, 1091, 1096, 1099, 1101, 1104, 1109, 1112, 1113, 1117, 1122, 1124, 1127, 1129, 1132, 1134, 1136, 1138, 1139, 1143, 1145, 1152, 1153, 1154, 1158, 1160, 1161, 1163, 1165, 1167, 1177, 1183, 1185, 1187, 1188, 1192, 1193, 1195, 1200, 1205, 1206, 1208, 1211, 1213, 1221, 1225, 1233, 1237, 1239, 1, 5, 35, 46, 62, 65, 175, 185, 203, 224, 225, 232, 278, 297, 318, 326, 358, 363, 377, 378, 389, 406, 463, 465, 528, 547, 558, 569, 597, 599, 603, 700, 701, 704, 711, 733, 734, 753, 871, 873, 882, 908, 912, 939, 972, 985, 1029, 1036, 1038, 1049, 1055, 1067, 1092, 1118, 1140, 1191, 1236]
Discarding 454 places :
Implicit Place search using SMT only with invariants took 23627 ms to find 454 implicit places.
// Phase 1: matrix 1200 rows 786 cols
[2021-05-08 13:45:15] [INFO ] Computed 21 place invariants in 25 ms
[2021-05-08 13:45:15] [INFO ] Dead Transitions using invariants and state equation in 554 ms returned []
Starting structural reductions, iteration 1 : 786/3260 places, 1200/3200 transitions.
Drop transitions removed 343 transitions
Trivial Post-agglo rules discarded 343 transitions
Performed 343 trivial Post agglomeration. Transition count delta: 343
Iterating post reduction 0 with 343 rules applied. Total rules applied 343 place count 786 transition count 857
Reduce places removed 360 places and 0 transitions.
Graph (trivial) has 740 edges and 426 vertex of which 360 / 426 are part of one of the 20 SCC in 9 ms
Free SCC test removed 340 places
Iterating post reduction 1 with 361 rules applied. Total rules applied 704 place count 86 transition count 857
Ensure Unique test removed 660 transitions
Reduce isomorphic transitions removed 660 transitions.
Iterating post reduction 2 with 660 rules applied. Total rules applied 1364 place count 86 transition count 197
Discarding 51 places :
Symmetric choice reduction at 3 with 51 rule applications. Total rules 1415 place count 35 transition count 146
Iterating global reduction 3 with 51 rules applied. Total rules applied 1466 place count 35 transition count 146
Applied a total of 1466 rules in 45 ms. Remains 35 /786 variables (removed 751) and now considering 146/1200 (removed 1054) transitions.
[2021-05-08 13:45:15] [INFO ] Flow matrix only has 127 transitions (discarded 19 similar events)
// Phase 1: matrix 127 rows 35 cols
[2021-05-08 13:45:15] [INFO ] Computed 4 place invariants in 1 ms
[2021-05-08 13:45:15] [INFO ] Implicit Places using invariants in 15 ms returned []
[2021-05-08 13:45:15] [INFO ] Flow matrix only has 127 transitions (discarded 19 similar events)
// Phase 1: matrix 127 rows 35 cols
[2021-05-08 13:45:15] [INFO ] Computed 4 place invariants in 1 ms
[2021-05-08 13:45:16] [INFO ] Implicit Places using invariants and state equation in 33 ms returned []
Implicit Place search using SMT with State Equation took 49 ms to find 0 implicit places.
Finished structural reductions, in 2 iterations. Remains : 35/3260 places, 146/3200 transitions.
Discarding 114 transitions out of 146. Remains 32
[2021-05-08 13:45:16] [INFO ] Initial state test concluded for 20 properties.
Finished random walk after 440 steps, including 0 resets, run visited all 12 properties in 9 ms. (steps per millisecond=48 )
Able to resolve query QuasiLiveness after proving 32 properties.
FORMULA QuasiLiveness TRUE TECHNIQUES RANDOM_WALK TOPOLOGICAL INITIAL_STATE

BK_STOP 1620481516981

--------------------
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="DatabaseWithMutex-PT-20"
export BK_EXAMINATION="QuasiLiveness"
export BK_TOOL="itstools"
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 itstools"
echo " Input is DatabaseWithMutex-PT-20, 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 r071-tall-162039089200462"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

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