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-155284912900412.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-100101, examination is LTLFireability
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r199-smll-155284912900412
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 388K
-rw-r--r-- 1 mcc users 3.8K 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 18K 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 8.6K Feb 4 22:47 LTLFireability.xml
-rw-r--r-- 1 mcc users 3.7K Feb 4 16:37 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 19K Feb 4 16:37 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 2.6K Feb 1 12:58 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 15K 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-101-LTLFireability-00
FORMULA_NAME RefineWMG-PT-100-101-LTLFireability-01
FORMULA_NAME RefineWMG-PT-100-101-LTLFireability-02
FORMULA_NAME RefineWMG-PT-100-101-LTLFireability-03
FORMULA_NAME RefineWMG-PT-100-101-LTLFireability-04
FORMULA_NAME RefineWMG-PT-100-101-LTLFireability-05
FORMULA_NAME RefineWMG-PT-100-101-LTLFireability-06
FORMULA_NAME RefineWMG-PT-100-101-LTLFireability-07
FORMULA_NAME RefineWMG-PT-100-101-LTLFireability-08
FORMULA_NAME RefineWMG-PT-100-101-LTLFireability-09
FORMULA_NAME RefineWMG-PT-100-101-LTLFireability-10
FORMULA_NAME RefineWMG-PT-100-101-LTLFireability-11
FORMULA_NAME RefineWMG-PT-100-101-LTLFireability-12
FORMULA_NAME RefineWMG-PT-100-101-LTLFireability-13
FORMULA_NAME RefineWMG-PT-100-101-LTLFireability-14
FORMULA_NAME RefineWMG-PT-100-101-LTLFireability-15

=== Now, execution of the tool begins

