Execution Chart

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

Trace from the execution

Formatting '/data/fkordon/mcc2019-input.r199-smll-155284912900402.qcow2', fmt=qcow2 size=4294967296 backing_file='/data/fkordon/mcc2019-input.qcow2' encryption=off cluster_size=65536 lazy_refcounts=off
Waiting for the VM to be ready (probing ssh)
.................
=====================================================================
Generated by BenchKit 2-3957
Executing tool itstoolsm
Input is RefineWMG-PT-100100, examination is LTLCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r199-smll-155284912900402
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 388K
-rw-r--r-- 1 mcc users 3.9K Feb 12 14:28 CTLCardinality.txt
-rw-r--r-- 1 mcc users 22K Feb 12 14:28 CTLCardinality.xml
-rw-r--r-- 1 mcc users 2.6K Feb 8 16:23 CTLFireability.txt
-rw-r--r-- 1 mcc users 19K Feb 8 16:23 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.0K Mar 10 17:31 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 5.8K Mar 10 17:31 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 107 Feb 24 15:05 GlobalProperties.txt
-rw-r--r-- 1 mcc users 345 Feb 24 15:05 GlobalProperties.xml
-rw-r--r-- 1 mcc users 2.5K Feb 5 01:08 LTLCardinality.txt
-rw-r--r-- 1 mcc users 12K Feb 5 01:08 LTLCardinality.xml
-rw-r--r-- 1 mcc users 1.9K Feb 4 22:47 LTLFireability.txt
-rw-r--r-- 1 mcc users 9.8K Feb 4 22:47 LTLFireability.xml
-rw-r--r-- 1 mcc users 3.4K Feb 4 16:36 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 17K Feb 4 16:36 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 2.4K Feb 1 12:58 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 13K Feb 1 12:58 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.7K Feb 4 22:30 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.7K Feb 4 22:30 UpperBounds.xml
-rw-r--r-- 1 mcc users 6 Jan 29 09:35 equiv_col
-rw-r--r-- 1 mcc users 7 Jan 29 09:35 instance
-rw-r--r-- 1 mcc users 6 Jan 29 09:35 iscolored
-rw-r--r-- 1 mcc users 217K Mar 10 17:31 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 RefineWMG-PT-100-100-LTLCardinality-00
FORMULA_NAME RefineWMG-PT-100-100-LTLCardinality-01
FORMULA_NAME RefineWMG-PT-100-100-LTLCardinality-02
FORMULA_NAME RefineWMG-PT-100-100-LTLCardinality-03
FORMULA_NAME RefineWMG-PT-100-100-LTLCardinality-04
FORMULA_NAME RefineWMG-PT-100-100-LTLCardinality-05
FORMULA_NAME RefineWMG-PT-100-100-LTLCardinality-06
FORMULA_NAME RefineWMG-PT-100-100-LTLCardinality-07
FORMULA_NAME RefineWMG-PT-100-100-LTLCardinality-08
FORMULA_NAME RefineWMG-PT-100-100-LTLCardinality-09
FORMULA_NAME RefineWMG-PT-100-100-LTLCardinality-10
FORMULA_NAME RefineWMG-PT-100-100-LTLCardinality-11
FORMULA_NAME RefineWMG-PT-100-100-LTLCardinality-12
FORMULA_NAME RefineWMG-PT-100-100-LTLCardinality-13
FORMULA_NAME RefineWMG-PT-100-100-LTLCardinality-14
FORMULA_NAME RefineWMG-PT-100-100-LTLCardinality-15

=== Now, execution of the tool begins

BK_START 1553739574465

