Execution Chart

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

Trace from the execution

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

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 7.4M
-rw-r--r-- 1 mcc users 50K May 15 08:57 CTLCardinality.txt
-rw-r--r-- 1 mcc users 176K May 15 08:57 CTLCardinality.xml
-rw-r--r-- 1 mcc users 25K May 15 08:57 CTLFireability.txt
-rw-r--r-- 1 mcc users 84K May 15 08:57 CTLFireability.xml
-rw-r--r-- 1 mcc users 5.6K May 12 07:58 LTLCardinality.txt
-rw-r--r-- 1 mcc users 24K May 12 07:58 LTLCardinality.xml
-rw-r--r-- 1 mcc users 4.0K May 12 07:58 LTLFireability.txt
-rw-r--r-- 1 mcc users 18K May 12 07:58 LTLFireability.xml
-rw-r--r-- 1 mcc users 1 May 12 08:13 NewModel
-rw-r--r-- 1 mcc users 5.7K May 11 18:47 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 20K May 11 18:47 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 4.0K May 11 15:52 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 15K May 11 15:52 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 2.0K May 12 04:40 UpperBounds.txt
-rw-r--r-- 1 mcc users 4.1K May 12 04:40 UpperBounds.xml
-rw-r--r-- 1 mcc users 6 May 12 08:13 equiv_col
-rw-r--r-- 1 mcc users 7 May 12 08:13 instance
-rw-r--r-- 1 mcc users 6 May 12 08:13 iscolored
-rw-r--r-- 1 mcc users 6.9M May 12 08:13 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 StableMarking

=== Now, execution of the tool begins

BK_START 1621322016221

