About the Execution of ITS-Tools for CloudDeployment-PT-5a
Execution Summary | |||||
Max Memory Used (MB) |
Time wait (ms) | CPU Usage (ms) | I/O Wait (ms) | Computed Result | Execution Status |
15763.290 | 266033.00 | 265012.00 | 1039.00 | T | normal |
Execution Chart
We display below the execution chart for this examination (boot time has been removed).
Trace from the execution
Formatting '/data/fkordon/mcc2020-input.r042-smll-158902051700236.qcow2', fmt=qcow2 size=4294967296 backing_file='/data/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 itstools
Input is CloudDeployment-PT-5a, examination is ReachabilityDeadlock
Time confinement is 1800 seconds
Memory confinement is 16384 MBytes
Number of cores is 1
Run identifier is r042-smll-158902051700236
=====================================================================
--------------------
preparation of the directory to be used:
/home/mcc/execution
total 396K
-rw-r--r-- 1 mcc users 3.6K Mar 30 01:22 CTLCardinality.txt
-rw-r--r-- 1 mcc users 21K Mar 30 01:22 CTLCardinality.xml
-rw-r--r-- 1 mcc users 2.3K Mar 28 15:43 CTLFireability.txt
-rw-r--r-- 1 mcc users 14K Mar 28 15:43 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.0K Mar 24 05:37 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 3.1K Apr 8 14:45 LTLCardinality.txt
-rw-r--r-- 1 mcc users 22K Apr 28 14:00 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.0K Apr 8 14:45 LTLFireability.txt
-rw-r--r-- 1 mcc users 16K Apr 28 14:00 LTLFireability.xml
-rw-r--r-- 1 mcc users 3.3K Mar 27 08:29 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 17K Mar 27 08:29 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 2.5K Mar 26 07:54 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 14K Mar 26 07:54 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.7K Mar 28 14:49 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.7K Mar 28 14:49 UpperBounds.xml
-rw-r--r-- 1 mcc users 6 Mar 24 05:37 equiv_col
-rw-r--r-- 1 mcc users 3 Mar 24 05:37 instance
-rw-r--r-- 1 mcc users 6 Mar 24 05:37 iscolored
-rw-r--r-- 1 mcc users 230K 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
FORMULA_NAME ReachabilityDeadlock
=== Now, execution of the tool begins
BK_START 1589204823994
[2020-05-11 13:47:08] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, ReachabilityDeadlock, -z3path, /home/mcc/BenchKit//z3/bin/z3, -yices2path, /home/mcc/BenchKit//yices/bin/yices, -its, -ltsminpath, /home/mcc/BenchKit//lts_install_dir/, -greatspnpath, /home/mcc/BenchKit//greatspn/, -order, META, -manyOrder, -smt, -timeout, 1800]
[2020-05-11 13:47:08] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2020-05-11 13:47:08] [INFO ] Load time of PNML (sax parser for PT used): 315 ms
[2020-05-11 13:47:08] [INFO ] Transformed 180 places.
[2020-05-11 13:47:08] [INFO ] Transformed 675 transitions.
[2020-05-11 13:47:08] [INFO ] Found NUPN structural information;
[2020-05-11 13:47:08] [INFO ] Parsed PT model containing 180 places and 675 transitions in 431 ms.
Ensure Unique test removed 80 transitions
Reduce redundant transitions removed 80 transitions.
Parsed 1 properties from file /home/mcc/execution/ReachabilityDeadlock.xml in 32 ms.
Working with output stream class java.io.PrintStream
Built sparse matrix representations for Structural reductions in 12 ms.16597KB memory used
Starting structural reductions, iteration 0 : 180/180 places, 595/595 transitions.
Graph (trivial) has 201 edges and 180 vertex of which 50 / 180 are part of one of the 15 SCC in 14 ms
Free SCC test removed 35 places
Discarding 11 places :
Also discarding 0 output transitions
Graph (complete) has 1567 edges and 145 vertex of which 134 are kept as prefixes of interest. Removing 11 places using SCC suffix rule.26 ms
Ensure Unique test removed 95 transitions
Reduce isomorphic transitions removed 95 transitions.
Iterating post reduction 0 with 95 rules applied. Total rules applied 97 place count 134 transition count 500
Symmetric choice reduction at 1 with 3 rule applications. Total rules 100 place count 134 transition count 500
Deduced a syphon composed of 3 places in 2 ms
Reduce places removed 3 places and 3 transitions.
Iterating global reduction 1 with 6 rules applied. Total rules applied 106 place count 131 transition count 497
Symmetric choice reduction at 1 with 2 rule applications. Total rules 108 place count 131 transition count 497
Deduced a syphon composed of 2 places in 2 ms
Reduce places removed 2 places and 2 transitions.
Iterating global reduction 1 with 4 rules applied. Total rules applied 112 place count 129 transition count 495
Symmetric choice reduction at 1 with 1 rule applications. Total rules 113 place count 129 transition count 495
Deduced a syphon composed of 1 places in 3 ms
Reduce places removed 1 places and 1 transitions.
Iterating global reduction 1 with 2 rules applied. Total rules applied 115 place count 128 transition count 494
Performed 15 Post agglomeration using F-continuation condition.Transition count delta: -45
Deduced a syphon composed of 15 places in 9 ms
Reduce places removed 15 places and 0 transitions.
Iterating global reduction 1 with 30 rules applied. Total rules applied 145 place count 113 transition count 539
Drop transitions removed 135 transitions
Redundant transition composition rules discarded 135 transitions
Iterating global reduction 1 with 135 rules applied. Total rules applied 280 place count 113 transition count 404
Reduce places removed 1 places and 1 transitions.
Iterating global reduction 1 with 1 rules applied. Total rules applied 281 place count 112 transition count 403
Applied a total of 281 rules in 461 ms. Remains 112 /180 variables (removed 68) and now considering 403/595 (removed 192) transitions.
Finished structural reductions, in 1 iterations. Remains : 112/180 places, 403/595 transitions.
Random walk for 1250000 steps, including 24455 resets, run took 5873 ms (no deadlock found). (steps per millisecond=212 )
Random directed walk for 1250001 steps, including 7524 resets, run took 3506 ms (no deadlock found). (steps per millisecond=356 )
[2020-05-11 13:47:18] [INFO ] Flow matrix only has 159 transitions (discarded 244 similar events)
// Phase 1: matrix 159 rows 112 cols
[2020-05-11 13:47:18] [INFO ] Computed 19 place invariants in 28 ms
[2020-05-11 13:47:19] [INFO ] [Real]Absence check using 0 positive and 19 generalized place invariants in 24 ms returned sat
[2020-05-11 13:47:19] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-05-11 13:47:19] [INFO ] [Real]Absence check using state equation in 245 ms returned sat
[2020-05-11 13:47:19] [INFO ] State equation strengthened by 7 read => feed constraints.
[2020-05-11 13:47:19] [INFO ] [Real]Added 7 Read/Feed constraints in 23 ms returned sat
[2020-05-11 13:47:19] [INFO ] Solution in real domain found non-integer solution.
[2020-05-11 13:47:19] [INFO ] [Nat]Absence check using 0 positive and 19 generalized place invariants in 18 ms returned sat
[2020-05-11 13:47:19] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2020-05-11 13:47:19] [INFO ] [Nat]Absence check using state equation in 169 ms returned sat
[2020-05-11 13:47:19] [INFO ] State equation strengthened by 7 read => feed constraints.
[2020-05-11 13:47:19] [INFO ] [Nat]Added 7 Read/Feed constraints in 20 ms returned sat
[2020-05-11 13:47:19] [INFO ] Computed and/alt/rep : 332/1456/132 causal constraints in 50 ms.
[2020-05-11 13:47:20] [INFO ] Added : 82 causal constraints over 17 iterations in 708 ms. Result :sat
Attempting to minimize the solution found.
Minimization took 18 ms.
Parikh directed walk for 9600 steps, including 182 resets, run took 102 ms. (steps per millisecond=94 )
Random directed walk for 500004 steps, including 2989 resets, run took 952 ms (no deadlock found). (steps per millisecond=525 )
Random walk for 500000 steps, including 9742 resets, run took 1342 ms (no deadlock found). (steps per millisecond=372 )
Random directed walk for 500000 steps, including 2991 resets, run took 960 ms (no deadlock found). (steps per millisecond=520 )
Random walk for 500000 steps, including 9797 resets, run took 1334 ms (no deadlock found). (steps per millisecond=374 )
[2020-05-11 13:47:25] [INFO ] Flatten gal took : 283 ms
Using solver Z3 to compute partial order matrices.
Built C files in :
/home/mcc/execution
[2020-05-11 13:47:26] [INFO ] Applying decomposition
[2020-05-11 13:47:26] [INFO ] Flatten gal took : 235 ms
[2020-05-11 13:47:26] [INFO ] Input system was already deterministic with 595 transitions.
Converted graph to binary with : CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202005100927/bin/convert-linux64, -i, /tmp/graph4592600464331186162.txt, -o, /tmp/graph4592600464331186162.bin, -w, /tmp/graph4592600464331186162.weights], workingDir=null]
Built communities with : CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202005100927/bin/louvain-linux64, /tmp/graph4592600464331186162.bin, -l, -1, -v, -w, /tmp/graph4592600464331186162.weights, -q, 0, -e, 0.001], workingDir=null]
[2020-05-11 13:47:27] [INFO ] Decomposing Gal with order
[2020-05-11 13:47:27] [INFO ] Rewriting arrays to variables to allow decomposition.
Presburger conditions satisfied. Using coverability to approximate state space in K-Induction.
Normalized transition count is 301 out of 595 initially.
// Phase 1: matrix 301 rows 180 cols
[2020-05-11 13:47:27] [INFO ] Computed 30 place invariants in 23 ms
inv : p113 - p141 = 0
inv : p117 + p118 + p119 + p120 + p121 + p122 + p123 + p124 + p125 + p126 + p127 + p128 + p129 + p130 + p131 + p132 + p133 + p134 + p135 + p136 + p137 + p138 + p139 + p140 - p141 - p178 - p179 = 0
inv : p142 + p143 + p144 + p145 + p146 + p147 + p148 + p149 + p150 + p151 + p152 + p153 + p154 + p155 + p156 + p157 + p158 + p159 + p160 + p161 + p162 + p163 + p164 + p165 + p166 + p167 + p176 + p177 - p178 - p179 = 0
inv : p87 - p141 = 0
inv : p88 - p178 - p179 = 0
inv : p30 - p178 - p179 = 0
inv : p142 + p143 + p144 + p145 + p146 + p147 + p148 + p149 + p150 + p151 + p152 + p153 + p154 + p155 + p156 + p157 + p158 + p159 + p160 + p161 + p162 + p163 + p164 + p165 + p166 + p167 + p174 + p175 - p178 - p179 = 0
inv : p59 - p141 = 0
inv : p142 + p143 + p144 + p145 + p146 + p147 + p148 + p149 + p150 + p151 + p152 + p153 + p154 + p155 + p156 + p157 + p158 + p159 + p160 + p161 + p162 + p163 + p164 + p165 + p166 + p167 + p172 + p173 - p178 - p179 = 0
inv : p116 - p178 - p179 = 0
inv : p86 - p178 - p179 = 0
inv : p32 - p178 - p179 = 0
inv : p58 - p178 - p179 = 0
inv : p114 - p178 - p179 = 0
inv : p61 + p62 + p63 + p64 + p65 + p66 + p67 + p68 + p69 + p70 + p71 + p72 + p73 + p74 + p75 + p76 + p77 + p78 + p79 + p80 + p81 + p82 + p83 + p84 - p141 - p178 - p179 = 0
inv : p1 - p141 = 0
inv : p33 + p34 + p35 + p36 + p37 + p38 + p39 + p40 + p41 + p42 + p43 + p44 + p45 + p46 + p47 + p48 + p49 + p50 + p51 + p52 + p53 + p54 + p55 + p56 - p141 - p178 - p179 = 0
inv : p142 + p143 + p144 + p145 + p146 + p147 + p148 + p149 + p150 + p151 + p152 + p153 + p154 + p155 + p156 + p157 + p158 + p159 + p160 + p161 + p162 + p163 + p164 + p165 + p166 + p167 + p168 + p169 - p178 - p179 = 0
inv : p29 - p141 = 0
inv : p115 - p141 = 0
inv : p60 - p178 - p179 = 0
inv : p89 + p90 + p91 + p92 + p93 + p94 + p95 + p96 + p97 + p98 + p99 + p100 + p101 + p102 + p103 + p104 + p105 + p106 + p107 + p108 + p109 + p110 + p111 + p112 - p141 - p178 - p179 = 0
inv : p5 + p6 + p7 + p8 + p9 + p10 + p11 + p12 + p13 + p14 + p15 + p16 + p17 + p18 + p19 + p20 + p21 + p22 + p23 + p24 + p25 + p26 + p27 + p28 - p141 - p178 - p179 = 0
inv : p57 - p141 = 0
inv : p4 - p178 - p179 = 0
inv : p3 - p141 = 0
inv : p85 - p141 = 0
inv : p142 + p143 + p144 + p145 + p146 + p147 + p148 + p149 + p150 + p151 + p152 + p153 + p154 + p155 + p156 + p157 + p158 + p159 + p160 + p161 + p162 + p163 + p164 + p165 + p166 + p167 + p170 + p171 - p178 - p179 = 0
inv : p2 - p178 - p179 = 0
inv : p31 - p141 = 0
Total of 30 invariants.
[2020-05-11 13:47:27] [INFO ] Computed 30 place invariants in 31 ms
[2020-05-11 13:47:27] [INFO ] Removed a total of 614 redundant transitions.
[2020-05-11 13:47:27] [INFO ] Flatten gal took : 618 ms
[2020-05-11 13:47:28] [INFO ] Fuse similar labels procedure discarded/fused a total of 121 labels/synchronizations in 92 ms.
[2020-05-11 13:47:28] [INFO ] Time to serialize gal into /home/mcc/execution/ReachabilityDeadlock.pnml.gal : 45 ms
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202005100927/bin/its-ctl-linux64, --gc-threshold, 2000000, --quiet, -i, /home/mcc/execution/ReachabilityDeadlock.pnml.gal, -t, CGAL, -ctl, DEADLOCK], workingDir=/home/mcc/execution]
its-ctl command run as :
/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202005100927/bin/its-ctl-linux64 --gc-threshold 2000000 --quiet -i /home/mcc/execution/ReachabilityDeadlock.pnml.gal -t CGAL -ctl DEADLOCK
No direction supplied, using forward translation only.
built 27 ordering constraints for composite.
built 18 ordering constraints for composite.
built 18 ordering constraints for composite.
built 15 ordering constraints for composite.
built 19 ordering constraints for composite.
built 13 ordering constraints for composite.
built 14 ordering constraints for composite.
built 60 ordering constraints for composite.
built 65 ordering constraints for composite.
built 6 ordering constraints for composite.
built 18 ordering constraints for composite.
built 13 ordering constraints for composite.
built 15 ordering constraints for composite.
built 13 ordering constraints for composite.
[2020-05-11 13:47:28] [INFO ] Proved 180 variables to be positive in 1155 ms
[2020-05-11 13:47:28] [INFO ] Computing symmetric may disable matrix : 595 transitions.
[2020-05-11 13:47:28] [INFO ] Computation of disable matrix completed :0/595 took 1 ms. Total solver calls (SAT/UNSAT): 0(0/0)
[2020-05-11 13:47:28] [INFO ] Computation of Complete disable matrix. took 290 ms. Total solver calls (SAT/UNSAT): 0(0/0)
[2020-05-11 13:47:28] [INFO ] Computing symmetric may enable matrix : 595 transitions.
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
reachable,2.4883e+08,0.186762,9060,266,120,8943,665,784,12240,247,1674,0
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
dead,2,0.228562,9060,61,61,8943,740,2015,12240,1137,1674,6715
System contains 2 deadlocks (shown below if less than --print-limit option) !
FORMULA ReachabilityDeadlock TRUE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL USE_NUPN
[ i9={[ u35={[ ]
} u34={[ ]
} u33={[ ]
} ]
} i8={[ u32={[ ]
} u31={[ ]
} u29={[ ]
} u30={[ ]
} ]
} i7={[ u46={[ ]
} u28={[ ]
} u27={[ ]
} ]
} i6={[ u26={[ ]
} u25={[ ]
} u24={[ ]
} u22={[ ]
} u23={[ ]
} ]
} i10={[ i1={[ u40={[ ]
} u39={[ ]
} ]
} i0={[ u48={[ ]
} u42={[ ]
} u41={[ ]
} u38={[ ]
} u36={[ ]
} u37={[ ]
} ]
} ]
} i5={[ u21={[ ]
} u20={[ ]
} u19={[ ]
} u18={[ ]
} ]
} i3={[ u44={[ ]
} u13={[ ]
} u12={[ ]
} ]
} i1={[ u47={[ ]
} u45={[ ]
} u43={[ ]
} u6={[ ]
} u5={[ ]
} ]
} i4={[ u17={[ ]
} u16={[ ]
} u14={[ ]
} u15={[ ]
} ]
} i2={[ u11={[ ]
} u10={[ ]
} u9={[ ]
} u7={[ ]
} u8={[ ]
} ]
} i0={[ u4={[ ]
} u3={[ ]
} u2={[ ]
} u0={[ ]
} u1={[ ]
} ]
} ]
[ i9={[ u35={[ p140=1 ]
} u34={[ ]
} u33={[ ]
} ]
} i8={[ u32={[ ]
} u31={[ ]
} u29={[ ]
} u30={[ ]
} ]
} i7={[ u46={[ ]
} u28={[ p112=1 ]
} u27={[ ]
} ]
} i6={[ u26={[ ]
} u25={[ ]
} u24={[ ]
} u22={[ ]
} u23={[ ]
} ]
} i10={[ i1={[ u40={[ ]
} u39={[ ]
} ]
} i0={[ u48={[ p85=1 p87=1 p59=1 p113=1 p57=1 p115=1 p31=1 p141=1 p29=1 p3=1 p1=1 ]
} u42={[ ]
} u41={[ ]
} u38={[ ]
} u36={[ ]
} u37={[ ]
} ]
} ]
} i5={[ u21={[ p84=1 ]
} u20={[ ]
} u19={[ ]
} u18={[ ]
} ]
} i3={[ u44={[ ]
} u13={[ p56=1 ]
} u12={[ ]
} ]
} i1={[ u47={[ ]
} u45={[ ]
} u43={[ ]
} u6={[ p28=1 ]
} u5={[ ]
} ]
} i4={[ u17={[ ]
} u16={[ ]
} u14={[ ]
} u15={[ ]
} ]
} i2={[ u11={[ ]
} u10={[ ]
} u9={[ ]
} u7={[ ]
} u8={[ ]
} ]
} i0={[ u4={[ ]
} u3={[ ]
} u2={[ ]
} u0={[ ]
} u1={[ ]
} ]
} ]
[2020-05-11 13:47:29] [INFO ] Computation of Complete enable matrix. took 151 ms. Total solver calls (SAT/UNSAT): 0(0/0)
[2020-05-11 13:47:29] [INFO ] Computing symmetric co enabling matrix : 595 transitions.
[2020-05-11 13:47:32] [INFO ] Computation of co-enabling matrix(2/595) took 3000 ms. Total solver calls (SAT/UNSAT): 904(904/0)
[2020-05-11 13:47:35] [INFO ] Computation of co-enabling matrix(14/595) took 6052 ms. Total solver calls (SAT/UNSAT): 4438(4438/0)
[2020-05-11 13:47:38] [INFO ] Computation of co-enabling matrix(28/595) took 9145 ms. Total solver calls (SAT/UNSAT): 8379(8379/0)
[2020-05-11 13:47:41] [INFO ] Computation of co-enabling matrix(43/595) took 12347 ms. Total solver calls (SAT/UNSAT): 12594(12594/0)
[2020-05-11 13:47:44] [INFO ] Computation of co-enabling matrix(57/595) took 15489 ms. Total solver calls (SAT/UNSAT): 16619(16619/0)
[2020-05-11 13:47:47] [INFO ] Computation of co-enabling matrix(72/595) took 18615 ms. Total solver calls (SAT/UNSAT): 20714(20714/0)
[2020-05-11 13:47:50] [INFO ] Computation of co-enabling matrix(86/595) took 21716 ms. Total solver calls (SAT/UNSAT): 24823(24823/0)
[2020-05-11 13:47:53] [INFO ] Computation of co-enabling matrix(100/595) took 24744 ms. Total solver calls (SAT/UNSAT): 28736(28736/0)
[2020-05-11 13:47:56] [INFO ] Computation of co-enabling matrix(114/595) took 27756 ms. Total solver calls (SAT/UNSAT): 32698(32698/0)
[2020-05-11 13:47:59] [INFO ] Computation of co-enabling matrix(128/595) took 30788 ms. Total solver calls (SAT/UNSAT): 36709(36709/0)
[2020-05-11 13:48:02] [INFO ] Computation of co-enabling matrix(143/595) took 33805 ms. Total solver calls (SAT/UNSAT): 40824(40824/0)
[2020-05-11 13:48:05] [INFO ] Computation of co-enabling matrix(157/595) took 36852 ms. Total solver calls (SAT/UNSAT): 44919(44919/0)
[2020-05-11 13:48:09] [INFO ] Computation of co-enabling matrix(170/595) took 40055 ms. Total solver calls (SAT/UNSAT): 48546(48546/0)
[2020-05-11 13:48:12] [INFO ] Computation of co-enabling matrix(179/595) took 43256 ms. Total solver calls (SAT/UNSAT): 51210(51210/0)
[2020-05-11 13:48:16] [INFO ] Computation of co-enabling matrix(182/595) took 47152 ms. Total solver calls (SAT/UNSAT): 52449(52449/0)
[2020-05-11 13:48:19] [INFO ] Computation of co-enabling matrix(185/595) took 50376 ms. Total solver calls (SAT/UNSAT): 53679(53679/0)
[2020-05-11 13:48:22] [INFO ] Computation of co-enabling matrix(188/595) took 53562 ms. Total solver calls (SAT/UNSAT): 54900(54900/0)
[2020-05-11 13:48:25] [INFO ] Computation of co-enabling matrix(191/595) took 56740 ms. Total solver calls (SAT/UNSAT): 56112(56112/0)
[2020-05-11 13:48:29] [INFO ] Computation of co-enabling matrix(194/595) took 59971 ms. Total solver calls (SAT/UNSAT): 57315(57315/0)
[2020-05-11 13:48:32] [INFO ] Computation of co-enabling matrix(197/595) took 63270 ms. Total solver calls (SAT/UNSAT): 58509(58509/0)
[2020-05-11 13:48:35] [INFO ] Computation of co-enabling matrix(200/595) took 66532 ms. Total solver calls (SAT/UNSAT): 59694(59694/0)
[2020-05-11 13:48:38] [INFO ] Computation of co-enabling matrix(203/595) took 69706 ms. Total solver calls (SAT/UNSAT): 60870(60870/0)
[2020-05-11 13:48:41] [INFO ] Computation of co-enabling matrix(206/595) took 72812 ms. Total solver calls (SAT/UNSAT): 62037(62037/0)
[2020-05-11 13:48:44] [INFO ] Computation of co-enabling matrix(209/595) took 75867 ms. Total solver calls (SAT/UNSAT): 63195(63195/0)
[2020-05-11 13:48:47] [INFO ] Computation of co-enabling matrix(212/595) took 78870 ms. Total solver calls (SAT/UNSAT): 64344(64344/0)
[2020-05-11 13:48:51] [INFO ] Computation of co-enabling matrix(216/595) took 82818 ms. Total solver calls (SAT/UNSAT): 65862(65862/0)
[2020-05-11 13:48:54] [INFO ] Computation of co-enabling matrix(219/595) took 85865 ms. Total solver calls (SAT/UNSAT): 66990(66990/0)
[2020-05-11 13:48:58] [INFO ] Computation of co-enabling matrix(222/595) took 88923 ms. Total solver calls (SAT/UNSAT): 68109(68109/0)
[2020-05-11 13:49:01] [INFO ] Computation of co-enabling matrix(225/595) took 91926 ms. Total solver calls (SAT/UNSAT): 69219(69219/0)
[2020-05-11 13:49:04] [INFO ] Computation of co-enabling matrix(229/595) took 95825 ms. Total solver calls (SAT/UNSAT): 70685(70685/0)
[2020-05-11 13:49:08] [INFO ] Computation of co-enabling matrix(233/595) took 99626 ms. Total solver calls (SAT/UNSAT): 72135(72135/0)
[2020-05-11 13:49:12] [INFO ] Computation of co-enabling matrix(237/595) took 103401 ms. Total solver calls (SAT/UNSAT): 73569(73569/0)
[2020-05-11 13:49:16] [INFO ] Computation of co-enabling matrix(241/595) took 107200 ms. Total solver calls (SAT/UNSAT): 74987(74987/0)
[2020-05-11 13:49:20] [INFO ] Computation of co-enabling matrix(245/595) took 111006 ms. Total solver calls (SAT/UNSAT): 76389(76389/0)
[2020-05-11 13:49:23] [INFO ] Computation of co-enabling matrix(249/595) took 114721 ms. Total solver calls (SAT/UNSAT): 77775(77775/0)
[2020-05-11 13:49:27] [INFO ] Computation of co-enabling matrix(253/595) took 118443 ms. Total solver calls (SAT/UNSAT): 79145(79145/0)
[2020-05-11 13:49:31] [INFO ] Computation of co-enabling matrix(257/595) took 122180 ms. Total solver calls (SAT/UNSAT): 80499(80499/0)
[2020-05-11 13:49:34] [INFO ] Computation of co-enabling matrix(261/595) took 125682 ms. Total solver calls (SAT/UNSAT): 81837(81837/0)
[2020-05-11 13:49:38] [INFO ] Computation of co-enabling matrix(265/595) took 129150 ms. Total solver calls (SAT/UNSAT): 83159(83159/0)
[2020-05-11 13:49:41] [INFO ] Computation of co-enabling matrix(269/595) took 132695 ms. Total solver calls (SAT/UNSAT): 84465(84465/0)
[2020-05-11 13:49:45] [INFO ] Computation of co-enabling matrix(273/595) took 136244 ms. Total solver calls (SAT/UNSAT): 85755(85755/0)
[2020-05-11 13:49:48] [INFO ] Computation of co-enabling matrix(277/595) took 139666 ms. Total solver calls (SAT/UNSAT): 87029(87029/0)
[2020-05-11 13:49:52] [INFO ] Computation of co-enabling matrix(281/595) took 142982 ms. Total solver calls (SAT/UNSAT): 88287(88287/0)
[2020-05-11 13:49:55] [INFO ] Computation of co-enabling matrix(285/595) took 146248 ms. Total solver calls (SAT/UNSAT): 89529(89529/0)
[2020-05-11 13:49:58] [INFO ] Computation of co-enabling matrix(289/595) took 149531 ms. Total solver calls (SAT/UNSAT): 90755(90755/0)
[2020-05-11 13:50:01] [INFO ] Computation of co-enabling matrix(293/595) took 152743 ms. Total solver calls (SAT/UNSAT): 91965(91965/0)
[2020-05-11 13:50:05] [INFO ] Computation of co-enabling matrix(297/595) took 155945 ms. Total solver calls (SAT/UNSAT): 93159(93159/0)
[2020-05-11 13:50:08] [INFO ] Computation of co-enabling matrix(301/595) took 159063 ms. Total solver calls (SAT/UNSAT): 94337(94337/0)
[2020-05-11 13:50:11] [INFO ] Computation of co-enabling matrix(305/595) took 162110 ms. Total solver calls (SAT/UNSAT): 95499(95499/0)
[2020-05-11 13:50:14] [INFO ] Computation of co-enabling matrix(309/595) took 165125 ms. Total solver calls (SAT/UNSAT): 96645(96645/0)
[2020-05-11 13:50:17] [INFO ] Computation of co-enabling matrix(314/595) took 168831 ms. Total solver calls (SAT/UNSAT): 98055(98055/0)
[2020-05-11 13:50:20] [INFO ] Computation of co-enabling matrix(318/595) took 171878 ms. Total solver calls (SAT/UNSAT): 99165(99165/0)
[2020-05-11 13:50:23] [INFO ] Computation of co-enabling matrix(322/595) took 174888 ms. Total solver calls (SAT/UNSAT): 100259(100259/0)
[2020-05-11 13:50:27] [INFO ] Computation of co-enabling matrix(327/595) took 178475 ms. Total solver calls (SAT/UNSAT): 101604(101604/0)
[2020-05-11 13:50:31] [INFO ] Computation of co-enabling matrix(332/595) took 181965 ms. Total solver calls (SAT/UNSAT): 102924(102924/0)
[2020-05-11 13:50:34] [INFO ] Computation of co-enabling matrix(337/595) took 185368 ms. Total solver calls (SAT/UNSAT): 104219(104219/0)
[2020-05-11 13:50:37] [INFO ] Computation of co-enabling matrix(342/595) took 188697 ms. Total solver calls (SAT/UNSAT): 105489(105489/0)
[2020-05-11 13:50:41] [INFO ] Computation of co-enabling matrix(347/595) took 191985 ms. Total solver calls (SAT/UNSAT): 106734(106734/0)
[2020-05-11 13:50:44] [INFO ] Computation of co-enabling matrix(352/595) took 195218 ms. Total solver calls (SAT/UNSAT): 107954(107954/0)
[2020-05-11 13:50:47] [INFO ] Computation of co-enabling matrix(357/595) took 198408 ms. Total solver calls (SAT/UNSAT): 109149(109149/0)
[2020-05-11 13:50:50] [INFO ] Computation of co-enabling matrix(362/595) took 201544 ms. Total solver calls (SAT/UNSAT): 110319(110319/0)
[2020-05-11 13:50:53] [INFO ] Computation of co-enabling matrix(367/595) took 204713 ms. Total solver calls (SAT/UNSAT): 111464(111464/0)
[2020-05-11 13:50:56] [INFO ] Computation of co-enabling matrix(372/595) took 207813 ms. Total solver calls (SAT/UNSAT): 112584(112584/0)
[2020-05-11 13:51:00] [INFO ] Computation of co-enabling matrix(378/595) took 211327 ms. Total solver calls (SAT/UNSAT): 113895(113895/0)
[2020-05-11 13:51:03] [INFO ] Computation of co-enabling matrix(384/595) took 214727 ms. Total solver calls (SAT/UNSAT): 115170(115170/0)
[2020-05-11 13:51:07] [INFO ] Computation of co-enabling matrix(390/595) took 218069 ms. Total solver calls (SAT/UNSAT): 116409(116409/0)
[2020-05-11 13:51:10] [INFO ] Computation of co-enabling matrix(396/595) took 221356 ms. Total solver calls (SAT/UNSAT): 117612(117612/0)
[2020-05-11 13:51:13] [INFO ] Computation of co-enabling matrix(402/595) took 224490 ms. Total solver calls (SAT/UNSAT): 118779(118779/0)
[2020-05-11 13:51:16] [INFO ] Computation of co-enabling matrix(408/595) took 227554 ms. Total solver calls (SAT/UNSAT): 119910(119910/0)
[2020-05-11 13:51:19] [INFO ] Computation of co-enabling matrix(414/595) took 230630 ms. Total solver calls (SAT/UNSAT): 121005(121005/0)
[2020-05-11 13:51:22] [INFO ] Computation of co-enabling matrix(435/595) took 233638 ms. Total solver calls (SAT/UNSAT): 122512(122512/0)
[2020-05-11 13:51:25] [INFO ] Computation of co-enabling matrix(531/595) took 236644 ms. Total solver calls (SAT/UNSAT): 124877(124877/0)
[2020-05-11 13:51:28] [INFO ] Computation of Finished co-enabling matrix. took 239463 ms. Total solver calls (SAT/UNSAT): 126630(126630/0)
Skipping mayMatrices nes/nds SMT solver raised an error on invariants :(error "Failed to assert expression: java.io.IOException: Stream closed (invariants (select s 2))")
java.lang.RuntimeException: SMT solver raised an error on invariants :(error "Failed to assert expression: java.io.IOException: Stream closed (invariants (select s 2))")
at fr.lip6.move.gal.gal2smt.bmc.KInductionSolver.addKnownInvariants(KInductionSolver.java:460)
at fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver.computeDoNotAccord(NecessaryEnablingsolver.java:574)
at fr.lip6.move.gal.gal2pins.Gal2PinsTransformerNext.printLabels(Gal2PinsTransformerNext.java:538)
at fr.lip6.move.gal.gal2pins.Gal2PinsTransformerNext.printDependencyMatrix(Gal2PinsTransformerNext.java:209)
at fr.lip6.move.gal.gal2pins.Gal2PinsTransformerNext.buildBodyFile(Gal2PinsTransformerNext.java:85)
at fr.lip6.move.gal.gal2pins.Gal2PinsTransformerNext.transform(Gal2PinsTransformerNext.java:831)
at fr.lip6.move.gal.application.LTSminRunner$1.run(LTSminRunner.java:73)
at java.base/java.lang.Thread.run(Thread.java:834)
[2020-05-11 13:51:28] [INFO ] Built C files in 242538ms conformant to PINS in folder :/home/mcc/execution
Running compilation step : CommandLine [args=[gcc, -c, -I/home/mcc/BenchKit//lts_install_dir//include, -I., -std=c99, -fPIC, -O2, model.c], workingDir=/home/mcc/execution]
WARNING : LTS min runner thread was asked to interrupt. Dying gracefully.
BK_STOP 1589205090027
--------------------
content from stderr:
+ export BINDIR=/home/mcc/BenchKit/
+ BINDIR=/home/mcc/BenchKit/
++ pwd
+ export MODEL=/home/mcc/execution
+ MODEL=/home/mcc/execution
+ [[ ReachabilityDeadlock = StateSpace ]]
+ /home/mcc/BenchKit//runeclipse.sh /home/mcc/execution ReachabilityDeadlock -its -ltsminpath /home/mcc/BenchKit//lts_install_dir/ -greatspnpath /home/mcc/BenchKit//greatspn/ -order META -manyOrder -smt -timeout 1800
+ ulimit -s 65536
+ [[ -z '' ]]
+ export LTSMIN_MEM_SIZE=8589934592
+ LTSMIN_MEM_SIZE=8589934592
+ /home/mcc/BenchKit//itstools/its-tools -data /home/mcc/execution/workspace -pnfolder /home/mcc/execution -examination ReachabilityDeadlock -z3path /home/mcc/BenchKit//z3/bin/z3 -yices2path /home/mcc/BenchKit//yices/bin/yices -its -ltsminpath /home/mcc/BenchKit//lts_install_dir/ -greatspnpath /home/mcc/BenchKit//greatspn/ -order META -manyOrder -smt -timeout 1800 -vmargs -Dosgi.locking=none -Declipse.stateSaveDelayInterval=-1 -Dosgi.configuration.area=/tmp/.eclipse -Xss128m -Xms40m -Xmx16000m -Dfile.encoding=UTF-8 -Dosgi.requiredJavaVersion=1.6
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="CloudDeployment-PT-5a"
export BK_EXAMINATION="ReachabilityDeadlock"
export BK_TOOL="itstools"
export BK_RESULT_DIR="/tmp/BK_RESULTS/OUTPUTS"
export BK_TIME_CONFINEMENT="1800"
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 itstools"
echo " Input is CloudDeployment-PT-5a, examination is ReachabilityDeadlock"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 1"
echo " Run identifier is r042-smll-158902051700236"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"
tar xzf /home/mcc/BenchKit/INPUTS/CloudDeployment-PT-5a.tgz
mv CloudDeployment-PT-5a execution
cd execution
if [ "ReachabilityDeadlock" = "ReachabilityDeadlock" ] || [ "ReachabilityDeadlock" = "UpperBounds" ] || [ "ReachabilityDeadlock" = "QuasiLiveness" ] || [ "ReachabilityDeadlock" = "StableMarking" ] || [ "ReachabilityDeadlock" = "Liveness" ] || [ "ReachabilityDeadlock" = "OneSafe" ] || [ "ReachabilityDeadlock" = "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 [ "ReachabilityDeadlock" = "UpperBounds" ] ; then
echo "The expected result is a vector of positive values"
echo NUM_VECTOR
elif [ "ReachabilityDeadlock" != "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 "ReachabilityDeadlock.txt" ] ; then
echo "here is the order used to build the result vector(from text file)"
for x in $(grep Property ReachabilityDeadlock.txt | cut -d ' ' -f 2 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ -f "ReachabilityDeadlock.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 '
echo "FORMULA_NAME $x"
done
elif [ "ReachabilityDeadlock" = "ReachabilityDeadlock" ] || [ "ReachabilityDeadlock" = "QuasiLiveness" ] || [ "ReachabilityDeadlock" = "StableMarking" ] || [ "ReachabilityDeadlock" = "Liveness" ] || [ "ReachabilityDeadlock" = "OneSafe" ] ; then
echo "FORMULA_NAME ReachabilityDeadlock"
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 ;