Working with output stream class java.io.PrintStream
Using solver Z3 to compute partial order matrices.
Built C files in :
/home/mcc/execution
Running greatSPN : CommandLine [args=[/home/mcc/BenchKit//greatspn//bin/pinvar, /home/mcc/execution/gspn], workingDir=/home/mcc/execution]
Run of greatSPN captured in /home/mcc/execution/outPut.txt
Running greatSPN : CommandLine [args=[/home/mcc/BenchKit//greatspn//bin/RGMEDD2, /home/mcc/execution/gspn, -META, -varord-only], workingDir=/home/mcc/execution]
Run of greatSPN captured in /home/mcc/execution/outPut.txt
Using order generated by GreatSPN with heuristic : META
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.201903251645/bin/its-ltl-linux64, --gc-threshold, 2000000, -i, /home/mcc/execution/LTLCardinality.pnml.gal, -t, CGAL, -LTL, /home/mcc/execution/LTLCardinality.ltl, -c, -stutter-deadlock, --load-order, /home/mcc/execution/model.ord], workingDir=/home/mcc/execution]

its-ltl command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.201903251645/bin/its-ltl-linux64 --gc-threshold 2000000 -i /home/mcc/execution/LTLCardinality.pnml.gal -t CGAL -LTL /home/mcc/execution/LTLCardinality.ltl -c -stutter-deadlock --load-order /home/mcc/execution/model.ord
Read 16 LTL properties
Successfully loaded order from file /home/mcc/execution/model.ord
Checking formula 0 : !((G(("(p349>=2)")U(X("(p494<=p41)")))))
Formula 0 simplified : !G("(p349>=2)" U X"(p494<=p41)")
Presburger conditions satisfied. Using coverability to approximate state space in K-Induction.
// Phase 1: matrix 403 rows 504 cols
invariant :p167 + p168 = 100
invariant :p349 + p350 = 100
invariant :p79 + p80 = 100
invariant :p452 + p453 = 100
invariant :p214 + p215 = 100
invariant :p92 + p93 = 100
invariant :p94 + p95 = 100
invariant :p157 + p158 = 100
invariant :p412 + p413 = 100
invariant :p399 + p400 = 100
invariant :p407 + p408 = 100
invariant :p474 + p475 = 100
invariant :p84 + p85 = 100
invariant :p164 + p165 = 100
invariant :p379 + p380 = 100
invariant :p334 + p335 = 100
invariant :p337 + p338 = 100
invariant :p429 + p430 = 100
invariant :p64 + p65 = 100
invariant :p417 + p418 = 100
invariant :p184 + p185 = 100
invariant :p427 + p428 = 100
invariant :p239 + p240 = 100
invariant :p127 + p128 = 100
invariant :p237 + p238 = 100
invariant :p149 + p150 = 100
invariant :p52 + p53 = 100
invariant :p + pprime + p1 + p6 + p11 + p16 + p21 + p26 + p31 + p36 + p41 + p46 + p51 + p56 + p61 + p66 + p71 + p76 + p81 + p86 + p91 + p96 + p101 + p106 + p111 + p116 + p121 + p126 + p131 + p136 + p141 + p146 + p151 + p156 + p161 + p166 + p171 + p176 + p181 + p186 + p191 + p196 + p201 + p206 + p211 + p216 + p221 + p226 + p231 + p236 + p241 + p246 + p251 + p256 + p261 + p266 + p271 + p276 + p281 + p286 + p291 + p296 + p301 + p306 + p311 + p316 + p321 + p326 + p331 + p336 + p341 + p346 + p351 + p356 + p361 + p366 + p371 + p376 + p381 + p386 + p391 + p396 + p401 + p406 + p411 + p416 + p421 + p426 + p431 + p436 + p441 + p446 + p451 + p456 + p461 + p466 + p471 + p476 + p481 + p486 + p491 + p496 = 7
invariant :p307 + p308 = 100
invariant :p294 + p295 = 100
invariant :p362 + p363 = 100
invariant :p57 + p58 = 100
invariant :p199 + p200 = 100
invariant :p209 + p210 = 100
invariant :p322 + p323 = 100
invariant :p289 + p290 = 100
invariant :p119 + p120 = 100
invariant :p304 + p305 = 100
invariant :p134 + p135 = 100
invariant :p347 + p348 = 100
invariant :p179 + p180 = 100
invariant :p302 + p303 = 100
invariant :p234 + p235 = 100
invariant :p454 + p455 = 100
invariant :p194 + p195 = 100
invariant :p24 + p25 = 100
invariant :p232 + p233 = 100
invariant :p272 + p273 = 100
invariant :p224 + p225 = 100
invariant :p219 + p220 = 100
invariant :p444 + p445 = 100
invariant :p2 + p3 = 100
invariant :p212 + p213 = 100
invariant :p292 + p293 = 100
invariant :p137 + p138 = 100
invariant :p59 + p60 = 100
invariant :p7 + p8 = 100
invariant :p382 + p383 = 100
invariant :p297 + p298 = 100
invariant :p424 + p425 = 100
invariant :p277 + p278 = 100
invariant :p317 + p318 = 100
invariant :p377 + p378 = 100
invariant :p4 + p5 = 100
invariant :p22 + p23 = 100
invariant :p257 + p258 = 100
invariant :p437 + p438 = 100
invariant :p244 + p245 = 100
invariant :p124 + p125 = 100
invariant :p197 + p198 = 100
invariant :p497 + p498 = 100
invariant :p499 + p500 = 100
invariant :p459 + p460 = 100
invariant :p384 + p385 = 100
invariant :p279 + p280 = 100
invariant :p129 + p130 = 100
invariant :p117 + p118 = 100
invariant :p494 + p495 = 100
invariant :psecond + pterce = 5
invariant :p369 + p370 = 100
invariant :p17 + p18 = 100
invariant :p487 + p488 = 100
invariant :p97 + p98 = 100
invariant :p229 + p230 = 100
invariant :p107 + p108 = 100
invariant :p14 + p15 = 100
invariant :p202 + p203 = 100
invariant :p269 + p270 = 100
invariant :p457 + p458 = 100
invariant :p477 + p478 = 100
invariant :p54 + p55 = 100
invariant :p319 + p320 = 100
invariant :p342 + p343 = 100
invariant :p77 + p78 = 100
invariant :p222 + p223 = 100
invariant :p187 + p188 = 100
invariant :p44 + p45 = 100
invariant :p204 + p205 = 100
invariant :p364 + p365 = 100
invariant :p249 + p250 = 100
invariant :p132 + p133 = 100
invariant :p74 + p75 = 100
invariant :p329 + p330 = 100
invariant :p372 + p373 = 100
invariant :p462 + p463 = 100
invariant :p27 + p28 = 100
invariant :p87 + p88 = 100
invariant :p489 + p490 = 100
invariant :p122 + p123 = 100
invariant :p104 + p105 = 100
invariant :p252 + p253 = 100
invariant :p144 + p145 = 100
invariant :p102 + p103 = 100
invariant :p367 + p368 = 100
invariant :p147 + p148 = 100
invariant :p414 + p415 = 100
invariant :p39 + p40 = 100
invariant :p422 + p423 = 100
invariant :p287 + p288 = 100
invariant :p112 + p113 = 100
invariant :p9 + p10 = 100
invariant :p404 + p405 = 100
invariant :p482 + p483 = 100
invariant :p484 + p485 = 100
invariant :p374 + p375 = 100
invariant :p392 + p393 = 100
invariant :p169 + p170 = 100
invariant :p19 + p20 = 100
invariant :p262 + p263 = 100
invariant :p357 + p358 = 100
invariant :p67 + p68 = 100
invariant :p47 + p48 = 100
invariant :p397 + p398 = 100
invariant :p32 + p33 = 100
invariant :p267 + p268 = 100
invariant :p12 + p13 = 100
invariant :p339 + p340 = 100
invariant :p62 + p63 = 100
invariant :p99 + p100 = 100
invariant :p172 + p173 = 100
invariant :p217 + p218 = 100
invariant :p354 + p355 = 100
invariant :p109 + p110 = 100
invariant :p472 + p473 = 100
invariant :p332 + p333 = 100
invariant :p492 + p493 = 100
invariant :p402 + p403 = 100
invariant :p162 + p163 = 100
invariant :p434 + p435 = 100
invariant :p139 + p140 = 100
invariant :p439 + p440 = 100
invariant :p207 + p208 = 100
invariant :p282 + p283 = 100
invariant :p274 + p275 = 100
invariant :p174 + p175 = 100
invariant :p34 + p35 = 100
invariant :p192 + p193 = 100
invariant :p469 + p470 = 100
invariant :p312 + p313 = 100
invariant :p154 + p155 = 100
invariant :p479 + p480 = 100
invariant :p387 + p388 = 100
invariant :p464 + p465 = 100
invariant :p177 + p178 = 100
invariant :p72 + p73 = 100
invariant :p389 + p390 = 100
invariant :p467 + p468 = 100
invariant :p324 + p325 = 100
invariant :p327 + p328 = 100
invariant :p227 + p228 = 100
invariant :p29 + p30 = 100
invariant :p432 + p433 = 100
invariant :p247 + p248 = 100
invariant :p259 + p260 = 100
invariant :p254 + p255 = 100
invariant :p42 + p43 = 100
invariant :p284 + p285 = 100
invariant :p242 + p243 = 100
invariant :p49 + p50 = 100
invariant :p142 + p143 = 100
invariant :p159 + p160 = 100
invariant :p309 + p310 = 100
invariant :p409 + p410 = 100
invariant :p182 + p183 = 100
invariant :p394 + p395 = 100
invariant :p152 + p153 = 100
invariant :p447 + p448 = 100
invariant :p299 + p300 = 100
invariant :p352 + p353 = 100
invariant :p69 + p70 = 100
invariant :p82 + p83 = 100
invariant :p264 + p265 = 100
invariant :p442 + p443 = 100
invariant :p449 + p450 = 100
invariant :p114 + p115 = 100
invariant :p419 + p420 = 100
invariant :p37 + p38 = 100
invariant :p89 + p90 = 100
invariant :p359 + p360 = 100
invariant :p344 + p345 = 100
invariant :p314 + p315 = 100
invariant :p189 + p190 = 100
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]
Compilation finished in 6567 ms.
Running link step : CommandLine [args=[gcc, -shared, -o, gal.so, model.o], workingDir=/home/mcc/execution]
Link finished in 61 ms.
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, --when, --ltl, [](((LTLAP0==true))U(X((LTLAP1==true)))), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 346 ms.
FORMULA RefineWMG-PT-100-100-LTLCardinality-00 FALSE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, --when, --ltl, ((LTLAP2==true))U(X([]((LTLAP3==true)))), --buchi-type=spotba], workingDir=/home/mcc/execution]
WARNING : LTSmin timed out (>225 s) on command CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, --when, --ltl, ((LTLAP2==true))U(X([]((LTLAP3==true)))), --buchi-type=spotba], workingDir=/home/mcc/execution]
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, -p, --pins-guards, --when, --ltl, false, --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 1390 ms.
FORMULA RefineWMG-PT-100-100-LTLCardinality-02 FALSE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, -p, --pins-guards, --when, --ltl, []([](<>(<>((LTLAP4==true))))), --buchi-type=spotba], workingDir=/home/mcc/execution]
WARNING : LTSmin timed out (>225 s) on command CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, -p, --pins-guards, --when, --ltl, []([](<>(<>((LTLAP4==true))))), --buchi-type=spotba], workingDir=/home/mcc/execution]
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, --when, --ltl, X((<>((LTLAP5==true)))U(X((LTLAP6==true)))), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 360 ms.
FORMULA RefineWMG-PT-100-100-LTLCardinality-04 FALSE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, -p, --pins-guards, --when, --ltl, false, --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 1310 ms.
FORMULA RefineWMG-PT-100-100-LTLCardinality-05 FALSE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, -p, --pins-guards, --when, --ltl, <>(((LTLAP7==true))U(<>((LTLAP8==true)))), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 1415 ms.
FORMULA RefineWMG-PT-100-100-LTLCardinality-06 TRUE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, -p, --pins-guards, --when, --ltl, []([]([]((LTLAP9==true)))), --buchi-type=spotba], workingDir=/home/mcc/execution]
WARNING : LTSmin timed out (>225 s) on command CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, -p, --pins-guards, --when, --ltl, []([]([]((LTLAP9==true)))), --buchi-type=spotba], workingDir=/home/mcc/execution]
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, -p, --pins-guards, --when, --ltl, false, --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 1345 ms.
FORMULA RefineWMG-PT-100-100-LTLCardinality-08 FALSE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, -p, --pins-guards, --when, --ltl, true, --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 1208 ms.
FORMULA RefineWMG-PT-100-100-LTLCardinality-09 TRUE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, -p, --pins-guards, --when, --ltl, (((LTLAP10==true))U((LTLAP11==true)))U(<>((LTLAP12==true))), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 1335 ms.
FORMULA RefineWMG-PT-100-100-LTLCardinality-10 TRUE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, -p, --pins-guards, --when, --ltl, ((LTLAP13==true))U(((LTLAP14==true))U((LTLAP15==true))), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 1536 ms.
FORMULA RefineWMG-PT-100-100-LTLCardinality-11 TRUE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, -p, --pins-guards, --when, --ltl, ((LTLAP16==true))U([](<>((LTLAP17==true)))), --buchi-type=spotba], workingDir=/home/mcc/execution]
WARNING : LTSmin timed out (>225 s) on command CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, -p, --pins-guards, --when, --ltl, ((LTLAP16==true))U([](<>((LTLAP17==true)))), --buchi-type=spotba], workingDir=/home/mcc/execution]
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, --when, --ltl, X((LTLAP18==true)), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 416 ms.
FORMULA RefineWMG-PT-100-100-LTLCardinality-13 FALSE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, --when, --ltl, X(X(((LTLAP19==true))U((LTLAP20==true)))), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 268 ms.
FORMULA RefineWMG-PT-100-100-LTLCardinality-14 FALSE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, --when, --ltl, X((LTLAP21==true)), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 577 ms.
FORMULA RefineWMG-PT-100-100-LTLCardinality-15 FALSE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Retrying LTSmin with larger timeout 1800 s
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, --when, --ltl, ((LTLAP2==true))U(X([]((LTLAP3==true)))), --buchi-type=spotba], workingDir=/home/mcc/execution]
Detected timeout of ITS tools.
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.201903251645/bin/its-ltl-linux64, --gc-threshold, 2000000, -i, /home/mcc/execution/LTLCardinality.pnml.gal, -t, CGAL, -LTL, /home/mcc/execution/LTLCardinality.ltl, -c, -stutter-deadlock], workingDir=/home/mcc/execution]