Running Version 0
[2021-05-18 07:13:37] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, StableMarking, -spotpath, /home/mcc/BenchKit/bin//..//ltlfilt, -z3path, /home/mcc/BenchKit/bin//..//z3/bin/z3, -yices2path, /home/mcc/BenchKit/bin//..//yices/bin/yices, -its, -ltsmin, -greatspnpath, /home/mcc/BenchKit/bin//..//greatspn/, -order, META, -manyOrder, -smt, -timeout, 1800]
[2021-05-18 07:13:37] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2021-05-18 07:13:38] [INFO ] Load time of PNML (sax parser for PT used): 388 ms
[2021-05-18 07:13:38] [INFO ] Transformed 3606 places.
[2021-05-18 07:13:38] [INFO ] Transformed 5141 transitions.
[2021-05-18 07:13:38] [INFO ] Parsed PT model containing 3606 places and 5141 transitions in 485 ms.
Incomplete random walk after 10000 steps, including 317 resets, run finished after 998 ms. (steps per millisecond=10 ) properties (out of 3606) seen :2167
Running SMT prover for 1439 properties.
[2021-05-18 07:13:39] [INFO ] Flow matrix only has 4869 transitions (discarded 272 similar events)
// Phase 1: matrix 4869 rows 3606 cols
[2021-05-18 07:13:40] [INFO ] Computed 459 place invariants in 485 ms
[2021-05-18 07:14:05] [WARNING] SMT solver failed with error :SMT solver raised an error when submitting script.... while checking expressions.
Fused 1439 Parikh solutions to 1 different solutions.
Support contains 1439 out of 3606 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 3606/3606 places, 5141/5141 transitions.
Graph (complete) has 12103 edges and 3606 vertex of which 3580 are kept as prefixes of interest. Removing 26 places using SCC suffix rule.19 ms
Discarding 26 places :
Also discarding 0 output transitions
Drop transitions removed 465 transitions
Trivial Post-agglo rules discarded 465 transitions
Performed 465 trivial Post agglomeration. Transition count delta: 465
Iterating post reduction 0 with 465 rules applied. Total rules applied 466 place count 3580 transition count 4676
Reduce places removed 465 places and 0 transitions.
Iterating post reduction 1 with 465 rules applied. Total rules applied 931 place count 3115 transition count 4676
Performed 96 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 2 with 96 Pre rules applied. Total rules applied 931 place count 3115 transition count 4580
Deduced a syphon composed of 96 places in 3 ms
Reduce places removed 96 places and 0 transitions.
Iterating global reduction 2 with 192 rules applied. Total rules applied 1123 place count 3019 transition count 4580
Discarding 369 places :
Symmetric choice reduction at 2 with 369 rule applications. Total rules 1492 place count 2650 transition count 4211
Iterating global reduction 2 with 369 rules applied. Total rules applied 1861 place count 2650 transition count 4211
Discarding 10 places :
Symmetric choice reduction at 2 with 10 rule applications. Total rules 1871 place count 2640 transition count 4181
Iterating global reduction 2 with 10 rules applied. Total rules applied 1881 place count 2640 transition count 4181
Performed 2 Post agglomeration using F-continuation condition.Transition count delta: 2
Deduced a syphon composed of 2 places in 3 ms
Reduce places removed 2 places and 0 transitions.
Iterating global reduction 2 with 4 rules applied. Total rules applied 1885 place count 2638 transition count 4179
Free-agglomeration rule (complex) applied 268 times.
Iterating global reduction 2 with 268 rules applied. Total rules applied 2153 place count 2638 transition count 3931
Reduce places removed 268 places and 0 transitions.
Iterating post reduction 2 with 268 rules applied. Total rules applied 2421 place count 2370 transition count 3931
Partial Free-agglomeration rule applied 96 times.
Drop transitions removed 96 transitions
Iterating global reduction 3 with 96 rules applied. Total rules applied 2517 place count 2370 transition count 3931
Applied a total of 2517 rules in 1002 ms. Remains 2370 /3606 variables (removed 1236) and now considering 3931/5141 (removed 1210) transitions.
Finished structural reductions, in 1 iterations. Remains : 2370/3606 places, 3931/5141 transitions.
[2021-05-18 07:14:06] [INFO ] Flatten gal took : 381 ms
[2021-05-18 07:14:07] [INFO ] Flatten gal took : 202 ms
[2021-05-18 07:14:07] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality4848418784095805176.gal : 61 ms
[2021-05-18 07:14:07] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality8929221570310449567.prop : 5 ms
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-reach-linux64, --gc-threshold, 2000000, --quiet, -i, /tmp/ReachabilityCardinality4848418784095805176.gal, -t, CGAL, -reachable-file, /tmp/ReachabilityCardinality8929221570310449567.prop, --nowitness, --gen-order, FOLLOW], workingDir=/home/mcc/execution]

its-reach command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-reach-linux64 --gc-threshold 2000000 --quiet -i /tmp/ReachabilityCardinality4848418784095805176.gal -t CGAL -reachable-file /tmp/ReachabilityCardinality8929221570310449567.prop --nowitness --gen-order FOLLOW
Loading property file /tmp/ReachabilityCardinality8929221570310449567.prop.
SDD proceeding with computation,1439 properties remain. new max is 4
SDD size :1 after 8
SDD proceeding with computation,1439 properties remain. new max is 8
SDD size :8 after 12
Detected timeout of ITS tools.
[2021-05-18 07:14:22] [INFO ] Flatten gal took : 169 ms
[2021-05-18 07:14:22] [INFO ] Applying decomposition
[2021-05-18 07:14:22] [INFO ] Flatten gal took : 206 ms
Converted graph to binary with : CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202104292328/bin/convert-linux64, -i, /tmp/graph7932927838361421856.txt, -o, /tmp/graph7932927838361421856.bin, -w, /tmp/graph7932927838361421856.weights], workingDir=null]
Built communities with : CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202104292328/bin/louvain-linux64, /tmp/graph7932927838361421856.bin, -l, -1, -v, -w, /tmp/graph7932927838361421856.weights, -q, 0, -e, 0.001], workingDir=null]
[2021-05-18 07:14:23] [INFO ] Decomposing Gal with order
[2021-05-18 07:14:23] [INFO ] Rewriting arrays to variables to allow decomposition.
[2021-05-18 07:14:24] [INFO ] Removed a total of 3933 redundant transitions.
[2021-05-18 07:14:24] [INFO ] Flatten gal took : 1058 ms
[2021-05-18 07:14:25] [INFO ] Fuse similar labels procedure discarded/fused a total of 1432 labels/synchronizations in 265 ms.
[2021-05-18 07:14:25] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality17932543883783679247.gal : 40 ms
[2021-05-18 07:14:25] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality13209830230810451054.prop : 3 ms
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-reach-linux64, --gc-threshold, 2000000, --quiet, -i, /tmp/ReachabilityCardinality17932543883783679247.gal, -t, CGAL, -reachable-file, /tmp/ReachabilityCardinality13209830230810451054.prop, --nowitness], workingDir=/home/mcc/execution]