BK_START 1553753753495

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/LTLFireability.pnml.gal, -t, CGAL, -LTL, /home/mcc/execution/LTLFireability.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/LTLFireability.pnml.gal -t CGAL -LTL /home/mcc/execution/LTLFireability.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 : !(((X(X(X("(p409>=1)"))))U("(p257>=1)")))
Formula 0 simplified : !(XXX"(p409>=1)" U "(p257>=1)")
Presburger conditions satisfied. Using coverability to approximate state space in K-Induction.
// Phase 1: matrix 403 rows 504 cols
invariant :p167 + p168 = 101
invariant :p349 + p350 = 101
invariant :p79 + p80 = 101
invariant :p452 + p453 = 101
invariant :p214 + p215 = 101
invariant :p92 + p93 = 101
invariant :p94 + p95 = 101
invariant :p157 + p158 = 101
invariant :p412 + p413 = 101
invariant :p399 + p400 = 101
invariant :p407 + p408 = 101
invariant :p474 + p475 = 101
invariant :p84 + p85 = 101
invariant :p164 + p165 = 101
invariant :p379 + p380 = 101
invariant :p334 + p335 = 101
invariant :p337 + p338 = 101
invariant :p429 + p430 = 101
invariant :p64 + p65 = 101
invariant :p417 + p418 = 101
invariant :p184 + p185 = 101
invariant :p427 + p428 = 101
invariant :p239 + p240 = 101
invariant :p127 + p128 = 101
invariant :p237 + p238 = 101
invariant :p149 + p150 = 101
invariant :p52 + p53 = 101
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 = 101
invariant :p294 + p295 = 101
invariant :p362 + p363 = 101
invariant :p57 + p58 = 101
invariant :p199 + p200 = 101
invariant :p209 + p210 = 101
invariant :p322 + p323 = 101
invariant :p289 + p290 = 101
invariant :p119 + p120 = 101
invariant :p304 + p305 = 101
invariant :p134 + p135 = 101
invariant :p347 + p348 = 101
invariant :p179 + p180 = 101
invariant :p302 + p303 = 101
invariant :p234 + p235 = 101
invariant :p454 + p455 = 101
invariant :p194 + p195 = 101
invariant :p24 + p25 = 101
invariant :p232 + p233 = 101
invariant :p272 + p273 = 101
invariant :p224 + p225 = 101
invariant :p219 + p220 = 101
invariant :p444 + p445 = 101
invariant :p2 + p3 = 101
invariant :p212 + p213 = 101
invariant :p292 + p293 = 101
invariant :p137 + p138 = 101
invariant :p59 + p60 = 101
invariant :p7 + p8 = 101
invariant :p382 + p383 = 101
invariant :p297 + p298 = 101
invariant :p424 + p425 = 101
invariant :p277 + p278 = 101
invariant :p317 + p318 = 101
invariant :p377 + p378 = 101
invariant :p4 + p5 = 101
invariant :p22 + p23 = 101
invariant :p257 + p258 = 101
invariant :p437 + p438 = 101
invariant :p244 + p245 = 101
invariant :p124 + p125 = 101
invariant :p197 + p198 = 101
invariant :p497 + p498 = 101
invariant :p499 + p500 = 101
invariant :p459 + p460 = 101
invariant :p384 + p385 = 101
invariant :p279 + p280 = 101
invariant :p129 + p130 = 101
invariant :p117 + p118 = 101
invariant :p494 + p495 = 101
invariant :psecond + pterce = 5
invariant :p369 + p370 = 101
invariant :p17 + p18 = 101
invariant :p487 + p488 = 101
invariant :p97 + p98 = 101
invariant :p229 + p230 = 101
invariant :p107 + p108 = 101
invariant :p14 + p15 = 101
invariant :p202 + p203 = 101
invariant :p269 + p270 = 101
invariant :p457 + p458 = 101
invariant :p477 + p478 = 101
invariant :p54 + p55 = 101
invariant :p319 + p320 = 101
invariant :p342 + p343 = 101
invariant :p77 + p78 = 101
invariant :p222 + p223 = 101
invariant :p187 + p188 = 101
invariant :p44 + p45 = 101
invariant :p204 + p205 = 101
invariant :p364 + p365 = 101
invariant :p249 + p250 = 101
invariant :p132 + p133 = 101
invariant :p74 + p75 = 101
invariant :p329 + p330 = 101
invariant :p372 + p373 = 101
invariant :p462 + p463 = 101
invariant :p27 + p28 = 101
invariant :p87 + p88 = 101
invariant :p489 + p490 = 101
invariant :p122 + p123 = 101
invariant :p104 + p105 = 101
invariant :p252 + p253 = 101
invariant :p144 + p145 = 101
invariant :p102 + p103 = 101
invariant :p367 + p368 = 101
invariant :p147 + p148 = 101
invariant :p414 + p415 = 101
invariant :p39 + p40 = 101
invariant :p422 + p423 = 101
invariant :p287 + p288 = 101
invariant :p112 + p113 = 101
invariant :p9 + p10 = 101
invariant :p404 + p405 = 101
invariant :p482 + p483 = 101
invariant :p484 + p485 = 101
invariant :p374 + p375 = 101
invariant :p392 + p393 = 101
invariant :p169 + p170 = 101
invariant :p19 + p20 = 101
invariant :p262 + p263 = 101
invariant :p357 + p358 = 101
invariant :p67 + p68 = 101
invariant :p47 + p48 = 101
invariant :p397 + p398 = 101
invariant :p32 + p33 = 101
invariant :p267 + p268 = 101
invariant :p12 + p13 = 101
invariant :p339 + p340 = 101
invariant :p62 + p63 = 101
invariant :p99 + p100 = 101
invariant :p172 + p173 = 101
invariant :p217 + p218 = 101
invariant :p354 + p355 = 101
invariant :p109 + p110 = 101
invariant :p472 + p473 = 101
invariant :p332 + p333 = 101
invariant :p492 + p493 = 101
invariant :p402 + p403 = 101
invariant :p162 + p163 = 101
invariant :p434 + p435 = 101
invariant :p139 + p140 = 101
invariant :p439 + p440 = 101
invariant :p207 + p208 = 101
invariant :p282 + p283 = 101
invariant :p274 + p275 = 101
invariant :p174 + p175 = 101
invariant :p34 + p35 = 101
invariant :p192 + p193 = 101
invariant :p469 + p470 = 101
invariant :p312 + p313 = 101
invariant :p154 + p155 = 101
invariant :p479 + p480 = 101
invariant :p387 + p388 = 101
invariant :p464 + p465 = 101
invariant :p177 + p178 = 101
invariant :p72 + p73 = 101
invariant :p389 + p390 = 101
invariant :p467 + p468 = 101
invariant :p324 + p325 = 101
invariant :p327 + p328 = 101
invariant :p227 + p228 = 101
invariant :p29 + p30 = 101
invariant :p432 + p433 = 101
invariant :p247 + p248 = 101
invariant :p259 + p260 = 101
invariant :p254 + p255 = 101
invariant :p42 + p43 = 101
invariant :p284 + p285 = 101
invariant :p242 + p243 = 101
invariant :p49 + p50 = 101
invariant :p142 + p143 = 101
invariant :p159 + p160 = 101
invariant :p309 + p310 = 101
invariant :p409 + p410 = 101
invariant :p182 + p183 = 101
invariant :p394 + p395 = 101
invariant :p152 + p153 = 101
invariant :p447 + p448 = 101
invariant :p299 + p300 = 101
invariant :p352 + p353 = 101
invariant :p69 + p70 = 101
invariant :p82 + p83 = 101
invariant :p264 + p265 = 101
invariant :p442 + p443 = 101
invariant :p449 + p450 = 101
invariant :p114 + p115 = 101
invariant :p419 + p420 = 101
invariant :p37 + p38 = 101
invariant :p89 + p90 = 101
invariant :p359 + p360 = 101
invariant :p344 + p345 = 101
invariant :p314 + p315 = 101
invariant :p189 + p190 = 101
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 6592 ms.
Running link step : CommandLine [args=[gcc, -shared, -o, gal.so, model.o], workingDir=/home/mcc/execution]
Link finished in 68 ms.
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, --when, --ltl, (X(X(X((LTLAP0==true)))))U((LTLAP1==true)), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 522 ms.
FORMULA RefineWMG-PT-100-101-LTLFireability-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, (<>(X([]((LTLAP2==true)))))U(X((LTLAP3==true))), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 341 ms.
FORMULA RefineWMG-PT-100-101-LTLFireability-01 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, true, --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 1688 ms.
FORMULA RefineWMG-PT-100-101-LTLFireability-02 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, --when, --ltl, X((<>(<>((LTLAP4==true))))U([](<>((LTLAP5==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, X((<>(<>((LTLAP4==true))))U([](<>((LTLAP5==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([](((LTLAP6==true))U((LTLAP7==true))))), --buchi-type=spotba], workingDir=/home/mcc/execution]
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, <>(X([](((LTLAP6==true))U((LTLAP7==true))))), --buchi-type=spotba], workingDir=/home/mcc/execution]
255
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/LTLFireability.pnml.gal, -t, CGAL, -LTL, /home/mcc/execution/LTLFireability.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/LTLFireability.pnml.gal -t CGAL -LTL /home/mcc/execution/LTLFireability.ltl -c -stutter-deadlock
Read 13 LTL properties
Checking formula 0 : !((X((F(F("(p42>=1)")))U(G(F("(p289>=1)"))))))
Formula 0 simplified : !X(F"(p42>=1)" U GF"(p289>=1)")
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/LTLFireability.pnml.gal, -t, CGAL, -LTL, /home/mcc/execution/LTLFireability.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/LTLFireability.pnml.gal -t CGAL -LTL /home/mcc/execution/LTLFireability.ltl -c -stutter-deadlock
Read 13 LTL properties
Checking formula 0 : !((X((F(F("(p42>=1)")))U(G(F("(p289>=1)"))))))
Formula 0 simplified : !X(F"(p42>=1)" U GF"(p289>=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
+ [[ LTLFireability = StateSpace ]]
+ /home/mcc/BenchKit//runeclipse.sh /home/mcc/execution LTLFireability -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 LTLFireability -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 6:15:55 AM fr.lip6.move.gal.application.Application start
INFO: Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, LTLFireability, -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 6:15:55 AM fr.lip6.move.gal.application.MccTranslator transformPNML
INFO: Parsing pnml file : /home/mcc/execution/model.pnml
Mar 28, 2019 6:15:55 AM fr.lip6.move.gal.nupn.PTNetReader loadFromXML
INFO: Load time of PNML (sax parser for PT used): 129 ms
Mar 28, 2019 6:15:55 AM fr.lip6.move.gal.pnml.togal.PTGALTransformer handlePage
INFO: Transformed 504 places.
Mar 28, 2019 6:15:55 AM fr.lip6.move.gal.pnml.togal.PTGALTransformer handlePage
INFO: Transformed 403 transitions.
Mar 28, 2019 6:15:56 AM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/model.pnml.img.gal : 26 ms
Mar 28, 2019 6:15:56 AM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 133 ms
Mar 28, 2019 6:15:56 AM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 105 ms
Mar 28, 2019 6:15:56 AM fr.lip6.move.gal.semantics.DeterministicNextBuilder getDeterministicNext
INFO: Input system was already deterministic with 403 transitions.
Mar 28, 2019 6:15:56 AM fr.lip6.move.gal.semantics.DeterministicNextBuilder getDeterministicNext
INFO: Input system was already deterministic with 403 transitions.
Mar 28, 2019 6:15:56 AM fr.lip6.move.gal.application.StructuralToGreatSPN handlePage
INFO: Transformed 504 places.
Mar 28, 2019 6:15:56 AM fr.lip6.move.gal.application.StructuralToGreatSPN handlePage
INFO: Transformed 403 transitions.
Mar 28, 2019 6:15:56 AM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/LTLFireability.pnml.gal : 6 ms
Mar 28, 2019 6:15:56 AM fr.lip6.move.serialization.SerializationUtil serializePropertiesForITSLTLTools
INFO: Time to serialize properties into /home/mcc/execution/LTLFireability.ltl : 1 ms
Mar 28, 2019 6:15:57 AM fr.lip6.move.gal.gal2smt.bmc.KInductionSolver computeAndDeclareInvariants
INFO: Computed 202 place invariants in 209 ms
Mar 28, 2019 6:15:58 AM fr.lip6.move.gal.gal2smt.bmc.KInductionSolver init
INFO: Proved 504 variables to be positive in 1173 ms
Mar 28, 2019 6:15:58 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeAblingMatrix
INFO: Computing symmetric may disable matrix : 403 transitions.
Mar 28, 2019 6:15:58 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of disable matrix completed :0/403 took 0 ms. Total solver calls (SAT/UNSAT): 0(0/0)
Mar 28, 2019 6:15:58 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of Complete disable matrix. took 49 ms. Total solver calls (SAT/UNSAT): 0(0/0)
Mar 28, 2019 6:15:58 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeAblingMatrix
INFO: Computing symmetric may enable matrix : 403 transitions.
Mar 28, 2019 6:15:58 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of Complete enable matrix. took 12 ms. Total solver calls (SAT/UNSAT): 0(0/0)
Mar 28, 2019 6:15:58 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeCoEnablingMatrix
INFO: Computing symmetric co enabling matrix : 403 transitions.
Mar 28, 2019 6:16:01 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(7/403) took 2503 ms. Total solver calls (SAT/UNSAT): 406(406/0)
Mar 28, 2019 6:16:04 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(31/403) took 5968 ms. Total solver calls (SAT/UNSAT): 997(997/0)
Mar 28, 2019 6:16:08 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(55/403) took 9391 ms. Total solver calls (SAT/UNSAT): 1552(1552/0)
Mar 28, 2019 6:16:11 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(79/403) took 12563 ms. Total solver calls (SAT/UNSAT): 2071(2071/0)
Mar 28, 2019 6:16:14 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(107/403) took 15889 ms. Total solver calls (SAT/UNSAT): 2631(2631/0)
Mar 28, 2019 6:16:17 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(135/403) took 18959 ms. Total solver calls (SAT/UNSAT): 3142(3142/0)
Mar 28, 2019 6:16:21 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(167/403) took 22294 ms. Total solver calls (SAT/UNSAT): 3666(3666/0)
Mar 28, 2019 6:16:24 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(203/403) took 25560 ms. Total solver calls (SAT/UNSAT): 4179(4179/0)
Mar 28, 2019 6:16:27 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(243/403) took 28700 ms. Total solver calls (SAT/UNSAT): 4654(4654/0)
Mar 28, 2019 6:16:30 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(291/403) took 31738 ms. Total solver calls (SAT/UNSAT): 5092(5092/0)
Mar 28, 2019 6:16:33 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(363/403) took 34803 ms. Total solver calls (SAT/UNSAT): 5479(5479/0)
Mar 28, 2019 6:16:34 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of Finished co-enabling matrix. took 35686 ms. Total solver calls (SAT/UNSAT): 5552(5552/0)
Mar 28, 2019 6:16:34 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeDoNotAccord
INFO: Computing Do-Not-Accords matrix : 403 transitions.
Mar 28, 2019 6:17:09 AM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of Completed DNA matrix. took 34602 ms. Total solver calls (SAT/UNSAT): 403(0/403)
Mar 28, 2019 6:17:09 AM fr.lip6.move.gal.gal2pins.Gal2PinsTransformerNext transform
INFO: Built C files in 72808ms conformant to PINS in folder :/home/mcc/execution
pins2lts-mc, 0.000: Registering PINS so language module
pins2lts-mc( 1/ 8), 0.002: library has no initializer
pins2lts-mc( 1/ 8), 0.002: loading model GAL
pins2lts-mc( 2/ 8), 0.002: library has no initializer
pins2lts-mc( 2/ 8), 0.002: loading model GAL
pins2lts-mc( 3/ 8), 0.003: library has no initializer
pins2lts-mc( 3/ 8), 0.003: loading model GAL
pins2lts-mc( 0/ 8), 0.002: Loading model from ./gal.so
pins2lts-mc( 0/ 8), 0.003: library has no initializer
pins2lts-mc( 0/ 8), 0.003: loading model GAL
pins2lts-mc( 7/ 8), 0.001: library has no initializer
pins2lts-mc( 7/ 8), 0.001: loading model GAL
pins2lts-mc( 4/ 8), 0.003: library has no initializer
pins2lts-mc( 4/ 8), 0.003: loading model GAL
pins2lts-mc( 5/ 8), 0.003: library has no initializer
pins2lts-mc( 5/ 8), 0.003: loading model GAL
pins2lts-mc( 6/ 8), 0.003: library has no initializer
pins2lts-mc( 6/ 8), 0.004: loading model GAL
pins2lts-mc( 1/ 8), 0.015: completed loading model GAL
pins2lts-mc( 1/ 8), 0.015: LTL layer: formula: <>(X([](((LTLAP6==true))U((LTLAP7==true)))))
pins2lts-mc( 2/ 8), 0.016: completed loading model GAL
pins2lts-mc( 0/ 8), 0.020: completed loading model GAL
pins2lts-mc( 4/ 8), 0.021: completed loading model GAL
pins2lts-mc( 1/ 8), 0.024: "<>(X([](((LTLAP6==true))U((LTLAP7==true)))))" is not a file, parsing as formula...
pins2lts-mc( 5/ 8), 0.025: completed loading model GAL
pins2lts-mc( 1/ 8), 0.026: Using Spin LTL semantics
pins2lts-mc( 3/ 8), 0.026: completed loading model GAL
pins2lts-mc( 7/ 8), 0.030: completed loading model GAL
pins2lts-mc( 6/ 8), 0.041: completed loading model GAL
pins2lts-mc( 0/ 8), 0.246: There are 425 state labels and 1 edge labels
pins2lts-mc( 0/ 8), 0.246: State length is 505, there are 413 groups
pins2lts-mc( 0/ 8), 0.246: Running cndfs using 8 cores
pins2lts-mc( 0/ 8), 0.246: Using a tree table with 2^27 elements
pins2lts-mc( 0/ 8), 0.246: Successor permutation: dynamic
pins2lts-mc( 0/ 8), 0.246: Global bits: 2, count bits: 0, local bits: 0
pins2lts-mc( 6/ 8), 0.830: [Blue] ~120 levels ~960 states ~101024 transitions
pins2lts-mc( 0/ 8), 1.288: [Blue] ~240 levels ~1920 states ~200360 transitions
pins2lts-mc( 7/ 8), 2.029: [Blue] ~480 levels ~3840 states ~399856 transitions
pins2lts-mc( 7/ 8), 2.840: [Blue] ~960 levels ~7680 states ~800064 transitions
pins2lts-mc( 7/ 8), 3.887: [Blue] ~1920 levels ~15360 states ~1619936 transitions
pins2lts-mc( 7/ 8), 5.694: [Blue] ~3840 levels ~30720 states ~3265392 transitions
pins2lts-mc( 7/ 8), 9.560: [Blue] ~7680 levels ~61440 states ~6546496 transitions
pins2lts-mc( 7/ 8), 17.981: [Blue] ~15360 levels ~122880 states ~13124336 transitions
pins2lts-mc( 3/ 8), 34.911: [Blue] ~30720 levels ~245760 states ~25755840 transitions
pins2lts-mc( 3/ 8), 67.680: [Blue] ~61440 levels ~491520 states ~51839128 transitions
pins2lts-mc( 3/ 8), 136.157: [Blue] ~122880 levels ~983040 states ~103844176 transitions
pins2lts-mc( 4/ 8), 206.252: Error: tree roots table full! Change -s/--ratio.
pins2lts-mc( 0/ 8), 208.831:
pins2lts-mc( 0/ 8), 208.831: Explored 1347822 states 144397115 transitions, fanout: 107.134
pins2lts-mc( 0/ 8), 208.831: Total exploration time 208.570 sec (206.010 sec minimum, 207.031 sec on average)
pins2lts-mc( 0/ 8), 208.831: States per second: 6462, Transitions per second: 692320
pins2lts-mc( 0/ 8), 208.831:
pins2lts-mc( 0/ 8), 208.831: State space has 134217683 states, 0 are accepting
pins2lts-mc( 0/ 8), 208.831: cndfs_1 (permutation: dynamic) stats:
pins2lts-mc( 0/ 8), 208.831: blue states: 1347822 (1.00%), transitions: 0 (per worker)
pins2lts-mc( 0/ 8), 208.831: red states: 0 (0.00%), bogus: 0 (0.00%), transitions: 0, waits: 0 (0.00 sec)
pins2lts-mc( 0/ 8), 208.831: all-red states: 0 (0.00%), bogus 0 (0.00%)
pins2lts-mc( 0/ 8), 208.831:
pins2lts-mc( 0/ 8), 208.831: Total memory used for local state coloring: 20.6MB
pins2lts-mc( 0/ 8), 208.831:
pins2lts-mc( 0/ 8), 208.831: Queue width: 8B, total height: 1347822, memory: 10.28MB
pins2lts-mc( 0/ 8), 208.831: Tree memory: 1143.5MB, 8.9 B/state, compr.: 0.4%
pins2lts-mc( 0/ 8), 208.831: Tree fill ratio (roots/leafs): 99.0%/46.0%
pins2lts-mc( 0/ 8), 208.831: Stored 447 string chucks using 0MB
pins2lts-mc( 0/ 8), 208.831: Total memory used for chunk indexing: 0MB
pins2lts-mc( 0/ 8), 208.831: Est. total memory use: 1153.8MB (~1034.3MB 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, <>(X([](((LTLAP6==true))U((LTLAP7==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:91)
at java.lang.Thread.run(Thread.java:748)
Mar 28, 2019 6:35:57 AM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 58 ms
Mar 28, 2019 6:35:57 AM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/LTLFireability.pnml.gal : 4 ms
Mar 28, 2019 6:35:57 AM fr.lip6.move.serialization.SerializationUtil serializePropertiesForITSLTLTools
INFO: Time to serialize properties into /home/mcc/execution/LTLFireability.ltl : 1 ms
Mar 28, 2019 6:55:57 AM fr.lip6.move.gal.application.MccTranslator applyOrder
INFO: Applying decomposition
Mar 28, 2019 6:55:57 AM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 50 ms
Mar 28, 2019 6:55:57 AM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 50 ms
Mar 28, 2019 6:55:57 AM fr.lip6.move.gal.application.MccTranslator applyOrder
WARNING: Could not apply decomposition. Using flat GAL structure.
java.lang.NullPointerException
at fr.lip6.move.gal.application.MccTranslator.applyOrder(MccTranslator.java:128)
at fr.lip6.move.gal.application.MccTranslator.flattenSpec(MccTranslator.java:156)
at fr.lip6.move.gal.application.Application.runMultiITS(Application.java:427)
at fr.lip6.move.gal.application.Application.start(Application.java:319)
at fr.lip6.move.gal.itscl.application.Application.start(Application.java:40)
at org.eclipse.equinox.internal.app.EclipseAppHandle.run(EclipseAppHandle.java:203)
at org.eclipse.core.runtime.internal.adaptor.EclipseAppLauncher.runApplication(EclipseAppLauncher.java:137)
at org.eclipse.core.runtime.internal.adaptor.EclipseAppLauncher.start(EclipseAppLauncher.java:107)
at org.eclipse.core.runtime.adaptor.EclipseStarter.run(EclipseStarter.java:400)
at org.eclipse.core.runtime.adaptor.EclipseStarter.run(EclipseStarter.java:255)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at org.eclipse.equinox.launcher.Main.invokeFramework(Main.java:659)
at org.eclipse.equinox.launcher.Main.basicRun(Main.java:595)
at org.eclipse.equinox.launcher.Main.run(Main.java:1501)
at org.eclipse.equinox.launcher.Main.main(Main.java:1474)
Mar 28, 2019 6:55:57 AM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 48 ms
Mar 28, 2019 6:55:57 AM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/LTLFireability.pnml.gal : 3 ms
Mar 28, 2019 6:55:57 AM fr.lip6.move.serialization.SerializationUtil serializePropertiesForITSLTLTools
INFO: Time to serialize properties into /home/mcc/execution/LTLFireability.ltl : 0 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-100101"
export BK_EXAMINATION="LTLFireability"
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-100101, examination is LTLFireability"
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-155284912900412"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

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