its-ltl command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.201903251645/bin/its-ltl-linux64 --gc-threshold 2000000 -i /home/mcc/execution/LTLCardinality.pnml.gal -t CGAL -LTL /home/mcc/execution/LTLCardinality.ltl -c -stutter-deadlock
Read 4 LTL properties
Checking formula 0 : !((("(p441>=2)")U(X(G("(p8>=1)")))))
Formula 0 simplified : !("(p441>=2)" U XG"(p8>=1)")
WARNING : LTS min runner thread failed on error :java.lang.RuntimeException: Unexpected exception when executing ltsmin :CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, --when, --ltl, ((LTLAP2==true))U(X([]((LTLAP3==true)))), --buchi-type=spotba], workingDir=/home/mcc/execution]
255
Reverse transition relation is exact ! Faster fixpoint algorithm enabled.
Detected timeout of ITS tools.
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.201903251645/bin/its-ltl-linux64, --gc-threshold, 2000000, -i, /home/mcc/execution/LTLCardinality.pnml.gal, -t, CGAL, -LTL, /home/mcc/execution/LTLCardinality.ltl, -c, -stutter-deadlock], workingDir=/home/mcc/execution]

its-ltl command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.201903251645/bin/its-ltl-linux64 --gc-threshold 2000000 -i /home/mcc/execution/LTLCardinality.pnml.gal -t CGAL -LTL /home/mcc/execution/LTLCardinality.ltl -c -stutter-deadlock
Read 4 LTL properties
Checking formula 0 : !((("(p441>=2)")U(X(G("(p8>=1)")))))
Formula 0 simplified : !("(p441>=2)" U XG"(p8>=1)")
Reverse transition relation is exact ! Faster fixpoint algorithm enabled.