its-reach command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-reach-linux64 --gc-threshold 2000000 --quiet -i /tmp/ReachabilityCardinality17932543883783679247.gal -t CGAL -reachable-file /tmp/ReachabilityCardinality13209830230810451054.prop --nowitness
Loading property file /tmp/ReachabilityCardinality13209830230810451054.prop.
Invariant property smplace_2256 does not hold.
Invariant property smplace_2254 does not hold.
SDD proceeding with computation,1437 properties remain. new max is 2
SDD size :1 after 61
Invariant property smplace_1225 does not hold.
Invariant property smplace_1224 does not hold.
Invariant property smplace_1222 does not hold.
SDD proceeding with computation,1434 properties remain. new max is 2
SDD size :61 after 72
SDD proceeding with computation,1434 properties remain. new max is 4
SDD size :72 after 81
SDD proceeding with computation,1434 properties remain. new max is 8
SDD size :81 after 86
SDD proceeding with computation,1434 properties remain. new max is 16
SDD size :86 after 86
SDD proceeding with computation,1434 properties remain. new max is 32
SDD size :86 after 86
SDD proceeding with computation,1434 properties remain. new max is 64
SDD size :86 after 86
SDD proceeding with computation,1434 properties remain. new max is 128
SDD size :86 after 86
SDD proceeding with computation,1434 properties remain. new max is 256
SDD size :86 after 86
SDD proceeding with computation,1434 properties remain. new max is 512
SDD size :86 after 86
SDD proceeding with computation,1434 properties remain. new max is 1024
SDD size :86 after 86
Invariant property smplace_1343 does not hold.
Invariant property smplace_1341 does not hold.
Invariant property smplace_920 does not hold.
Invariant property smplace_918 does not hold.
SDD proceeding with computation,1430 properties remain. new max is 1024
SDD size :86 after 156
Detected timeout of ITS tools.
Built C files in :
/tmp/ltsmin9258914169350866233
[2021-05-18 07:14:40] [INFO ] Built C files in 73ms conformant to PINS (ltsmin variant)in folder :/tmp/ltsmin9258914169350866233
Running compilation step : CommandLine [args=[gcc, -c, -I/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202104292328/bin/include/, -I., -std=c99, -fPIC, -O2, model.c], workingDir=/tmp/ltsmin9258914169350866233]
WARNING : LTS min runner thread failed on error :java.lang.RuntimeException: Compilation or link of executable timed out.java.util.concurrent.TimeoutException: Subprocess running CommandLine [args=[gcc, -c, -I/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202104292328/bin/include/, -I., -std=c99, -fPIC, -O2, model.c], workingDir=/tmp/ltsmin9258914169350866233] killed by timeout after 1 SECONDS
java.lang.RuntimeException: Compilation or link of executable timed out.java.util.concurrent.TimeoutException: Subprocess running CommandLine [args=[gcc, -c, -I/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202104292328/bin/include/, -I., -std=c99, -fPIC, -O2, model.c], workingDir=/tmp/ltsmin9258914169350866233] killed by timeout after 1 SECONDS
at fr.lip6.move.gal.application.LTSminRunner$1.run(LTSminRunner.java:79)
at java.base/java.lang.Thread.run(Thread.java:834)
Interrupted random walk after 733835 steps, including 35097 resets, run timeout after 30001 ms. (steps per millisecond=24 ) properties seen :{3=1, 4=1, 8=1, 9=1, 15=1, 16=1, 24=1, 25=1, 35=1, 36=1, 37=1, 38=1, 50=1, 51=1, 52=1, 53=1, 65=1, 66=1, 78=1, 79=1, 80=1, 81=1, 82=1, 106=1, 107=1, 108=1, 118=1, 119=1, 120=1, 121=1, 122=1, 123=1, 131=1, 132=1, 133=1, 134=1, 140=1, 141=1, 142=1, 143=1, 147=1, 148=1, 149=1, 150=1, 152=1, 153=1, 156=1, 157=1, 159=1, 160=1, 161=1, 162=1, 166=1, 167=1, 173=1, 174=1, 182=1, 183=1, 193=1, 194=1, 195=1, 206=1, 207=1, 208=1, 209=1, 219=1, 220=1, 221=1, 222=1, 223=1, 224=1, 234=1, 235=1, 245=1, 246=1, 254=1, 255=1, 261=1, 262=1, 263=1, 264=1, 268=1, 269=1, 271=1, 272=1, 273=1, 274=1, 275=1, 276=1, 277=1, 278=1, 279=1, 280=1, 283=1, 284=1, 285=1, 286=1, 287=1, 288=1, 290=1, 291=1, 295=1, 296=1, 302=1, 303=1, 311=1, 312=1, 313=1, 321=1, 322=1, 323=1, 324=1, 325=1, 326=1, 334=1, 335=1, 336=1, 337=1, 338=1, 359=1, 360=1, 364=1, 365=1, 367=1, 368=1, 369=1, 370=1, 371=1, 372=1, 373=1, 374=1, 375=1, 376=1, 377=1, 378=1, 381=1, 382=1, 383=1, 384=1, 385=1, 386=1, 388=1, 389=1, 390=1, 391=1, 395=1, 396=1, 397=1, 398=1, 404=1, 405=1, 406=1, 407=1, 408=1, 409=1, 416=1, 417=1, 418=1, 419=1, 420=1, 421=1, 422=1, 423=1, 429=1, 430=1, 431=1, 432=1, 433=1, 434=1, 440=1, 441=1, 442=1, 443=1, 449=1, 450=1, 454=1, 455=1, 457=1, 458=1, 459=1, 460=1, 461=1, 462=1, 463=1, 464=1, 465=1, 466=1, 467=1, 468=1, 469=1, 470=1, 471=1, 474=1, 475=1, 476=1, 477=1, 478=1, 479=1, 480=1, 481=1, 482=1, 483=1, 485=1, 486=1, 487=1, 488=1, 492=1, 493=1, 494=1, 499=1, 500=1, 501=1, 502=1, 506=1, 507=1, 508=1, 512=1, 513=1, 517=1, 518=1, 520=1, 521=1, 522=1, 523=1, 524=1, 525=1, 526=1, 527=1, 528=1, 529=1, 530=1, 531=1, 532=1, 533=1, 534=1, 535=1, 536=1, 537=1, 540=1, 541=1, 542=1, 543=1, 544=1, 545=1, 546=1, 547=1, 548=1, 549=1, 550=1, 551=1, 553=1, 554=1, 555=1, 556=1, 557=1, 560=1, 561=1, 562=1, 563=1, 564=1, 566=1, 567=1, 568=1, 569=1, 570=1, 571=1, 572=1, 575=1, 576=1, 578=1, 579=1, 580=1, 581=1, 582=1, 583=1, 584=1, 585=1, 586=1, 587=1, 588=1, 589=1, 590=1, 591=1, 592=1, 593=1, 594=1, 595=1, 596=1, 597=1, 598=1, 599=1, 600=1, 601=1, 602=1, 603=1, 604=1, 605=1, 606=1, 607=1, 608=1, 609=1, 610=1, 611=1, 612=1, 613=1, 614=1, 615=1, 616=1, 617=1, 618=1, 619=1, 620=1, 621=1, 622=1, 623=1, 624=1, 625=1, 626=1, 627=1, 628=1, 629=1, 630=1, 631=1, 632=1, 633=1, 634=1, 635=1, 636=1, 637=1, 638=1, 639=1, 640=1, 641=1, 642=1, 643=1, 644=1, 645=1, 646=1, 647=1, 648=1, 649=1, 650=1, 651=1, 652=1, 653=1, 654=1, 655=1, 656=1, 657=1, 658=1, 659=1, 660=1, 661=1, 662=1, 663=1, 664=1, 665=1, 666=1, 667=1, 668=1, 669=1, 670=1, 671=1, 672=1, 673=1, 674=1, 675=1, 676=1, 677=1, 678=1, 679=1, 680=1, 681=1, 682=1, 683=1, 684=1, 685=1, 686=1, 687=1, 688=1, 689=1, 690=1, 692=1, 693=1, 694=1, 695=1, 696=1, 697=1, 698=1, 699=1, 700=1, 701=1, 702=1, 703=1, 704=1, 705=1, 706=1, 707=1, 708=1, 709=1, 710=1, 711=1, 712=1, 713=1, 714=1, 715=1, 716=1, 717=1, 718=1, 719=1, 720=1, 721=1, 722=1, 723=1, 724=1, 725=1, 726=1, 727=1, 728=1, 729=1, 730=1, 731=1, 732=1, 733=1, 734=1, 735=1, 736=1, 737=1, 738=1, 739=1, 740=1, 741=1, 742=1, 743=1, 744=1, 745=1, 746=1, 747=1, 748=1, 749=1, 750=1, 751=1, 752=1, 753=1, 754=1, 755=1, 756=1, 757=1, 758=1, 759=1, 760=1, 761=1, 762=1, 763=1, 764=1, 765=1, 766=1, 767=1, 768=1, 769=1, 770=1, 771=1, 772=1, 773=1, 774=1, 775=1, 776=1, 777=1, 778=1, 779=1, 780=1, 781=1, 782=1, 783=1, 784=1, 785=1, 786=1, 787=1, 788=1, 789=1, 790=1, 791=1, 792=1, 793=1, 794=1, 795=1, 796=1, 797=1, 798=1, 799=1, 800=1, 801=1, 802=1, 803=1, 804=1, 805=1, 806=1, 807=1, 808=1, 809=1, 810=1, 811=1, 812=1, 813=1, 814=1, 815=1, 816=1, 817=1, 818=1, 819=1, 820=1, 821=1, 822=1, 823=1, 824=1, 825=1, 826=1, 827=1, 828=1, 829=1, 830=1, 831=1, 834=1, 835=1, 836=1, 837=1, 838=1, 839=1, 840=1, 841=1, 842=1, 843=1, 844=1, 845=1, 846=1, 847=1, 848=1, 849=1, 850=1, 851=1, 853=1, 854=1, 855=1, 856=1, 857=1, 859=1, 860=1, 861=1, 862=1, 864=1, 865=1, 866=1, 867=1, 868=1, 870=1, 871=1, 872=1, 873=1, 874=1, 875=1, 877=1, 878=1, 879=1, 880=1, 881=1, 882=1, 883=1, 884=1, 885=1, 886=1, 887=1, 888=1, 889=1, 890=1, 893=1, 894=1, 895=1, 896=1, 898=1, 899=1, 903=1, 904=1, 905=1, 906=1, 907=1, 912=1, 913=1, 914=1, 915=1, 919=1, 920=1, 921=1, 922=1, 926=1, 927=1, 931=1, 932=1, 934=1, 935=1, 936=1, 937=1, 938=1, 939=1, 940=1, 941=1, 942=1, 943=1, 944=1, 945=1, 948=1, 949=1, 950=1, 951=1, 952=1, 953=1, 954=1, 955=1, 956=1, 957=1, 958=1, 959=1, 960=1, 961=1, 963=1, 964=1, 968=1, 969=1, 975=1, 976=1, 977=1, 978=1, 984=1, 985=1, 986=1, 987=1, 988=1, 989=1, 995=1, 996=1, 997=1, 1004=1, 1005=1, 1006=1, 1007=1, 1013=1, 1014=1, 1019=1, 1020=1, 1021=1, 1022=1, 1023=1, 1024=1, 1025=1, 1026=1, 1027=1, 1028=1, 1029=1, 1030=1, 1033=1, 1034=1, 1035=1, 1036=1, 1038=1, 1039=1, 1043=1, 1044=1, 1045=1, 1046=1, 1052=1, 1053=1, 1061=1, 1070=1, 1071=1, 1072=1, 1081=1, 1082=1, 1083=1, 1084=1, 1093=1, 1094=1, 1102=1, 1103=1, 1104=1, 1105=1, 1111=1, 1112=1, 1113=1, 1114=1, 1118=1, 1119=1, 1120=1, 1121=1, 1123=1, 1124=1, 1125=1, 1126=1, 1127=1, 1128=1, 1131=1, 1132=1, 1133=1, 1134=1, 1135=1, 1136=1, 1138=1, 1139=1, 1143=1, 1144=1, 1150=1, 1151=1, 1152=1, 1153=1, 1161=1, 1162=1, 1172=1, 1173=1, 1174=1, 1175=1, 1185=1, 1186=1, 1187=1, 1188=1, 1189=1, 1190=1, 1200=1, 1201=1, 1202=1, 1203=1, 1204=1, 1205=1, 1215=1, 1216=1, 1217=1, 1218=1, 1228=1, 1229=1, 1230=1, 1231=1, 1239=1, 1240=1, 1241=1, 1242=1, 1248=1, 1249=1, 1253=1, 1254=1, 1256=1, 1257=1, 1258=1, 1259=1, 1260=1, 1261=1, 1262=1, 1263=1, 1264=1, 1265=1, 1268=1, 1269=1, 1279=1, 1280=1, 1281=1, 1282=1, 1283=1, 1284=1, 1285=1, 1293=1, 1294=1, 1295=1, 1296=1, 1297=1, 1298=1, 1308=1, 1309=1, 1310=1, 1311=1, 1323=1, 1324=1, 1325=1, 1326=1, 1338=1, 1339=1, 1340=1, 1341=1, 1342=1, 1343=1, 1355=1, 1356=1, 1357=1, 1358=1, 1359=1, 1372=1, 1373=1, 1385=1, 1386=1, 1403=1, 1404=1, 1410=1, 1411=1, 1412=1, 1413=1, 1417=1, 1418=1, 1420=1, 1421=1, 1422=1, 1423=1, 1424=1, 1425=1, 1426=1, 1427=1, 1428=1, 1429=1}
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 7 ms. (steps per millisecond=143 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1000 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1000 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1000 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 16 ms. (steps per millisecond=62 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 20 ms. (steps per millisecond=50 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1000 steps, including 8 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1000 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 618) seen :0
Running SMT prover for 618 properties.
[2021-05-18 07:15:11] [INFO ] Flow matrix only has 3641 transitions (discarded 290 similar events)
// Phase 1: matrix 3641 rows 2370 cols
[2021-05-18 07:15:12] [INFO ] Computed 433 place invariants in 221 ms
[2021-05-18 07:15:33] [INFO ] SMT Verify possible in real domain returnedunsat :0 sat :0 real:618
[2021-05-18 07:15:50] [INFO ] [Nat]Absence check using 33 positive place invariants in 60 ms returned sat
[2021-05-18 07:15:50] [INFO ] [Nat]Absence check using 33 positive and 400 generalized place invariants in 100 ms returned sat
[2021-05-18 07:16:10] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2021-05-18 07:17:12] [INFO ] [Nat]Absence check using state equation in 61834 ms returned unsat :0 sat :618
[2021-05-18 07:17:12] [INFO ] State equation strengthened by 1379 read => feed constraints.
[2021-05-18 07:17:12] [INFO ] [Nat]Added 1379 Read/Feed constraints in 96 ms returned sat
Attempting to minimize the solution found.
Minimization took 26897 ms.
[2021-05-18 07:18:47] [INFO ] SMT Verify possible in nat domain returned unsat :508 sat :110
FORMULA StableMarking TRUE TECHNIQUES RANDOM_WALK STRUCTURAL_REDUCTION DECISION_DIAGRAMS COLLATERAL_PROCESSING TOPOLOGICAL USE_NUPN SAT_SMT

BK_STOP 1621322328476

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

+ export BINDIR=/home/mcc/BenchKit/bin//../
+ BINDIR=/home/mcc/BenchKit/bin//../
++ pwd
+ export MODEL=/home/mcc/execution
+ MODEL=/home/mcc/execution
+ [[ StableMarking = StateSpace ]]
+ /home/mcc/BenchKit/bin//..//runeclipse.sh /home/mcc/execution StableMarking -its -ltsmin -greatspnpath /home/mcc/BenchKit/bin//..//greatspn/ -order META -manyOrder -smt -timeout 1800
+ ulimit -s 65536
+ [[ -z '' ]]
+ export LTSMIN_MEM_SIZE=8589934592
+ LTSMIN_MEM_SIZE=8589934592
++ cut -d . -f 9
++ ls /home/mcc/BenchKit/bin//..//itstools/plugins/fr.lip6.move.gal.application.pnmcc_1.0.0.202104292328.jar
+ VERSION=0
+ echo 'Running Version 0'
+ /home/mcc/BenchKit/bin//..//itstools/its-tools -data /home/mcc/execution/workspace -pnfolder /home/mcc/execution -examination StableMarking -spotpath /home/mcc/BenchKit/bin//..//ltlfilt -z3path /home/mcc/BenchKit/bin//..//z3/bin/z3 -yices2path /home/mcc/BenchKit/bin//..//yices/bin/yices -its -ltsmin -greatspnpath /home/mcc/BenchKit/bin//..//greatspn/ -order META -manyOrder -smt -timeout 1800 -vmargs -Dosgi.locking=none -Declipse.stateSaveDelayInterval=-1 -Dosgi.configuration.area=/tmp/.eclipse -Xss128m -Xms40m -Xmx16000m

Sequence of Actions to be Executed by the VM

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

set -x
# this is for BenchKit: configuration of major elements for the test
export BK_INPUT="MultiCrashLeafsetExtension-PT-S16C03"
export BK_EXAMINATION="StableMarking"
export BK_TOOL="itstools"
export BK_RESULT_DIR="/tmp/BK_RESULTS/OUTPUTS"
export BK_TIME_CONFINEMENT="1800"
export BK_MEMORY_CONFINEMENT="16384"
export BK_BIN_PATH="/home/mcc/BenchKit/bin/"

# this is specific to your benchmark or test

export BIN_DIR="$HOME/BenchKit/bin"

# remove the execution directoty if it exists (to avoid increse of .vmdk images)
if [ -d execution ] ; then
rm -rf execution
fi

# this is for BenchKit: explicit launching of the test
echo "====================================================================="
echo " Generated by BenchKit 2-4028"
echo " Executing tool itstools"
echo " Input is MultiCrashLeafsetExtension-PT-S16C03, examination is StableMarking"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 4"
echo " Run identifier is r299-tall-162124165100363"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

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