Execution Chart

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

Trace from the execution

Formatting '/mnt/tpsp/fkordon/mcc2020-input.r176-tajo-158987871700302.qcow2', fmt=qcow2 size=4294967296 backing_file='/mnt/tpsp/fkordon/mcc2020-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 itslola
Input is PolyORBLF-COL-S02J06T08, examination is ReachabilityCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r176-tajo-158987871700302
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 336K
-rw-r--r-- 1 mcc users 4.4K Apr 12 05:40 CTLCardinality.txt
-rw-r--r-- 1 mcc users 22K Apr 12 05:40 CTLCardinality.xml
-rw-r--r-- 1 mcc users 2.9K Apr 11 04:57 CTLFireability.txt
-rw-r--r-- 1 mcc users 18K Apr 11 04:57 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.0K Mar 24 05:37 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 5.9K Mar 24 05:37 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 4.0K Apr 14 12:45 LTLCardinality.txt
-rw-r--r-- 1 mcc users 25K Apr 28 14:02 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.2K Apr 14 12:45 LTLFireability.txt
-rw-r--r-- 1 mcc users 15K Apr 28 14:02 LTLFireability.xml
-rw-r--r-- 1 mcc users 3.7K Apr 10 12:37 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 16K Apr 10 12:37 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 3.0K Apr 9 17:48 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 16K Apr 9 17:47 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.8K Apr 10 22:22 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.9K Apr 10 22:22 UpperBounds.xml
-rw-r--r-- 1 mcc users 5 Mar 24 05:37 equiv_pt
-rw-r--r-- 1 mcc users 10 Mar 24 05:37 instance
-rw-r--r-- 1 mcc users 5 Mar 24 05:37 iscolored
-rw-r--r-- 1 mcc users 154K Mar 24 05:37 model.pnml

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

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

The expected result is a vector of booleans
BOOL_VECTOR

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

=== Now, execution of the tool begins

BK_START 1591141835550

bash -c /home/mcc/BenchKit/BenchKit_head.sh 2> STDERR ; echo ; echo -n "BK_STOP " ; date -u +%s%3N
[2020-06-02 23:50:37] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, ReachabilityCardinality, -z3path, /home/mcc/BenchKit//z3/bin/z3, -yices2path, /home/mcc/BenchKit//yices/bin/yices, -timeout, 3600, -rebuildPNML]
[2020-06-02 23:50:37] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2020-06-02 23:50:37] [INFO ] Detected file is not PT type :http://www.pnml.org/version-2009/grammar/symmetricnet
SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder".
SLF4J: Defaulting to no-operation (NOP) logger implementation
SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for further details.
[2020-06-02 23:50:37] [INFO ] Load time of PNML (colored model parsed with PNMLFW) : 664 ms
[2020-06-02 23:50:37] [INFO ] sort/places :
D4->DisablePollingE,DisablePollingB,Insert_Source_B,P_1119,P_2579,
Threads->AwakeTasks,IdleTasks,NotifyEventJobQueuedE,QueueJobE,P_2321,TryAllocateOneTaskE,TryAllocateOneTaskB,P_2318,EnablePollingE,EnablePollingB,FetchJobB,ScheduleTaskE_Check,ScheduleTaskB,Abort_Check_Sources_E,Abort_Check_Sources_B,NotifyEventSourceAddedB,Insert_Source_E,NotifyEventSourceAddedE,P_1113,ProcessingEvt,P_1155,nyo,P_1158,P_1159,P_1160,NotifyEventEndOfCheckSourcesB,NotifyEventEndOfCheckSourcesE,Check_Sources_B,Check_Sources_E,Idle,NotifyEventJobCompletedE,NotifyEventJobCompletedB,RunE,RunB,Perform_Work_E,Try_Check_Sources_B,Try_Check_Sources_E,P_1617,ScheduleTaskE_Idle,
D6->CreatedJobs,
Jobs->P_1725,P_1724,P_1712,AvailableJobId,
Dot->cJobCnt,JobCnt,cBlockedTasks,PollingAbort,cPollingAbort,BlockedTasks,MarkerWrite,P_1727,P_1726,MarkerRead,P_1717,P_1716,CanInjectEvent,SigAbort,NoSigAbort,P_1093,P_1095,P_1097,P_1099,cSources,cIsMonitoring,IsMonitoring,cIdleTasks,ORB_Lock,
Sources->DataOnSrc,PlaceSources,ModifiedSrc,AbourtToModifySrc,
D1->NotifyEventJobQueuedB,QueueJobB,FetchJobE,ScheduleTaskE_Work,