BK_TIME_CONFINEMENT_REACHED

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

+ export BINDIR=/home/mcc/BenchKit/
+ BINDIR=/home/mcc/BenchKit/
++ pwd
+ export MODEL=/home/mcc/execution
+ MODEL=/home/mcc/execution
+ [[ LTLCardinality = StateSpace ]]
+ /home/mcc/BenchKit//runeclipse.sh /home/mcc/execution LTLCardinality -its -ltsminpath /home/mcc/BenchKit//lts_install_dir/ -greatspnpath /home/mcc/BenchKit//greatspn/ -order META -manyOrder -smt
+ 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 LTLCardinality -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 -vmargs -Dosgi.locking=none -Declipse.stateSaveDelayInterval=-1 -Dosgi.configuration.area=/tmp/.eclipse -Xss8m -Xms40m -Xmx8192m -Dfile.encoding=UTF-8 -Dosgi.requiredJavaVersion=1.6
Mar 28, 2019 2:19:37 AM fr.lip6.move.gal.application.Application start
INFO: Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, LTLCardinality, -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]
Mar 28, 2019 2:19:37 AM fr.lip6.move.gal.application.MccTranslator transformPNML
INFO: Parsing pnml file : /home/mcc/execution/model.pnml
Mar 28, 2019 2:19:37 AM fr.lip6.move.gal.nupn.PTNetReader loadFromXML
INFO: Load time of PNML (sax parser for PT used): 171 ms
Mar 28, 2019 2:19:37 AM fr.lip6.move.gal.pnml.togal.PTGALTransformer handlePage
INFO: Transformed 504 places.
Mar 28, 2019 2:19:38 AM fr.lip6.move.gal.pnml.togal.PTGALTransformer handlePage
INFO: Transformed 403 transitions.
Mar 28, 2019 2:19:38 AM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/model.pnml.img.gal : 39 ms
Mar 28, 2019 2:19:38 AM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 202 ms
Mar 28, 2019 2:19:38 AM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 102 ms
Mar 28, 2019 2:19:38 AM fr.lip6.move.gal.semantics.DeterministicNextBuilder getDeterministicNext
INFO: Input system was already deterministic with 403 transitions.
Mar 28, 2019 2:19:38 AM fr.lip6.move.gal.semantics.DeterministicNextBuilder getDeterministicNext
INFO: Input system was already deterministic with 403 transitions.
Mar 28, 2019 2:19:38 AM fr.lip6.move.gal.application.StructuralToGreatSPN handlePage
INFO: Transformed 504 places.
Mar 28, 2019 2:19:38 AM fr.lip6.move.gal.application.StructuralToGreatSPN handlePage
INFO: Transformed 403 transitions.
Mar 28, 2019 2:19:38 AM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/LTLCardinality.pnml.gal : 8 ms
Mar 28, 2019 2:19:38 AM fr.lip6.move.serialization.SerializationUtil serializePropertiesForITSLTLTools
INFO: Time to serialize properties into /home/mcc/execution/LTLCardinality.ltl : 2 ms
Mar 28, 2019 2:19:39 AM fr.lip6.move.gal.gal2smt.bmc.KInductionSolver computeAndDeclareInvariants
INFO: Computed 202 place invariants in 316 ms
Mar 28, 2019 2:19:40 AM fr.lip6.move.gal.gal2smt.bmc.KInductionSolver init
INFO: Proved 504 variables to be positive in 1240 ms
Mar 28, 2019 2:19:40 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeAblingMatrix
INFO: Computing symmetric may disable matrix : 403 transitions.
Mar 28, 2019 2:19:40 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of disable matrix completed :0/403 took 1 ms. Total solver calls (SAT/UNSAT): 0(0/0)
Mar 28, 2019 2:19:40 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of Complete disable matrix. took 80 ms. Total solver calls (SAT/UNSAT): 0(0/0)
Mar 28, 2019 2:19:40 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeAblingMatrix
INFO: Computing symmetric may enable matrix : 403 transitions.
Mar 28, 2019 2:19:40 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of Complete enable matrix. took 13 ms. Total solver calls (SAT/UNSAT): 0(0/0)
Mar 28, 2019 2:19:41 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeCoEnablingMatrix
INFO: Computing symmetric co enabling matrix : 403 transitions.
Mar 28, 2019 2:19:43 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(8/403) took 2331 ms. Total solver calls (SAT/UNSAT): 406(406/0)
Mar 28, 2019 2:19:46 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(31/403) took 5806 ms. Total solver calls (SAT/UNSAT): 997(997/0)
Mar 28, 2019 2:19:50 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(55/403) took 9016 ms. Total solver calls (SAT/UNSAT): 1552(1552/0)
Mar 28, 2019 2:19:53 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(75/403) took 12244 ms. Total solver calls (SAT/UNSAT): 1987(1987/0)
Mar 28, 2019 2:19:56 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(87/403) took 15377 ms. Total solver calls (SAT/UNSAT): 2236(2236/0)
Mar 28, 2019 2:19:59 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(115/403) took 18550 ms. Total solver calls (SAT/UNSAT): 2782(2782/0)
Mar 28, 2019 2:20:02 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(146/403) took 21555 ms. Total solver calls (SAT/UNSAT): 3280(3280/0)
Mar 28, 2019 2:20:05 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(175/403) took 24566 ms. Total solver calls (SAT/UNSAT): 3787(3787/0)
Mar 28, 2019 2:20:08 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(211/403) took 27697 ms. Total solver calls (SAT/UNSAT): 4282(4282/0)
Mar 28, 2019 2:20:12 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(255/403) took 30834 ms. Total solver calls (SAT/UNSAT): 4777(4777/0)
Mar 28, 2019 2:20:15 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(311/403) took 33860 ms. Total solver calls (SAT/UNSAT): 5232(5232/0)
Mar 28, 2019 2:20:17 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of Finished co-enabling matrix. took 36549 ms. Total solver calls (SAT/UNSAT): 5552(5552/0)
Mar 28, 2019 2:20:17 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeDoNotAccord
INFO: Computing Do-Not-Accords matrix : 403 transitions.
Mar 28, 2019 2:20:53 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of Completed DNA matrix. took 35237 ms. Total solver calls (SAT/UNSAT): 403(0/403)
Mar 28, 2019 2:20:53 AM fr.lip6.move.gal.gal2pins.Gal2PinsTransformerNext transform
INFO: Built C files in 74567ms conformant to PINS in folder :/home/mcc/execution
Mar 28, 2019 2:39:39 AM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 172 ms
Mar 28, 2019 2:39:39 AM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/LTLCardinality.pnml.gal : 16 ms
Mar 28, 2019 2:39:39 AM fr.lip6.move.serialization.SerializationUtil serializePropertiesForITSLTLTools
INFO: Time to serialize properties into /home/mcc/execution/LTLCardinality.ltl : 4 ms
pins2lts-mc, 0.000: Registering PINS so language module
pins2lts-mc( 0/ 8), 0.001: Loading model from ./gal.so
pins2lts-mc( 1/ 8), 0.001: library has no initializer
pins2lts-mc( 3/ 8), 0.000: library has no initializer
pins2lts-mc( 3/ 8), 0.000: loading model GAL
pins2lts-mc( 4/ 8), 0.001: library has no initializer
pins2lts-mc( 4/ 8), 0.001: loading model GAL
pins2lts-mc( 1/ 8), 0.001: loading model GAL
pins2lts-mc( 0/ 8), 0.002: library has no initializer
pins2lts-mc( 0/ 8), 0.002: loading model GAL
pins2lts-mc( 6/ 8), 0.001: library has no initializer
pins2lts-mc( 6/ 8), 0.001: loading model GAL
pins2lts-mc( 2/ 8), 0.001: library has no initializer
pins2lts-mc( 7/ 8), 0.001: library has no initializer
pins2lts-mc( 2/ 8), 0.002: loading model GAL
pins2lts-mc( 5/ 8), 0.002: library has no initializer
pins2lts-mc( 5/ 8), 0.002: loading model GAL
pins2lts-mc( 7/ 8), 0.002: loading model GAL
pins2lts-mc( 1/ 8), 0.021: completed loading model GAL
pins2lts-mc( 1/ 8), 0.021: LTL layer: formula: ((LTLAP2==true))U(X([]((LTLAP3==true))))
pins2lts-mc( 0/ 8), 0.025: completed loading model GAL
pins2lts-mc( 4/ 8), 0.028: completed loading model GAL
pins2lts-mc( 3/ 8), 0.028: completed loading model GAL
pins2lts-mc( 1/ 8), 0.028: "((LTLAP2==true))U(X([]((LTLAP3==true))))" is not a file, parsing as formula...
pins2lts-mc( 6/ 8), 0.027: completed loading model GAL
pins2lts-mc( 1/ 8), 0.029: Using Spin LTL semantics
pins2lts-mc( 2/ 8), 0.039: completed loading model GAL
pins2lts-mc( 7/ 8), 0.038: completed loading model GAL
pins2lts-mc( 5/ 8), 0.038: completed loading model GAL
pins2lts-mc( 0/ 8), 0.096: There are 426 state labels and 1 edge labels
pins2lts-mc( 0/ 8), 0.096: State length is 505, there are 414 groups
pins2lts-mc( 0/ 8), 0.096: Running cndfs using 8 cores
pins2lts-mc( 0/ 8), 0.096: Using a tree table with 2^27 elements
pins2lts-mc( 0/ 8), 0.096: Successor permutation: dynamic
pins2lts-mc( 0/ 8), 0.096: Global bits: 2, count bits: 0, local bits: 0
pins2lts-mc( 7/ 8), 0.717: [Blue] ~120 levels ~960 states ~101128 transitions
pins2lts-mc( 0/ 8), 1.217: [Blue] ~240 levels ~1920 states ~202728 transitions
pins2lts-mc( 0/ 8), 1.931: [Blue] ~480 levels ~3840 states ~406176 transitions
pins2lts-mc( 0/ 8), 2.919: [Blue] ~960 levels ~7680 states ~813048 transitions
pins2lts-mc( 1/ 8), 4.266: [Blue] ~1920 levels ~15360 states ~1677152 transitions
pins2lts-mc( 0/ 8), 6.423: [Blue] ~3840 levels ~30720 states ~3259496 transitions
pins2lts-mc( 0/ 8), 10.917: [Blue] ~7680 levels ~61440 states ~6522600 transitions
pins2lts-mc( 0/ 8), 20.179: [Blue] ~15360 levels ~122880 states ~13048304 transitions
pins2lts-mc( 0/ 8), 38.106: [Blue] ~30720 levels ~245760 states ~26100856 transitions
pins2lts-mc( 0/ 8), 76.094: [Blue] ~61440 levels ~491520 states ~52153472 transitions
pins2lts-mc( 0/ 8), 152.616: [Blue] ~122880 levels ~983040 states ~104251776 transitions
pins2lts-mc( 7/ 8), 232.213: Error: tree roots table full! Change -s/--ratio.
pins2lts-mc( 0/ 8), 235.472:
pins2lts-mc( 0/ 8), 235.472: Explored 1341271 states 144239452 transitions, fanout: 107.539
pins2lts-mc( 0/ 8), 235.472: Total exploration time 235.360 sec (233.630 sec minimum, 234.605 sec on average)
pins2lts-mc( 0/ 8), 235.472: States per second: 5699, Transitions per second: 612846
pins2lts-mc( 0/ 8), 235.472:
pins2lts-mc( 0/ 8), 235.472: State space has 134217714 states, 0 are accepting
pins2lts-mc( 0/ 8), 235.472: cndfs_1 (permutation: dynamic) stats:
pins2lts-mc( 0/ 8), 235.472: blue states: 1341271 (1.00%), transitions: 0 (per worker)
pins2lts-mc( 0/ 8), 235.472: red states: 0 (0.00%), bogus: 0 (0.00%), transitions: 0, waits: 0 (0.00 sec)
pins2lts-mc( 0/ 8), 235.472: all-red states: 0 (0.00%), bogus 0 (0.00%)
pins2lts-mc( 0/ 8), 235.472:
pins2lts-mc( 0/ 8), 235.472: Total memory used for local state coloring: 20.5MB
pins2lts-mc( 0/ 8), 235.472:
pins2lts-mc( 0/ 8), 235.472: Queue width: 8B, total height: 1341271, memory: 10.23MB
pins2lts-mc( 0/ 8), 235.472: Tree memory: 1083.3MB, 8.5 B/state, compr.: 0.4%
pins2lts-mc( 0/ 8), 235.472: Tree fill ratio (roots/leafs): 99.0%/23.0%
pins2lts-mc( 0/ 8), 235.472: Stored 455 string chucks using 0MB
pins2lts-mc( 0/ 8), 235.472: Total memory used for chunk indexing: 0MB
pins2lts-mc( 0/ 8), 235.472: Est. total memory use: 1093.5MB (~1034.2MB paged-in)
java.lang.RuntimeException: Unexpected exception when executing ltsmin :CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, --when, --ltl, ((LTLAP2==true))U(X([]((LTLAP3==true)))), --buchi-type=spotba], workingDir=/home/mcc/execution]
255
at fr.lip6.move.gal.application.LTSminRunner.checkProperty(LTSminRunner.java:168)
at fr.lip6.move.gal.application.LTSminRunner.access$9(LTSminRunner.java:122)
at fr.lip6.move.gal.application.LTSminRunner$1.run(LTSminRunner.java:98)
at java.lang.Thread.run(Thread.java:748)
Mar 28, 2019 2:59:40 AM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 62 ms
Mar 28, 2019 2:59:40 AM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/LTLCardinality.pnml.gal : 12 ms
Mar 28, 2019 2:59:40 AM fr.lip6.move.serialization.SerializationUtil serializePropertiesForITSLTLTools
INFO: Time to serialize properties into /home/mcc/execution/LTLCardinality.ltl : 1 ms

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="RefineWMG-PT-100100"
export BK_EXAMINATION="LTLCardinality"
export BK_TOOL="itstoolsm"
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-3957"
echo " Executing tool itstoolsm"
echo " Input is RefineWMG-PT-100100, examination is LTLCardinality"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 4"
echo " Run identifier is r199-smll-155284912900402"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

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