[2020-06-02 23:50:37] [INFO ] ms2 symmetric to ms1 in transition T_1124
[2020-06-02 23:50:37] [INFO ] ms3 symmetric to ms2 in transition T_1125
[2020-06-02 23:50:37] [INFO ] ms2 symmetric to ms1 in transition T_1125
[2020-06-02 23:50:37] [INFO ] ms3 symmetric to ms2 in transition T_1126
[2020-06-02 23:50:37] [INFO ] ms2 symmetric to ms1 in transition T_1126
[2020-06-02 23:50:37] [INFO ] ms1 symmetric to ms4 in transition T_1126
[2020-06-02 23:50:37] [INFO ] Imported 81 HL places and 65 HL transitions for a total of 690 PT places and 1492.0 transition bindings in 24 ms.
[2020-06-02 23:50:37] [INFO ] Computed order based on color domains.
[2020-06-02 23:50:38] [INFO ] Unfolded HLPN to a Petri net with 690 places and 1306 transitions in 33 ms.
[2020-06-02 23:50:38] [INFO ] Unfolded HLPN properties in 0 ms.
Parsed 16 properties from file /home/mcc/execution/ReachabilityCardinality.xml in 74 ms.
Working with output stream class java.io.PrintStream
Incomplete random walk after 10000 steps, including 3 resets, run finished after 88 ms. (steps per millisecond=113 ) properties seen :[0, 1, 0, 1, 0, 1, 1, 1, 0, 1, 1, 0, 0, 0, 0, 0]
FORMULA PolyORBLF-COL-S02J06T08-ReachabilityCardinality-10 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA PolyORBLF-COL-S02J06T08-ReachabilityCardinality-09 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA PolyORBLF-COL-S02J06T08-ReachabilityCardinality-07 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA PolyORBLF-COL-S02J06T08-ReachabilityCardinality-06 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA PolyORBLF-COL-S02J06T08-ReachabilityCardinality-05 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA PolyORBLF-COL-S02J06T08-ReachabilityCardinality-03 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA PolyORBLF-COL-S02J06T08-ReachabilityCardinality-01 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
Incomplete Best-First random walk after 10000 steps, including 0 resets, run finished after 34 ms. (steps per millisecond=294 ) properties seen :[0, 0, 0, 0, 0, 0, 0, 0, 0]
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 35 ms. (steps per millisecond=285 ) properties seen :[0, 0, 0, 0, 0, 0, 0, 0, 0]
Incomplete Best-First random walk after 10000 steps, including 0 resets, run finished after 27 ms. (steps per millisecond=370 ) properties seen :[0, 0, 0, 0, 0, 0, 0, 0, 0]
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 31 ms. (steps per millisecond=322 ) properties seen :[0, 0, 0, 0, 0, 0, 0, 0, 0]
Incomplete Best-First random walk after 10000 steps, including 1 resets, run finished after 31 ms. (steps per millisecond=322 ) properties seen :[0, 0, 0, 0, 0, 0, 0, 0, 0]
Incomplete Best-First random walk after 10000 steps, including 1 resets, run finished after 36 ms. (steps per millisecond=277 ) properties seen :[0, 0, 0, 0, 0, 0, 0, 0, 0]
Incomplete Best-First random walk after 10001 steps, including 3 resets, run finished after 26 ms. (steps per millisecond=384 ) properties seen :[0, 0, 0, 0, 0, 0, 0, 0, 0]
Incomplete Best-First random walk after 10000 steps, including 1 resets, run finished after 27 ms. (steps per millisecond=370 ) properties seen :[0, 0, 0, 0, 0, 0, 0, 0, 0]
Incomplete Best-First random walk after 10000 steps, including 1 resets, run finished after 31 ms. (steps per millisecond=322 ) properties seen :[0, 0, 0, 0, 0, 0, 0, 0, 0]
[2020-06-02 23:50:38] [INFO ] Flow matrix only has 1290 transitions (discarded 16 similar events)
// Phase 1: matrix 1290 rows 690 cols
[2020-06-02 23:50:38] [INFO ] Computed 54 place invariants in 90 ms
[2020-06-02 23:50:38] [INFO ] [Real]Absence check using 16 positive place invariants in 44 ms returned sat
[2020-06-02 23:50:38] [INFO ] [Real]Absence check using 16 positive and 38 generalized place invariants in 11 ms returned unsat
[2020-06-02 23:50:38] [INFO ] [Real]Absence check using 16 positive place invariants in 28 ms returned sat
[2020-06-02 23:50:38] [INFO ] [Real]Absence check using 16 positive and 38 generalized place invariants in 10 ms returned unsat
[2020-06-02 23:50:38] [INFO ] [Real]Absence check using 16 positive place invariants in 24 ms returned sat
[2020-06-02 23:50:39] [INFO ] [Real]Absence check using 16 positive and 38 generalized place invariants in 30 ms returned unsat
[2020-06-02 23:50:39] [INFO ] [Real]Absence check using 16 positive place invariants in 20 ms returned sat
[2020-06-02 23:50:39] [INFO ] [Real]Absence check using 16 positive and 38 generalized place invariants in 32 ms returned unsat
[2020-06-02 23:50:39] [INFO ] [Real]Absence check using 16 positive place invariants in 19 ms returned sat
[2020-06-02 23:50:39] [INFO ] [Real]Absence check using 16 positive and 38 generalized place invariants in 2 ms returned unsat
[2020-06-02 23:50:39] [INFO ] [Real]Absence check using 16 positive place invariants in 26 ms returned sat
[2020-06-02 23:50:39] [INFO ] [Real]Absence check using 16 positive and 38 generalized place invariants in 32 ms returned unsat
[2020-06-02 23:50:39] [INFO ] [Real]Absence check using 16 positive place invariants in 21 ms returned sat
[2020-06-02 23:50:39] [INFO ] [Real]Absence check using 16 positive and 38 generalized place invariants in 46 ms returned sat
[2020-06-02 23:50:39] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-02 23:50:41] [INFO ] [Real]Absence check using state equation in 1989 ms returned sat
[2020-06-02 23:50:41] [INFO ] Solution in real domain found non-integer solution.
[2020-06-02 23:50:41] [INFO ] [Nat]Absence check using 16 positive place invariants in 30 ms returned sat
[2020-06-02 23:50:41] [INFO ] [Nat]Absence check using 16 positive and 38 generalized place invariants in 44 ms returned sat
[2020-06-02 23:50:41] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2020-06-02 23:50:44] [INFO ] [Nat]Absence check using state equation in 2811 ms returned sat
[2020-06-02 23:50:44] [INFO ] State equation strengthened by 104 read => feed constraints.
[2020-06-02 23:50:45] [INFO ] [Nat]Added 104 Read/Feed constraints in 1184 ms returned sat
[2020-06-02 23:50:45] [INFO ] Deduced a trap composed of 74 places in 109 ms
[2020-06-02 23:50:46] [INFO ] Trap strengthening (SAT) tested/added 2/1 trap constraints in 294 ms
[2020-06-02 23:50:46] [INFO ] Computed and/alt/rep : 1304/21470/1288 causal constraints in 135 ms.
[2020-06-02 23:50:46] [INFO ] Added : 20 causal constraints over 4 iterations in 549 ms. Result :unknown
[2020-06-02 23:50:46] [INFO ] [Real]Absence check using 16 positive place invariants in 35 ms returned sat
[2020-06-02 23:50:46] [INFO ] [Real]Absence check using 16 positive and 38 generalized place invariants in 35 ms returned unsat
[2020-06-02 23:50:46] [INFO ] [Real]Absence check using 16 positive place invariants in 26 ms returned sat
[2020-06-02 23:50:46] [INFO ] [Real]Absence check using 16 positive and 38 generalized place invariants in 28 ms returned unsat
FORMULA PolyORBLF-COL-S02J06T08-ReachabilityCardinality-15 FALSE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA PolyORBLF-COL-S02J06T08-ReachabilityCardinality-14 FALSE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA PolyORBLF-COL-S02J06T08-ReachabilityCardinality-12 FALSE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA PolyORBLF-COL-S02J06T08-ReachabilityCardinality-11 FALSE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA PolyORBLF-COL-S02J06T08-ReachabilityCardinality-08 TRUE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA PolyORBLF-COL-S02J06T08-ReachabilityCardinality-04 TRUE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA PolyORBLF-COL-S02J06T08-ReachabilityCardinality-02 TRUE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA PolyORBLF-COL-S02J06T08-ReachabilityCardinality-00 FALSE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
Incomplete Parikh walk after 252800 steps, including 1000 resets, run finished after 696 ms. (steps per millisecond=363 ) properties seen :[0] could not realise parikh vector
Support contains 9 out of 690 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 690/690 places, 1306/1306 transitions.
Ensure Unique test removed 2 places
Performed 72 Post agglomeration using F-continuation condition.Transition count delta: 72
Iterating post reduction 0 with 74 rules applied. Total rules applied 74 place count 688 transition count 1234
Reduce places removed 72 places and 0 transitions.
Iterating post reduction 1 with 72 rules applied. Total rules applied 146 place count 616 transition count 1234
Performed 80 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 2 with 80 Pre rules applied. Total rules applied 146 place count 616 transition count 1154
Deduced a syphon composed of 80 places in 1 ms
Reduce places removed 80 places and 0 transitions.
Iterating global reduction 2 with 160 rules applied. Total rules applied 306 place count 536 transition count 1154
Performed 56 Post agglomeration using F-continuation condition.Transition count delta: 56
Deduced a syphon composed of 56 places in 2 ms
Reduce places removed 56 places and 0 transitions.
Iterating global reduction 2 with 112 rules applied. Total rules applied 418 place count 480 transition count 1098
Free-agglomeration rule (complex) applied 16 times.
Iterating global reduction 2 with 16 rules applied. Total rules applied 434 place count 480 transition count 1082
Reduce places removed 16 places and 0 transitions.
Iterating post reduction 2 with 16 rules applied. Total rules applied 450 place count 464 transition count 1082
Applied a total of 450 rules in 183 ms. Remains 464 /690 variables (removed 226) and now considering 1082/1306 (removed 224) transitions.
[2020-06-02 23:50:47] [INFO ] Flow matrix only has 1066 transitions (discarded 16 similar events)
// Phase 1: matrix 1066 rows 464 cols
[2020-06-02 23:50:47] [INFO ] Computed 52 place invariants in 36 ms
[2020-06-02 23:50:50] [INFO ] Dead Transitions using invariants and state equation in 2567 ms returned [972, 974, 975, 976, 977, 978, 979, 980, 981, 982, 983, 986, 988, 989, 990, 991, 992, 993, 994, 995, 996, 997, 1000, 1002, 1003, 1004, 1005, 1006, 1007, 1008, 1009, 1010, 1011, 1014, 1016, 1017, 1018, 1019, 1020, 1021, 1022, 1023, 1024, 1025, 1028, 1030, 1031, 1032, 1033, 1034, 1035, 1036, 1037, 1038, 1039, 1042, 1044, 1045, 1046, 1047, 1048, 1049, 1050, 1051, 1052, 1053, 1056, 1058, 1059, 1060, 1061, 1062, 1063, 1064, 1065, 1066, 1067, 1070, 1072, 1073, 1074, 1075, 1076, 1077, 1078, 1079, 1080, 1081]
Found 88 dead transitions using SMT.
Drop transitions removed 88 transitions
Dead transitions reduction (with SMT) triggered by suspicious arc values removed 88 transitions :[1081, 1080, 1079, 1078, 1077, 1076, 1075, 1074, 1073, 1072, 1070, 1067, 1066, 1065, 1064, 1063, 1062, 1061, 1060, 1059, 1058, 1056, 1053, 1052, 1051, 1050, 1049, 1048, 1047, 1046, 1045, 1044, 1042, 1039, 1038, 1037, 1036, 1035, 1034, 1033, 1032, 1031, 1030, 1028, 1025, 1024, 1023, 1022, 1021, 1020, 1019, 1018, 1017, 1016, 1014, 1011, 1010, 1009, 1008, 1007, 1006, 1005, 1004, 1003, 1002, 1000, 997, 996, 995, 994, 993, 992, 991, 990, 989, 988, 986, 983, 982, 981, 980, 979, 978, 977, 976, 975, 974, 972]
Starting structural reductions, iteration 1 : 464/690 places, 994/1306 transitions.
Reduce places removed 2 places and 16 transitions.
Iterating post reduction 0 with 2 rules applied. Total rules applied 2 place count 462 transition count 978
Reduce places removed 16 places and 16 transitions.
Iterating post reduction 1 with 16 rules applied. Total rules applied 18 place count 446 transition count 962
Applied a total of 18 rules in 30 ms. Remains 446 /464 variables (removed 18) and now considering 962/994 (removed 32) transitions.
Finished structural reductions, in 2 iterations. Remains : 446/690 places, 962/1306 transitions.
Incomplete random walk after 1000000 steps, including 403 resets, run finished after 3069 ms. (steps per millisecond=325 ) properties seen :[0]
Incomplete Best-First random walk after 1000001 steps, including 427 resets, run finished after 1620 ms. (steps per millisecond=617 ) properties seen :[0]
Interrupted probabilistic random walk after 4154226 steps, run timeout after 30001 ms. (steps per millisecond=138 ) properties seen :[0]
Probabilistic random walk after 4154226 steps, saw 1421554 distinct states, run finished after 30001 ms. (steps per millisecond=138 ) properties seen :[0]
[2020-06-02 23:51:25] [INFO ] Flow matrix only has 946 transitions (discarded 16 similar events)
// Phase 1: matrix 946 rows 446 cols
[2020-06-02 23:51:25] [INFO ] Computed 52 place invariants in 18 ms
[2020-06-02 23:51:25] [INFO ] [Real]Absence check using 15 positive place invariants in 19 ms returned sat
[2020-06-02 23:51:25] [INFO ] [Real]Absence check using 15 positive and 37 generalized place invariants in 37 ms returned sat
[2020-06-02 23:51:25] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-02 23:51:26] [INFO ] [Real]Absence check using state equation in 1165 ms returned sat
[2020-06-02 23:51:26] [INFO ] Solution in real domain found non-integer solution.
[2020-06-02 23:51:26] [INFO ] [Nat]Absence check using 15 positive place invariants in 22 ms returned sat
[2020-06-02 23:51:26] [INFO ] [Nat]Absence check using 15 positive and 37 generalized place invariants in 53 ms returned sat
[2020-06-02 23:51:26] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2020-06-02 23:51:27] [INFO ] [Nat]Absence check using state equation in 1235 ms returned sat
[2020-06-02 23:51:27] [INFO ] State equation strengthened by 104 read => feed constraints.
[2020-06-02 23:51:28] [INFO ] [Nat]Added 104 Read/Feed constraints in 226 ms returned sat
[2020-06-02 23:51:28] [INFO ] Deduced a trap composed of 43 places in 329 ms
[2020-06-02 23:51:28] [INFO ] Deduced a trap composed of 13 places in 318 ms
[2020-06-02 23:51:28] [INFO ] Trap strengthening (SAT) tested/added 3/2 trap constraints in 829 ms
[2020-06-02 23:51:28] [INFO ] Computed and/alt/rep : 960/21390/944 causal constraints in 80 ms.
[2020-06-02 23:51:49] [INFO ] Added : 655 causal constraints over 131 iterations in 20184 ms.(timeout) Result :sat
[2020-06-02 23:51:49] [INFO ] Deduced a trap composed of 43 places in 237 ms
[2020-06-02 23:51:49] [INFO ] Deduced a trap composed of 43 places in 215 ms
[2020-06-02 23:51:50] [INFO ] Deduced a trap composed of 44 places in 189 ms
[2020-06-02 23:51:50] [INFO ] Deduced a trap composed of 43 places in 68 ms
[2020-06-02 23:51:50] [INFO ] Deduced a trap composed of 43 places in 100 ms
[2020-06-02 23:51:51] [INFO ] Trap strengthening (SAT) tested/added 6/5 trap constraints in 2021 ms
Attempting to minimize the solution found.
Minimization took 211 ms.
Incomplete Parikh walk after 628000 steps, including 1000 resets, run finished after 2003 ms. (steps per millisecond=313 ) properties seen :[0] could not realise parikh vector
Support contains 9 out of 446 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 446/446 places, 962/962 transitions.
Applied a total of 0 rules in 18 ms. Remains 446 /446 variables (removed 0) and now considering 962/962 (removed 0) transitions.
Finished structural reductions, in 1 iterations. Remains : 446/446 places, 962/962 transitions.
Starting structural reductions, iteration 0 : 446/446 places, 962/962 transitions.
Applied a total of 0 rules in 18 ms. Remains 446 /446 variables (removed 0) and now considering 962/962 (removed 0) transitions.
[2020-06-02 23:51:53] [INFO ] Flow matrix only has 946 transitions (discarded 16 similar events)
// Phase 1: matrix 946 rows 446 cols
[2020-06-02 23:51:53] [INFO ] Computed 52 place invariants in 86 ms
[2020-06-02 23:51:54] [INFO ] Implicit Places using invariants in 1022 ms returned []
[2020-06-02 23:51:54] [INFO ] Flow matrix only has 946 transitions (discarded 16 similar events)
// Phase 1: matrix 946 rows 446 cols
[2020-06-02 23:51:54] [INFO ] Computed 52 place invariants in 12 ms
[2020-06-02 23:51:55] [INFO ] State equation strengthened by 104 read => feed constraints.
[2020-06-02 23:52:01] [INFO ] Implicit Places using invariants and state equation in 7264 ms returned []
Implicit Place search using SMT with State Equation took 8293 ms to find 0 implicit places.
[2020-06-02 23:52:01] [INFO ] Redundant transitions in 95 ms returned []
[2020-06-02 23:52:01] [INFO ] Flow matrix only has 946 transitions (discarded 16 similar events)
// Phase 1: matrix 946 rows 446 cols
[2020-06-02 23:52:01] [INFO ] Computed 52 place invariants in 18 ms
[2020-06-02 23:52:03] [INFO ] Dead Transitions using invariants and state equation in 1944 ms returned []
Finished structural reductions, in 1 iterations. Remains : 446/446 places, 962/962 transitions.
Incomplete random walk after 100000 steps, including 43 resets, run finished after 305 ms. (steps per millisecond=327 ) properties seen :[0]
[2020-06-02 23:52:04] [INFO ] Flow matrix only has 946 transitions (discarded 16 similar events)
// Phase 1: matrix 946 rows 446 cols
[2020-06-02 23:52:04] [INFO ] Computed 52 place invariants in 12 ms
[2020-06-02 23:52:04] [INFO ] [Real]Absence check using 15 positive place invariants in 19 ms returned sat
[2020-06-02 23:52:04] [INFO ] [Real]Absence check using 15 positive and 37 generalized place invariants in 35 ms returned sat
[2020-06-02 23:52:04] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-02 23:52:05] [INFO ] [Real]Absence check using state equation in 830 ms returned sat
[2020-06-02 23:52:05] [INFO ] Solution in real domain found non-integer solution.
[2020-06-02 23:52:05] [INFO ] [Nat]Absence check using 15 positive place invariants in 12 ms returned sat
[2020-06-02 23:52:05] [INFO ] [Nat]Absence check using 15 positive and 37 generalized place invariants in 21 ms returned sat
[2020-06-02 23:52:05] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2020-06-02 23:52:06] [INFO ] [Nat]Absence check using state equation in 1063 ms returned sat
[2020-06-02 23:52:06] [INFO ] State equation strengthened by 104 read => feed constraints.
[2020-06-02 23:52:06] [INFO ] [Nat]Added 104 Read/Feed constraints in 228 ms returned sat
[2020-06-02 23:52:06] [INFO ] Deduced a trap composed of 43 places in 304 ms
[2020-06-02 23:52:07] [INFO ] Deduced a trap composed of 13 places in 295 ms
[2020-06-02 23:52:07] [INFO ] Trap strengthening (SAT) tested/added 3/2 trap constraints in 771 ms
[2020-06-02 23:52:07] [INFO ] Computed and/alt/rep : 960/21390/944 causal constraints in 85 ms.
[2020-06-02 23:52:25] [INFO ] Added : 620 causal constraints over 124 iterations in 17849 ms. Result :(error "Solver has unexpectedly terminated")
Ensure Unique test removed 16 transitions
Reduce isomorphic transitions removed 16 transitions.
Iterating post reduction 0 with 16 rules applied. Total rules applied 16 place count 446 transition count 946
Performed 8 Post agglomeration using F-continuation condition.Transition count delta: -32
Deduced a syphon composed of 8 places in 1 ms
Reduce places removed 8 places and 0 transitions.
Iterating global reduction 1 with 16 rules applied. Total rules applied 32 place count 438 transition count 978
Free-agglomeration rule applied 8 times.
Iterating global reduction 1 with 8 rules applied. Total rules applied 40 place count 438 transition count 970
Reduce places removed 8 places and 0 transitions.
Iterating post reduction 1 with 8 rules applied. Total rules applied 48 place count 430 transition count 970
Free-agglomeration rule (complex) applied 18 times.
Iterating global reduction 2 with 18 rules applied. Total rules applied 66 place count 430 transition count 952
Reduce places removed 18 places and 0 transitions.
Iterating post reduction 2 with 18 rules applied. Total rules applied 84 place count 412 transition count 952
Drop transitions removed 32 transitions
Redundant transition composition rules discarded 32 transitions
Iterating global reduction 3 with 32 rules applied. Total rules applied 116 place count 412 transition count 920
Applied a total of 116 rules in 137 ms. Remains 412 /446 variables (removed 34) and now considering 920/962 (removed 42) transitions.
// Phase 1: matrix 920 rows 412 cols
[2020-06-02 23:52:25] [INFO ] Computed 52 place invariants in 17 ms
[2020-06-02 23:52:25] [INFO ] [Real]Absence check using 14 positive place invariants in 55 ms returned sat
[2020-06-02 23:52:25] [INFO ] [Real]Absence check using 14 positive and 38 generalized place invariants in 25 ms returned sat
[2020-06-02 23:52:25] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-02 23:52:26] [INFO ] [Real]Absence check using state equation in 896 ms returned sat
[2020-06-02 23:52:26] [INFO ] Solution in real domain found non-integer solution.
[2020-06-02 23:52:26] [INFO ] [Nat]Absence check using 14 positive place invariants in 22 ms returned sat
[2020-06-02 23:52:26] [INFO ] [Nat]Absence check using 14 positive and 38 generalized place invariants in 31 ms returned sat
[2020-06-02 23:52:26] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2020-06-02 23:52:27] [INFO ] [Nat]Absence check using state equation in 874 ms returned sat
[2020-06-02 23:52:27] [INFO ] Computed and/alt/rep : 917/20317/917 causal constraints in 62 ms.
[2020-06-02 23:52:47] [INFO ] Added : 760 causal constraints over 152 iterations in 20406 ms.(timeout) Result :sat
[2020-06-02 23:52:47] [INFO ] Deduced a trap composed of 40 places in 103 ms
[2020-06-02 23:52:48] [INFO ] Deduced a trap composed of 39 places in 72 ms
[2020-06-02 23:52:48] [INFO ] Deduced a trap composed of 39 places in 84 ms
[2020-06-02 23:52:49] [INFO ] Deduced a trap composed of 39 places in 139 ms
[2020-06-02 23:52:49] [INFO ] Deduced a trap composed of 39 places in 126 ms
[2020-06-02 23:52:49] [INFO ] Deduced a trap composed of 39 places in 107 ms
[2020-06-02 23:52:50] [INFO ] Trap strengthening (SAT) tested/added 7/6 trap constraints in 2341 ms
Attempting to minimize the solution found.
Minimization took 259 ms.
[2020-06-02 23:52:50] [INFO ] Export to MCC properties in file /home/mcc/execution/ReachabilityCardinality.sr.xml took 3 ms.
[2020-06-02 23:52:50] [INFO ] Export to PNML in file /home/mcc/execution/model.sr.pnml took 18 ms.
[2020-06-02 23:52:50] [INFO ] Flatten gal took : 165 ms
info: Time: 3600 - MCC
vrfy: Checking ReachabilityCardinality @ PolyORBLF-COL-S02J06T08 @ 3570 seconds
vrfy: finished
info: timeLeft: 3567
rslt: Output for ReachabilityCardinality @ PolyORBLF-COL-S02J06T08

{
"build":
{
"architecture": 64,
"assertions": false,
"build_hostname": "mcc2019",
"build_system": "x86_64-unknown-linux-gnu",
"optimizations": true,
"package_version": "2.0",
"svn_version": "3189M"
},
"call":
{
"exec_host": "mcc2020",
"localtimelimit": 0,
"markinglimit": null,
"parameters":
[
"--pnmlnet",
"model.pnml",
"--xmlformula",
"--formula=ReachabilityCardinality.xml",
"--mcc",
"--donotcomputecapacities",
"--encoder=simplecompressed",
"--check=modelchecking",
"--stubborn=tarjan",
"--stateequation=par",
"--timelimit=3570",
"--localtimelimit=0",
"--json=ReachabilityCardinality.json",
"--jsoninclude=formula,formulastat,net"
],
"starttime": "Tue Jun 2 23:52:51 2020
",
"timelimit": 3570
},
"child": null,
"exit":
{
"error": null,
"localtimelimitreached": true,
"memory": 24984,
"runtime": 3.000000,
"signal": null,
"timelimitreached": false
},
"files":
{
"formula": "ReachabilityCardinality.xml",
"net": "model.pnml"
},
"formula":
{
"count":
{
"A": 1,
"E": 0,
"F": 0,
"G": 1,
"U": 0,
"X": 0,
"aconj": 0,
"adisj": 0,
"aneg": 0,
"comp": 1,
"cont": 0,
"dl": 0,
"fir": 0,
"nodl": 0,
"place_references": 9,
"taut": 0,
"tconj": 0,
"tdisj": 0,
"tneg": 0,
"transition_references": 0,
"unfir": 0,
"visible_places": 9,
"visible_transitions": 0
},
"processed": "A (G ((p176 <= p392 + p393 + p394 + p395 + p396 + p397 + p398 + p399)))",
"processed_size": 71,
"rewrites": 2,
"skeleton": "A(G(**))"
},
"net":
{
"arcs": 4818,
"conflict_clusters": 29,
"places": 446,
"places_significant": 394,
"singleton_clusters": 0,
"transitions": 962
},
"task":
{
"search":
{
"store":
{
"encoder": "simple compression",
"type": "prefix"
},
"stubborn":
{
"type": "reachability preserving/insertion"
},
"threads": 1,
"type": "dfs"
},
"stateequation":
{
"literals": 1,
"problems": 1
},
"type": "invariance",
"workflow": "stateequation||search"
}
}
lola: LoLA will run for 3570 seconds at most (--timelimit)
lola: NET
lola: input: PNML file (--pnml)
lola: reading net from model.pnml
lola: reading pnml
lola: PNML file contains place/transition net
lola: finished parsing
lola: closed net file model.pnml
lola: 1408/268435456 symbol table entries, 0 collisions
lola: preprocessing...
lola: Size of bit vector: 14272
lola: finding significant places
lola: 446 places, 962 transitions, 394 significant places
lola: compute conflict clusters
lola: computed conflict clusters
lola: Computing conflicting sets
lola: Computing back conflicting sets
lola: TASK
lola: Reading formula in XML format (--xmlformula)
lola: reading pnml
lola: reading formula from ReachabilityCardinality.xml
lola: A (G ((p176 <= p392 + p393 + p394 + p395 + p396 + p397 + p398 + p399)))
lola: checking invariance
lola: Planning: workflow for reachability check: stateequation||search (--findpath=off)
lola: rewrite Frontend/Parser/formula_rewrite.k:721
lola: rewrite Frontend/Parser/formula_rewrite.k:787
lola: processed formula: A (G ((p176 <= p392 + p393 + p394 + p395 + p396 + p397 + p398 + p399)))
lola: processed formula length: 71
lola: 2 rewrites
lola: closed formula file ReachabilityCardinality.xml
lola: STORE
lola: using a simple compression encoder (--encoder=simplecompressed)
lola: using a prefix tree store (--store=prefix)
lola: SEARCH (state space)
lola: state space: using reachability graph (--search=depth)
lola: state space: using reachability preserving stubborn set method with insertion algorithm (--stubborn=tarjan)
lola: built state equation task
lola: RUNNING
lola: subprocess will run for 0 seconds at most (--localtimelimit)
lola: state equation task get result started, id 0
lola: local time limit reached - aborting
lola: rewrite Frontend/Parser/formula_rewrite.k:721
lola: rewrite Frontend/Parser/formula_rewrite.k:787
lola: state equation task get result rewrite finished id 0
lola: state equation task get result unparse finished++ id 0
lola: formula 0: (p392 + p393 + p394 + p395 + p396 + p397 + p398 + p399 + 1 <= p176)
lola: state equation task get result unparse finished id 0
lola: state equation: Generated DNF with 1 literals and 1 conjunctive subformulas
lola: memory consumption: 24984 KB
lola: time consumption: 3 seconds
lola: print data as JSON (--json)
lola: writing JSON to ReachabilityCardinality.json
lola: closed JSON file ReachabilityCardinality.json
lola: state equation: write sara problem file to ReachabilityCardinality-0.sara
lola: state equation: calling and running sara
sara: try reading problem file ReachabilityCardinality-0.sara.
rslt: finished

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

Sequence of Actions to be Executed by the VM

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

set -x
# this is for BenchKit: configuration of major elements for the test
export BK_INPUT="PolyORBLF-COL-S02J06T08"
export BK_EXAMINATION="ReachabilityCardinality"
export BK_TOOL="itslola"
export BK_RESULT_DIR="/tmp/BK_RESULTS/OUTPUTS"
export BK_TIME_CONFINEMENT="3600"
export BK_MEMORY_CONFINEMENT="16384"

# 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 itslola"
echo " Input is PolyORBLF-COL-S02J06T08, examination is ReachabilityCardinality"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 4"
echo " Run identifier is r176-tajo-158987871700302"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

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