About the Execution of ITS-Tools for PolyORBNT-PT-S05J40
| Execution Summary | |||||
| Max Memory Used (MB) |
Time wait (ms) | CPU Usage (ms) | I/O Wait (ms) | Computed Result | Execution Status |
| 16241.239 | 3600000.00 | 7932137.00 | 205280.30 | FTFFT?FFFTFTTFTF | normal |
Execution Chart
We display below the execution chart for this examination (boot time has been removed).
Trace from the execution
Formatting '/data/fko/mcc2021-input.r159-oct2-162089268400460.qcow2', fmt=qcow2 size=4294967296 backing_file=/data/fko/mcc2021-input.qcow2 cluster_size=65536 lazy_refcounts=off refcount_bits=16
Waiting for the VM to be ready (probing ssh)
.................................................................................................................................................................................................................................................................................
=====================================================================
Generated by BenchKit 2-4028
Executing tool itstools
Input is PolyORBNT-PT-S05J40, examination is LTLCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r159-oct2-162089268400460
=====================================================================
--------------------
preparation of the directory to be used:
/home/mcc/execution
total 4.6M
-rw-r--r-- 1 mcc users 138K May 5 16:58 CTLCardinality.txt
-rw-r--r-- 1 mcc users 624K May 10 09:43 CTLCardinality.xml
-rw-r--r-- 1 mcc users 311K May 5 16:58 CTLFireability.txt
-rw-r--r-- 1 mcc users 1.3M May 10 09:43 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.2K May 6 14:48 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 6.5K May 6 14:48 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 10K Mar 28 16:27 LTLCardinality.txt
-rw-r--r-- 1 mcc users 39K Mar 28 16:27 LTLCardinality.xml
-rw-r--r-- 1 mcc users 39K Mar 28 16:27 LTLFireability.txt
-rw-r--r-- 1 mcc users 120K Mar 28 16:27 LTLFireability.xml
-rw-r--r-- 1 mcc users 17K Mar 27 09:32 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 52K Mar 27 09:31 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 16K Mar 25 12:19 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 62K Mar 25 12:19 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 3.0K Mar 22 08:13 UpperBounds.txt
-rw-r--r-- 1 mcc users 5.8K Mar 22 08:13 UpperBounds.xml
-rw-r--r-- 1 mcc users 5 May 5 16:51 equiv_col
-rw-r--r-- 1 mcc users 7 May 5 16:51 instance
-rw-r--r-- 1 mcc users 6 May 5 16:51 iscolored
-rw-r--r-- 1 mcc users 1.9M May 5 16:51 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 PolyORBNT-PT-S05J40-00
FORMULA_NAME PolyORBNT-PT-S05J40-01
FORMULA_NAME PolyORBNT-PT-S05J40-02
FORMULA_NAME PolyORBNT-PT-S05J40-03
FORMULA_NAME PolyORBNT-PT-S05J40-04
FORMULA_NAME PolyORBNT-PT-S05J40-05
FORMULA_NAME PolyORBNT-PT-S05J40-06
FORMULA_NAME PolyORBNT-PT-S05J40-07
FORMULA_NAME PolyORBNT-PT-S05J40-08
FORMULA_NAME PolyORBNT-PT-S05J40-09
FORMULA_NAME PolyORBNT-PT-S05J40-10
FORMULA_NAME PolyORBNT-PT-S05J40-11
FORMULA_NAME PolyORBNT-PT-S05J40-12
FORMULA_NAME PolyORBNT-PT-S05J40-13
FORMULA_NAME PolyORBNT-PT-S05J40-14
FORMULA_NAME PolyORBNT-PT-S05J40-15
=== Now, execution of the tool begins
BK_START 1621222974044
Running Version 0
[2021-05-17 03:42:55] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, LTLCardinality, -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, 3600]
[2021-05-17 03:42:55] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2021-05-17 03:42:56] [INFO ] Load time of PNML (sax parser for PT used): 126 ms
[2021-05-17 03:42:56] [INFO ] Transformed 629 places.
[2021-05-17 03:42:56] [INFO ] Transformed 1590 transitions.
[2021-05-17 03:42:56] [INFO ] Parsed PT model containing 629 places and 1590 transitions in 167 ms.
Parsed 16 properties from file /home/mcc/execution/LTLCardinality.xml in 8 ms.
Working with output stream class java.io.PrintStream
[2021-05-17 03:42:56] [INFO ] Initial state test concluded for 1 properties.
Ensure Unique test removed 655 transitions
Reduce redundant transitions removed 655 transitions.
FORMULA PolyORBNT-PT-S05J40-12 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBNT-PT-S05J40-04 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
Support contains 203 out of 629 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 629/629 places, 935/935 transitions.
Ensure Unique test removed 4 places
Iterating post reduction 0 with 4 rules applied. Total rules applied 4 place count 625 transition count 935
Applied a total of 4 rules in 50 ms. Remains 625 /629 variables (removed 4) and now considering 935/935 (removed 0) transitions.
[2021-05-17 03:42:56] [INFO ] Flow matrix only has 931 transitions (discarded 4 similar events)
// Phase 1: matrix 931 rows 625 cols
[2021-05-17 03:42:56] [INFO ] Computed 98 place invariants in 65 ms
[2021-05-17 03:42:57] [INFO ] Dead Transitions using invariants and state equation in 1059 ms returned [105, 216, 230, 235, 252, 262, 299, 384, 394, 395, 430, 452, 489, 497, 539, 543, 561, 567, 590, 601, 608, 613, 623, 626, 648, 649, 652, 661, 666, 691, 697, 701, 707, 722, 723, 724, 747, 748, 749, 750, 759, 762, 763, 779, 782, 784, 785, 794, 797, 798, 800, 801, 803, 809, 811, 814, 818, 819, 820, 821, 822, 828, 831, 835, 840, 841, 843, 844, 845, 847, 848, 861, 862, 863, 873, 874, 875, 876, 889, 890, 893, 897, 900, 901, 910, 912, 914, 916, 917, 918, 920, 927, 929, 932, 933]
Found 95 dead transitions using SMT.
Drop transitions removed 95 transitions
Dead transitions reduction (with SMT) triggered by suspicious arc values removed 95 transitions :[933, 932, 929, 927, 920, 918, 917, 916, 914, 912, 910, 901, 900, 897, 893, 890, 889, 876, 875, 874, 873, 863, 862, 861, 848, 847, 845, 844, 843, 841, 840, 835, 831, 828, 822, 821, 820, 819, 818, 814, 811, 809, 803, 801, 800, 798, 797, 794, 785, 784, 782, 779, 763, 762, 759, 750, 749, 748, 747, 724, 723, 722, 707, 701, 697, 691, 666, 661, 652, 649, 648, 626, 623, 613, 608, 601, 590, 567, 561, 543, 539, 497, 489, 452, 430, 395, 394, 384, 299, 262, 252, 235, 230, 216, 105]
[2021-05-17 03:42:57] [INFO ] Flow matrix only has 836 transitions (discarded 4 similar events)
// Phase 1: matrix 836 rows 625 cols
[2021-05-17 03:42:57] [INFO ] Computed 98 place invariants in 39 ms
[2021-05-17 03:42:57] [INFO ] Implicit Places using invariants in 465 ms returned []
[2021-05-17 03:42:57] [INFO ] Flow matrix only has 836 transitions (discarded 4 similar events)
// Phase 1: matrix 836 rows 625 cols
[2021-05-17 03:42:57] [INFO ] Computed 98 place invariants in 27 ms
[2021-05-17 03:42:58] [INFO ] State equation strengthened by 1 read => feed constraints.
[2021-05-17 03:43:08] [INFO ] Implicit Places using invariants and state equation in 10664 ms returned []
Implicit Place search using SMT with State Equation took 11133 ms to find 0 implicit places.
[2021-05-17 03:43:08] [INFO ] Flow matrix only has 836 transitions (discarded 4 similar events)
// Phase 1: matrix 836 rows 625 cols
[2021-05-17 03:43:08] [INFO ] Computed 98 place invariants in 30 ms
[2021-05-17 03:43:09] [INFO ] Dead Transitions using invariants and state equation in 795 ms returned []
Starting structural reductions, iteration 1 : 625/629 places, 840/935 transitions.
Applied a total of 0 rules in 22 ms. Remains 625 /625 variables (removed 0) and now considering 840/840 (removed 0) transitions.
[2021-05-17 03:43:09] [INFO ] Flow matrix only has 836 transitions (discarded 4 similar events)
// Phase 1: matrix 836 rows 625 cols
[2021-05-17 03:43:09] [INFO ] Computed 98 place invariants in 12 ms
[2021-05-17 03:43:10] [INFO ] Dead Transitions using invariants and state equation in 872 ms returned []
Finished structural reductions, in 2 iterations. Remains : 625/629 places, 840/935 transitions.
[2021-05-17 03:43:10] [INFO ] Initial state reduction rules for LTL removed 3 formulas.
[2021-05-17 03:43:10] [INFO ] Flatten gal took : 171 ms
FORMULA PolyORBNT-PT-S05J40-10 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBNT-PT-S05J40-08 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBNT-PT-S05J40-07 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
[2021-05-17 03:43:10] [INFO ] Flatten gal took : 53 ms
[2021-05-17 03:43:10] [INFO ] Input system was already deterministic with 840 transitions.
Incomplete random walk after 100000 steps, including 6795 resets, run finished after 323 ms. (steps per millisecond=309 ) properties (out of 23) seen :14
Running SMT prover for 9 properties.
[2021-05-17 03:43:11] [INFO ] Flow matrix only has 836 transitions (discarded 4 similar events)
// Phase 1: matrix 836 rows 625 cols
[2021-05-17 03:43:11] [INFO ] Computed 98 place invariants in 24 ms
[2021-05-17 03:43:11] [INFO ] [Real]Absence check using 76 positive place invariants in 12 ms returned sat
[2021-05-17 03:43:11] [INFO ] [Real]Absence check using 76 positive and 22 generalized place invariants in 13 ms returned unsat
[2021-05-17 03:43:11] [INFO ] [Real]Absence check using 76 positive place invariants in 8 ms returned unsat
[2021-05-17 03:43:11] [INFO ] [Real]Absence check using 76 positive place invariants in 12 ms returned sat
[2021-05-17 03:43:11] [INFO ] [Real]Absence check using 76 positive and 22 generalized place invariants in 13 ms returned unsat
[2021-05-17 03:43:11] [INFO ] [Real]Absence check using 76 positive place invariants in 12 ms returned sat
[2021-05-17 03:43:11] [INFO ] [Real]Absence check using 76 positive and 22 generalized place invariants in 13 ms returned sat
[2021-05-17 03:43:11] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2021-05-17 03:43:11] [INFO ] [Real]Absence check using state equation in 345 ms returned sat
[2021-05-17 03:43:11] [INFO ] Solution in real domain found non-integer solution.
[2021-05-17 03:43:11] [INFO ] [Nat]Absence check using 76 positive place invariants in 13 ms returned sat
[2021-05-17 03:43:11] [INFO ] [Nat]Absence check using 76 positive and 22 generalized place invariants in 14 ms returned sat
[2021-05-17 03:43:11] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2021-05-17 03:43:12] [INFO ] [Nat]Absence check using state equation in 547 ms returned sat
[2021-05-17 03:43:12] [INFO ] State equation strengthened by 1 read => feed constraints.
[2021-05-17 03:43:12] [INFO ] [Nat]Added 1 Read/Feed constraints in 39 ms returned sat
[2021-05-17 03:43:12] [INFO ] Computed and/alt/rep : 455/1035/455 causal constraints (skipped 375 transitions) in 39 ms.
[2021-05-17 03:43:13] [INFO ] Deduced a trap composed of 14 places in 210 ms of which 5 ms to minimize.
[2021-05-17 03:43:13] [INFO ] Trap strengthening (SAT) tested/added 2/1 trap constraints in 363 ms
[2021-05-17 03:43:13] [INFO ] Added : 39 causal constraints over 9 iterations in 1152 ms. Result :sat
[2021-05-17 03:43:13] [INFO ] [Real]Absence check using 76 positive place invariants in 8 ms returned unsat
[2021-05-17 03:43:13] [INFO ] [Real]Absence check using 76 positive place invariants in 7 ms returned unsat
[2021-05-17 03:43:13] [INFO ] [Real]Absence check using 76 positive place invariants in 8 ms returned unsat
[2021-05-17 03:43:13] [INFO ] [Real]Absence check using 76 positive place invariants in 13 ms returned sat
[2021-05-17 03:43:13] [INFO ] [Real]Absence check using 76 positive and 22 generalized place invariants in 11 ms returned unsat
[2021-05-17 03:43:13] [INFO ] [Real]Absence check using 76 positive place invariants in 7 ms returned unsat
Successfully simplified 8 atomic propositions for a total of 11 simplifications.
[2021-05-17 03:43:13] [INFO ] Initial state test concluded for 4 properties.
FORMULA PolyORBNT-PT-S05J40-00 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBNT-PT-S05J40-01 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBNT-PT-S05J40-02 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBNT-PT-S05J40-14 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBNT-PT-S05J40-11 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
Running Spot : CommandLine [args=[/home/mcc/BenchKit/bin//..//ltl2tgba, --hoaf=tv, -f, !(F((G(F(p0))||G(p1))))], workingDir=/home/mcc/execution]
Support contains 54 out of 625 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 625/625 places, 840/840 transitions.
Ensure Unique test removed 1 places
Drop transitions removed 5 transitions
Trivial Post-agglo rules discarded 5 transitions
Performed 5 trivial Post agglomeration. Transition count delta: 5
Iterating post reduction 0 with 5 rules applied. Total rules applied 5 place count 624 transition count 835
Reduce places removed 5 places and 0 transitions.
Iterating post reduction 1 with 5 rules applied. Total rules applied 10 place count 619 transition count 835
Performed 44 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 2 with 44 Pre rules applied. Total rules applied 10 place count 619 transition count 791
Deduced a syphon composed of 44 places in 4 ms
Reduce places removed 44 places and 0 transitions.
Iterating global reduction 2 with 88 rules applied. Total rules applied 98 place count 575 transition count 791
Performed 2 Post agglomeration using F-continuation condition.Transition count delta: 2
Deduced a syphon composed of 2 places in 1 ms
Reduce places removed 2 places and 0 transitions.
Iterating global reduction 2 with 4 rules applied. Total rules applied 102 place count 573 transition count 789
Applied a total of 102 rules in 81 ms. Remains 573 /625 variables (removed 52) and now considering 789/840 (removed 51) transitions.
[2021-05-17 03:43:14] [INFO ] Flow matrix only has 785 transitions (discarded 4 similar events)
// Phase 1: matrix 785 rows 573 cols
[2021-05-17 03:43:14] [INFO ] Computed 97 place invariants in 14 ms
[2021-05-17 03:43:14] [INFO ] Dead Transitions using invariants and state equation in 672 ms returned []
[2021-05-17 03:43:14] [INFO ] Flow matrix only has 785 transitions (discarded 4 similar events)
// Phase 1: matrix 785 rows 573 cols
[2021-05-17 03:43:14] [INFO ] Computed 97 place invariants in 12 ms
[2021-05-17 03:43:15] [INFO ] Implicit Places using invariants in 520 ms returned []
[2021-05-17 03:43:15] [INFO ] Flow matrix only has 785 transitions (discarded 4 similar events)
// Phase 1: matrix 785 rows 573 cols
[2021-05-17 03:43:15] [INFO ] Computed 97 place invariants in 18 ms
[2021-05-17 03:43:15] [INFO ] State equation strengthened by 1 read => feed constraints.
[2021-05-17 03:43:23] [INFO ] Implicit Places using invariants and state equation in 8228 ms returned []
Implicit Place search using SMT with State Equation took 8761 ms to find 0 implicit places.
[2021-05-17 03:43:23] [INFO ] Redundant transitions in 35 ms returned []
[2021-05-17 03:43:23] [INFO ] Flow matrix only has 785 transitions (discarded 4 similar events)
// Phase 1: matrix 785 rows 573 cols
[2021-05-17 03:43:23] [INFO ] Computed 97 place invariants in 17 ms
[2021-05-17 03:43:24] [INFO ] Dead Transitions using invariants and state equation in 718 ms returned []
Finished structural reductions, in 1 iterations. Remains : 573/625 places, 789/840 transitions.
Stuttering acceptance computed with spot in 140 ms :[(AND (NOT p1) (NOT p0)), (AND (NOT p1) (NOT p0))]
Running random walk in product with property : PolyORBNT-PT-S05J40-03 automaton TGBA [mat=[[{ cond=true, acceptance={} source=0 dest: 0}, { cond=(AND (NOT p1) (NOT p0)), acceptance={} source=0 dest: 1}], [{ cond=(AND (NOT p1) (NOT p0)), acceptance={0} source=1 dest: 1}, { cond=(AND p1 (NOT p0)), acceptance={} source=1 dest: 1}]], initial=0, aps=[p1:(GT s453 (ADD s3 s8 s22 s28 s59 s76 s82 s100 s116 s118 s122 s144 s148 s175 s183 s201 s210 s242 s262 s263 s285 s295 s297 s330 s338 s347 s388 s393 s431 s439 s441 s446 s465 s479 s493 s508 s509 s523 s526 s530 s557)), p0:(OR (GT s41 (ADD s12 s81 s121 s346 s535)) (GT (ADD s266 s427 s440 s514 s561) s348))], nbAcceptance=1, properties=[trans-labels, explicit-labels, trans-acc, no-univ-branch, stutter-invariant], stateDesc=[null, null][true, true]]
Stuttering criterion allowed to conclude after 93 steps with 8 reset in 10 ms.
FORMULA PolyORBNT-PT-S05J40-03 FALSE TECHNIQUES STUTTER_TEST
Treatment of property PolyORBNT-PT-S05J40-03 finished in 10482 ms.
Running Spot : CommandLine [args=[/home/mcc/BenchKit/bin//..//ltl2tgba, --hoaf=tv, -f, !(G(F(p0)))], workingDir=/home/mcc/execution]
Support contains 42 out of 625 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 625/625 places, 840/840 transitions.
Ensure Unique test removed 1 places
Drop transitions removed 3 transitions
Trivial Post-agglo rules discarded 3 transitions
Performed 3 trivial Post agglomeration. Transition count delta: 3
Iterating post reduction 0 with 3 rules applied. Total rules applied 3 place count 624 transition count 837
Reduce places removed 3 places and 0 transitions.
Iterating post reduction 1 with 3 rules applied. Total rules applied 6 place count 621 transition count 837
Performed 46 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 2 with 46 Pre rules applied. Total rules applied 6 place count 621 transition count 791
Deduced a syphon composed of 46 places in 0 ms
Reduce places removed 46 places and 0 transitions.
Iterating global reduction 2 with 92 rules applied. Total rules applied 98 place count 575 transition count 791
Performed 2 Post agglomeration using F-continuation condition.Transition count delta: 2
Deduced a syphon composed of 2 places in 1 ms
Reduce places removed 2 places and 0 transitions.
Iterating global reduction 2 with 4 rules applied. Total rules applied 102 place count 573 transition count 789
Applied a total of 102 rules in 53 ms. Remains 573 /625 variables (removed 52) and now considering 789/840 (removed 51) transitions.
[2021-05-17 03:43:24] [INFO ] Flow matrix only has 785 transitions (discarded 4 similar events)
// Phase 1: matrix 785 rows 573 cols
[2021-05-17 03:43:24] [INFO ] Computed 97 place invariants in 12 ms
[2021-05-17 03:43:24] [INFO ] Dead Transitions using invariants and state equation in 513 ms returned []
[2021-05-17 03:43:24] [INFO ] Flow matrix only has 785 transitions (discarded 4 similar events)
// Phase 1: matrix 785 rows 573 cols
[2021-05-17 03:43:25] [INFO ] Computed 97 place invariants in 21 ms
[2021-05-17 03:43:25] [INFO ] Implicit Places using invariants in 581 ms returned []
[2021-05-17 03:43:25] [INFO ] Flow matrix only has 785 transitions (discarded 4 similar events)
// Phase 1: matrix 785 rows 573 cols
[2021-05-17 03:43:25] [INFO ] Computed 97 place invariants in 17 ms
[2021-05-17 03:43:25] [INFO ] State equation strengthened by 1 read => feed constraints.
[2021-05-17 03:43:32] [INFO ] Implicit Places using invariants and state equation in 7236 ms returned []
Implicit Place search using SMT with State Equation took 7822 ms to find 0 implicit places.
[2021-05-17 03:43:32] [INFO ] Redundant transitions in 9 ms returned []
[2021-05-17 03:43:32] [INFO ] Flow matrix only has 785 transitions (discarded 4 similar events)
// Phase 1: matrix 785 rows 573 cols
[2021-05-17 03:43:32] [INFO ] Computed 97 place invariants in 18 ms
[2021-05-17 03:43:33] [INFO ] Dead Transitions using invariants and state equation in 536 ms returned []
Finished structural reductions, in 1 iterations. Remains : 573/625 places, 789/840 transitions.
Stuttering acceptance computed with spot in 70 ms :[(NOT p0), (NOT p0)]
Running random walk in product with property : PolyORBNT-PT-S05J40-05 automaton TGBA [mat=[[{ cond=true, acceptance={} source=0 dest: 0}, { cond=(NOT p0), acceptance={} source=0 dest: 1}], [{ cond=(NOT p0), acceptance={0} source=1 dest: 1}]], initial=0, aps=[p0:(LEQ (ADD s3 s8 s22 s28 s58 s75 s81 s99 s115 s117 s121 s143 s147 s174 s182 s201 s210 s242 s262 s263 s284 s294 s296 s329 s337 s346 s387 s392 s430 s438 s440 s445 s464 s479 s493 s508 s509 s523 s526 s530 s557) s200)], nbAcceptance=1, properties=[trans-labels, explicit-labels, trans-acc, no-univ-branch, stutter-invariant, very-weak, weak, inherently-weak], stateDesc=[null, null][true, true]]
Product exploration explored 100000 steps with 5479 reset in 551 ms.
Product exploration explored 100000 steps with 5479 reset in 540 ms.
Knowledge obtained : [p0]
Stuttering acceptance computed with spot in 57 ms :[(NOT p0), (NOT p0)]
Product exploration explored 100000 steps with 5490 reset in 560 ms.
Product exploration explored 100000 steps with 5513 reset in 651 ms.
[2021-05-17 03:43:36] [INFO ] Flatten gal took : 80 ms
[2021-05-17 03:43:36] [INFO ] Flatten gal took : 67 ms
[2021-05-17 03:43:36] [INFO ] Time to serialize gal into /tmp/LTL12950997902436323956.gal : 30 ms
[2021-05-17 03:43:36] [INFO ] Time to serialize properties into /tmp/LTL13148174614663662950.ltl : 13 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-ltl-linux64, --gc-threshold, 2000000, -i, /tmp/LTL12950997902436323956.gal, -t, CGAL, -LTL, /tmp/LTL13148174614663662950.ltl, -c, -stutter-deadlock, --gen-order, FOLLOW], workingDir=/home/mcc/execution]
its-ltl command run as :
/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-ltl-linux64 --gc-threshold 2000000 -i /tmp/LTL12950997902436323956.gal -t CGAL -LTL /tmp/LTL13148174614663662950.ltl -c -stutter-deadlock --gen-order FOLLOW
Read 1 LTL properties
Checking formula 0 : !((G(F("(((((((((((((((((((((((((((((((((((((((((Perform_Work_B_1_30+Perform_Work_B_1_23)+Perform_Work_B_1_20)+Perform_Work_B_1_13)+Perform_Work_B_1_22)+Perform_Work_B_1_31)+Perform_Work_B_1_40)+Perform_Work_B_1_12)+Perform_Work_B_1_3)+Perform_Work_B_1_14)+Perform_Work_B_1_35)+Perform_Work_B_1_21)+Perform_Work_B_1_28)+Perform_Work_B_1_7)+Perform_Work_B_1_0)+Perform_Work_B_1_1)+Perform_Work_B_1_29)+Perform_Work_B_1_15)+Perform_Work_B_1_9)+Perform_Work_B_1_16)+Perform_Work_B_1_37)+Perform_Work_B_1_34)+Perform_Work_B_1_6)+Perform_Work_B_1_27)+Perform_Work_B_1_17)+Perform_Work_B_1_36)+Perform_Work_B_1_8)+Perform_Work_B_1_26)+Perform_Work_B_1_32)+Perform_Work_B_1_39)+Perform_Work_B_1_25)+Perform_Work_B_1_4)+Perform_Work_B_1_18)+Perform_Work_B_1_11)+Perform_Work_B_1_24)+Perform_Work_B_1_38)+Perform_Work_B_1_33)+Perform_Work_B_1_10)+Perform_Work_B_1_5)+Perform_Work_B_1_19)+Perform_Work_B_1_2)<=Try_Check_Sources_E_1)"))))
Formula 0 simplified : !GF"(((((((((((((((((((((((((((((((((((((((((Perform_Work_B_1_30+Perform_Work_B_1_23)+Perform_Work_B_1_20)+Perform_Work_B_1_13)+Perform_Work_B_1_22)+Perform_Work_B_1_31)+Perform_Work_B_1_40)+Perform_Work_B_1_12)+Perform_Work_B_1_3)+Perform_Work_B_1_14)+Perform_Work_B_1_35)+Perform_Work_B_1_21)+Perform_Work_B_1_28)+Perform_Work_B_1_7)+Perform_Work_B_1_0)+Perform_Work_B_1_1)+Perform_Work_B_1_29)+Perform_Work_B_1_15)+Perform_Work_B_1_9)+Perform_Work_B_1_16)+Perform_Work_B_1_37)+Perform_Work_B_1_34)+Perform_Work_B_1_6)+Perform_Work_B_1_27)+Perform_Work_B_1_17)+Perform_Work_B_1_36)+Perform_Work_B_1_8)+Perform_Work_B_1_26)+Perform_Work_B_1_32)+Perform_Work_B_1_39)+Perform_Work_B_1_25)+Perform_Work_B_1_4)+Perform_Work_B_1_18)+Perform_Work_B_1_11)+Perform_Work_B_1_24)+Perform_Work_B_1_38)+Perform_Work_B_1_33)+Perform_Work_B_1_10)+Perform_Work_B_1_5)+Perform_Work_B_1_19)+Perform_Work_B_1_2)<=Try_Check_Sources_E_1)"
Detected timeout of ITS tools.
[2021-05-17 03:43:51] [INFO ] Flatten gal took : 34 ms
[2021-05-17 03:43:51] [INFO ] Applying decomposition
[2021-05-17 03:43:51] [INFO ] Flatten gal took : 34 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/graph7581388659176567438.txt, -o, /tmp/graph7581388659176567438.bin, -w, /tmp/graph7581388659176567438.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/graph7581388659176567438.bin, -l, -1, -v, -w, /tmp/graph7581388659176567438.weights, -q, 0, -e, 0.001], workingDir=null]
[2021-05-17 03:43:51] [INFO ] Decomposing Gal with order
[2021-05-17 03:43:51] [INFO ] Rewriting arrays to variables to allow decomposition.
[2021-05-17 03:43:51] [INFO ] Removed a total of 869 redundant transitions.
[2021-05-17 03:43:51] [INFO ] Flatten gal took : 169 ms
[2021-05-17 03:43:51] [INFO ] Fuse similar labels procedure discarded/fused a total of 29 labels/synchronizations in 13 ms.
[2021-05-17 03:43:51] [INFO ] Time to serialize gal into /tmp/LTL18091220369750123867.gal : 8 ms
[2021-05-17 03:43:51] [INFO ] Time to serialize properties into /tmp/LTL7269307397274630981.ltl : 0 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-ltl-linux64, --gc-threshold, 2000000, -i, /tmp/LTL18091220369750123867.gal, -t, CGAL, -LTL, /tmp/LTL7269307397274630981.ltl, -c, -stutter-deadlock, --gen-order, FOLLOW], workingDir=/home/mcc/execution]
its-ltl command run as :
/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-ltl-linux64 --gc-threshold 2000000 -i /tmp/LTL18091220369750123867.gal -t CGAL -LTL /tmp/LTL7269307397274630981.ltl -c -stutter-deadlock --gen-order FOLLOW
Read 1 LTL properties
Checking formula 0 : !((G(F("(((((((((((((((((((((((((((((((((((((((((gu16.Perform_Work_B_1_30+gu16.Perform_Work_B_1_23)+gu16.Perform_Work_B_1_20)+gu16.Perform_Work_B_1_13)+gu16.Perform_Work_B_1_22)+gu16.Perform_Work_B_1_31)+gu16.Perform_Work_B_1_40)+gu16.Perform_Work_B_1_12)+gu16.Perform_Work_B_1_3)+gu16.Perform_Work_B_1_14)+gu16.Perform_Work_B_1_35)+gu16.Perform_Work_B_1_21)+gu16.Perform_Work_B_1_28)+gu16.Perform_Work_B_1_7)+gu16.Perform_Work_B_1_0)+gu16.Perform_Work_B_1_1)+gu16.Perform_Work_B_1_29)+gu16.Perform_Work_B_1_15)+gu16.Perform_Work_B_1_9)+gu16.Perform_Work_B_1_16)+gu16.Perform_Work_B_1_37)+gu16.Perform_Work_B_1_34)+gu16.Perform_Work_B_1_6)+gu16.Perform_Work_B_1_27)+gu16.Perform_Work_B_1_17)+gu16.Perform_Work_B_1_36)+gu16.Perform_Work_B_1_8)+gu16.Perform_Work_B_1_26)+gu16.Perform_Work_B_1_32)+gu16.Perform_Work_B_1_39)+gu16.Perform_Work_B_1_25)+gu16.Perform_Work_B_1_4)+gu16.Perform_Work_B_1_18)+gu16.Perform_Work_B_1_11)+gu16.Perform_Work_B_1_24)+gu16.Perform_Work_B_1_38)+gu16.Perform_Work_B_1_33)+gu16.Perform_Work_B_1_10)+gu16.Perform_Work_B_1_5)+gu16.Perform_Work_B_1_19)+gu16.Perform_Work_B_1_2)<=gu16.Try_Check_Sources_E_1)"))))
Formula 0 simplified : !GF"(((((((((((((((((((((((((((((((((((((((((gu16.Perform_Work_B_1_30+gu16.Perform_Work_B_1_23)+gu16.Perform_Work_B_1_20)+gu16.Perform_Work_B_1_13)+gu16.Perform_Work_B_1_22)+gu16.Perform_Work_B_1_31)+gu16.Perform_Work_B_1_40)+gu16.Perform_Work_B_1_12)+gu16.Perform_Work_B_1_3)+gu16.Perform_Work_B_1_14)+gu16.Perform_Work_B_1_35)+gu16.Perform_Work_B_1_21)+gu16.Perform_Work_B_1_28)+gu16.Perform_Work_B_1_7)+gu16.Perform_Work_B_1_0)+gu16.Perform_Work_B_1_1)+gu16.Perform_Work_B_1_29)+gu16.Perform_Work_B_1_15)+gu16.Perform_Work_B_1_9)+gu16.Perform_Work_B_1_16)+gu16.Perform_Work_B_1_37)+gu16.Perform_Work_B_1_34)+gu16.Perform_Work_B_1_6)+gu16.Perform_Work_B_1_27)+gu16.Perform_Work_B_1_17)+gu16.Perform_Work_B_1_36)+gu16.Perform_Work_B_1_8)+gu16.Perform_Work_B_1_26)+gu16.Perform_Work_B_1_32)+gu16.Perform_Work_B_1_39)+gu16.Perform_Work_B_1_25)+gu16.Perform_Work_B_1_4)+gu16.Perform_Work_B_1_18)+gu16.Perform_Work_B_1_11)+gu16.Perform_Work_B_1_24)+gu16.Perform_Work_B_1_38)+gu16.Perform_Work_B_1_33)+gu16.Perform_Work_B_1_10)+gu16.Perform_Work_B_1_5)+gu16.Perform_Work_B_1_19)+gu16.Perform_Work_B_1_2)<=gu16.Try_Check_Sources_E_1)"
Detected timeout of ITS tools.
Built C files in :
/tmp/ltsmin10935357879746184938
[2021-05-17 03:44:06] [INFO ] Built C files in 16ms conformant to PINS (ltsmin variant)in folder :/tmp/ltsmin10935357879746184938
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/ltsmin10935357879746184938]
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/ltsmin10935357879746184938] 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/ltsmin10935357879746184938] 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)
Treatment of property PolyORBNT-PT-S05J40-05 finished in 43439 ms.
Running Spot : CommandLine [args=[/home/mcc/BenchKit/bin//..//ltl2tgba, --hoaf=tv, -f, !(X(((F(p0)||X((G(p1)||X(p2)))) U X(p3))))], workingDir=/home/mcc/execution]
Support contains 132 out of 625 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 625/625 places, 840/840 transitions.
Ensure Unique test removed 1 places
Iterating post reduction 0 with 1 rules applied. Total rules applied 1 place count 624 transition count 840
Applied a total of 1 rules in 7 ms. Remains 624 /625 variables (removed 1) and now considering 840/840 (removed 0) transitions.
[2021-05-17 03:44:07] [INFO ] Flow matrix only has 836 transitions (discarded 4 similar events)
// Phase 1: matrix 836 rows 624 cols
[2021-05-17 03:44:07] [INFO ] Computed 97 place invariants in 11 ms
[2021-05-17 03:44:08] [INFO ] Dead Transitions using invariants and state equation in 806 ms returned []
[2021-05-17 03:44:08] [INFO ] Flow matrix only has 836 transitions (discarded 4 similar events)
// Phase 1: matrix 836 rows 624 cols
[2021-05-17 03:44:08] [INFO ] Computed 97 place invariants in 13 ms
[2021-05-17 03:44:09] [INFO ] Implicit Places using invariants in 522 ms returned []
[2021-05-17 03:44:09] [INFO ] Flow matrix only has 836 transitions (discarded 4 similar events)
// Phase 1: matrix 836 rows 624 cols
[2021-05-17 03:44:09] [INFO ] Computed 97 place invariants in 27 ms
[2021-05-17 03:44:09] [INFO ] State equation strengthened by 1 read => feed constraints.
[2021-05-17 03:44:18] [INFO ] Implicit Places using invariants and state equation in 9623 ms returned []
Implicit Place search using SMT with State Equation took 10146 ms to find 0 implicit places.
[2021-05-17 03:44:18] [INFO ] Flow matrix only has 836 transitions (discarded 4 similar events)
// Phase 1: matrix 836 rows 624 cols
[2021-05-17 03:44:18] [INFO ] Computed 97 place invariants in 15 ms
[2021-05-17 03:44:19] [INFO ] Dead Transitions using invariants and state equation in 782 ms returned []
Finished structural reductions, in 1 iterations. Remains : 624/625 places, 840/840 transitions.
Stuttering acceptance computed with spot in 252 ms :[(NOT p3), (NOT p3), (NOT p3), (AND (NOT p0) (NOT p2) (NOT p3) (NOT p1)), (AND (NOT p0) (NOT p1) (NOT p2)), (AND (NOT p0) (NOT p2)), (NOT p0), (AND (NOT p0) (NOT p1))]
Running random walk in product with property : PolyORBNT-PT-S05J40-06 automaton TGBA [mat=[[{ cond=true, acceptance={} source=0 dest: 1}], [{ cond=true, acceptance={} source=1 dest: 2}, { cond=(NOT p0), acceptance={} source=1 dest: 3}], [{ cond=(NOT p3), acceptance={0} source=2 dest: 2}, { cond=(AND (NOT p0) (NOT p3)), acceptance={0} source=2 dest: 3}], [{ cond=(AND (NOT p0) (NOT p3) p1), acceptance={} source=3 dest: 4}, { cond=(AND (NOT p0) (NOT p3) (NOT p1)), acceptance={} source=3 dest: 5}], [{ cond=(AND (NOT p0) (NOT p1) (NOT p2)), acceptance={} source=4 dest: 6}, { cond=(AND (NOT p0) p1 (NOT p2)), acceptance={} source=4 dest: 7}], [{ cond=(AND (NOT p0) (NOT p2)), acceptance={} source=5 dest: 6}], [{ cond=(NOT p0), acceptance={0} source=6 dest: 6}], [{ cond=(AND (NOT p0) (NOT p1)), acceptance={} source=7 dest: 6}, { cond=(AND (NOT p0) p1), acceptance={} source=7 dest: 7}]], initial=0, aps=[p0:(LEQ (ADD s0 s31 s35 s41 s53 s69 s74 s103 s106 s108 s120 s136 s150 s151 s160 s174 s197 s217 s282 s289 s298 s337 s340 s373 s382 s390 s391 s396 s407 s410 s413 s433 s451 s455 s490 s516 s534 s543 s544 s552 s559) s44), p3:(LEQ (ADD s291 s469 s482 s562 s611) s418), p1:(LEQ s510 s497), p2:(GT (ADD s7 s24 s48 s54 s63 s82 s96 s107 s109 s139 s167 s171 s198 s211 s227 s237 s249 s255 s269 s301 s324 s349 s356 s385 s400 s403 s415 s425 s435 s450 s458 s466 s487 s514 s515 s527 s529 s564 s586 s618 s622) (ADD s5 s42 s55 s62 s76 s86 s92 s115 s134 s161 s177 s178 s185 s199 s212 s221 s241 s250 s315 s317 s326 s327 s353 s358 s366 s394 s404 s406 s421 s439 s445 s456 s486 s501 s535 s539 s551 s587 s600 s604 s619))], nbAcceptance=1, properties=[trans-labels, explicit-labels, trans-acc, no-univ-branch, very-weak, weak, inherently-weak], stateDesc=[null, null, null, null, null, null, null, null][false, false, false, false, false, false, false, false]]
Stuttering criterion allowed to conclude after 12 steps with 0 reset in 1 ms.
FORMULA PolyORBNT-PT-S05J40-06 FALSE TECHNIQUES STUTTER_TEST
Treatment of property PolyORBNT-PT-S05J40-06 finished in 12020 ms.
Running Spot : CommandLine [args=[/home/mcc/BenchKit/bin//..//ltl2tgba, --hoaf=tv, -f, !(X(p0))], workingDir=/home/mcc/execution]
Support contains 3 out of 625 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 625/625 places, 840/840 transitions.
Ensure Unique test removed 1 places
Iterating post reduction 0 with 1 rules applied. Total rules applied 1 place count 624 transition count 840
Discarding 1 places :
Symmetric choice reduction at 1 with 1 rule applications. Total rules 2 place count 623 transition count 839
Iterating global reduction 1 with 1 rules applied. Total rules applied 3 place count 623 transition count 839
Applied a total of 3 rules in 51 ms. Remains 623 /625 variables (removed 2) and now considering 839/840 (removed 1) transitions.
[2021-05-17 03:44:19] [INFO ] Flow matrix only has 835 transitions (discarded 4 similar events)
// Phase 1: matrix 835 rows 623 cols
[2021-05-17 03:44:19] [INFO ] Computed 97 place invariants in 18 ms
[2021-05-17 03:44:20] [INFO ] Dead Transitions using invariants and state equation in 771 ms returned []
[2021-05-17 03:44:20] [INFO ] Flow matrix only has 835 transitions (discarded 4 similar events)
// Phase 1: matrix 835 rows 623 cols
[2021-05-17 03:44:20] [INFO ] Computed 97 place invariants in 19 ms
[2021-05-17 03:44:21] [INFO ] Implicit Places using invariants in 598 ms returned []
[2021-05-17 03:44:21] [INFO ] Flow matrix only has 835 transitions (discarded 4 similar events)
// Phase 1: matrix 835 rows 623 cols
[2021-05-17 03:44:21] [INFO ] Computed 97 place invariants in 18 ms
[2021-05-17 03:44:21] [INFO ] State equation strengthened by 1 read => feed constraints.
[2021-05-17 03:44:31] [INFO ] Implicit Places using invariants and state equation in 10130 ms returned []
Implicit Place search using SMT with State Equation took 10733 ms to find 0 implicit places.
[2021-05-17 03:44:31] [INFO ] Flow matrix only has 835 transitions (discarded 4 similar events)
// Phase 1: matrix 835 rows 623 cols
[2021-05-17 03:44:31] [INFO ] Computed 97 place invariants in 25 ms
[2021-05-17 03:44:32] [INFO ] Dead Transitions using invariants and state equation in 763 ms returned []
Finished structural reductions, in 1 iterations. Remains : 623/625 places, 839/840 transitions.
Stuttering acceptance computed with spot in 64 ms :[(NOT p0), (NOT p0), true]
Running random walk in product with property : PolyORBNT-PT-S05J40-09 automaton TGBA [mat=[[{ cond=(NOT p0), acceptance={} source=0 dest: 2}], [{ cond=true, acceptance={} source=1 dest: 0}], [{ cond=true, acceptance={0} source=2 dest: 2}]], initial=1, aps=[p0:(OR (LEQ s418 s274) (LEQ 1 s181))], nbAcceptance=1, properties=[trans-labels, explicit-labels, trans-acc, deterministic, no-univ-branch, unambiguous, semi-deterministic, terminal, very-weak, weak, inherently-weak], stateDesc=[null, null, null][false, false, false]]
Product exploration explored 100000 steps with 50000 reset in 476 ms.
Product exploration explored 100000 steps with 50000 reset in 482 ms.
Knowledge obtained : [p0]
Stuttering acceptance computed with spot in 60 ms :[(NOT p0), (NOT p0), true]
Product exploration explored 100000 steps with 50000 reset in 467 ms.
Product exploration explored 100000 steps with 50000 reset in 563 ms.
Applying partial POR strategy [true, false, true]
Stuttering acceptance computed with spot in 88 ms :[(NOT p0), (NOT p0), true]
Support contains 3 out of 623 places. Attempting structural reductions.
Property had overlarge support with respect to TGBA, discarding it for now.
Starting structural reductions, iteration 0 : 623/623 places, 839/839 transitions.
Performed 44 Post agglomeration using F-continuation condition.Transition count delta: 0
Iterating post reduction 0 with 44 rules applied. Total rules applied 44 place count 623 transition count 839
Performed 3 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 1 with 3 Pre rules applied. Total rules applied 44 place count 623 transition count 875
Deduced a syphon composed of 47 places in 1 ms
Iterating global reduction 1 with 3 rules applied. Total rules applied 47 place count 623 transition count 875
Performed 45 Post agglomeration using F-continuation condition.Transition count delta: 0
Deduced a syphon composed of 92 places in 1 ms
Iterating global reduction 1 with 45 rules applied. Total rules applied 92 place count 623 transition count 875
Discarding 44 places :
Symmetric choice reduction at 1 with 44 rule applications. Total rules 136 place count 579 transition count 831
Deduced a syphon composed of 48 places in 1 ms
Iterating global reduction 1 with 44 rules applied. Total rules applied 180 place count 579 transition count 831
Deduced a syphon composed of 48 places in 0 ms
Applied a total of 180 rules in 112 ms. Remains 579 /623 variables (removed 44) and now considering 831/839 (removed 8) transitions.
[2021-05-17 03:44:34] [INFO ] Flow matrix only has 823 transitions (discarded 8 similar events)
// Phase 1: matrix 823 rows 579 cols
[2021-05-17 03:44:34] [INFO ] Computed 97 place invariants in 12 ms
[2021-05-17 03:44:35] [INFO ] Dead Transitions using invariants and state equation in 482 ms returned []
[2021-05-17 03:44:35] [INFO ] Redundant transitions in 9 ms returned []
[2021-05-17 03:44:35] [INFO ] Flow matrix only has 823 transitions (discarded 8 similar events)
// Phase 1: matrix 823 rows 579 cols
[2021-05-17 03:44:35] [INFO ] Computed 97 place invariants in 16 ms
[2021-05-17 03:44:35] [INFO ] Dead Transitions using invariants and state equation in 506 ms returned []
Finished structural reductions, in 1 iterations. Remains : 579/623 places, 831/839 transitions.
Product exploration explored 100000 steps with 50000 reset in 3436 ms.
Product exploration explored 100000 steps with 50000 reset in 3341 ms.
[2021-05-17 03:44:42] [INFO ] Flatten gal took : 35 ms
[2021-05-17 03:44:42] [INFO ] Flatten gal took : 34 ms
[2021-05-17 03:44:42] [INFO ] Time to serialize gal into /tmp/LTL5213291795969609312.gal : 4 ms
[2021-05-17 03:44:42] [INFO ] Time to serialize properties into /tmp/LTL14025693173330022742.ltl : 0 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-ltl-linux64, --gc-threshold, 2000000, -i, /tmp/LTL5213291795969609312.gal, -t, CGAL, -LTL, /tmp/LTL14025693173330022742.ltl, -c, -stutter-deadlock, --gen-order, FOLLOW], workingDir=/home/mcc/execution]
its-ltl command run as :
/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-ltl-linux64 --gc-threshold 2000000 -i /tmp/LTL5213291795969609312.gal -t CGAL -LTL /tmp/LTL14025693173330022742.ltl -c -stutter-deadlock --gen-order FOLLOW
Read 1 LTL properties
Checking formula 0 : !((X("((place_782_1<=mo3)||(TheSour_2>=1))")))
Formula 0 simplified : !X"((place_782_1<=mo3)||(TheSour_2>=1))"
Detected timeout of ITS tools.
[2021-05-17 03:44:57] [INFO ] Flatten gal took : 33 ms
[2021-05-17 03:44:57] [INFO ] Applying decomposition
[2021-05-17 03:44:57] [INFO ] Flatten gal took : 33 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/graph7654738245107026773.txt, -o, /tmp/graph7654738245107026773.bin, -w, /tmp/graph7654738245107026773.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/graph7654738245107026773.bin, -l, -1, -v, -w, /tmp/graph7654738245107026773.weights, -q, 0, -e, 0.001], workingDir=null]
[2021-05-17 03:44:57] [INFO ] Decomposing Gal with order
[2021-05-17 03:44:57] [INFO ] Rewriting arrays to variables to allow decomposition.
[2021-05-17 03:44:57] [INFO ] Removed a total of 976 redundant transitions.
[2021-05-17 03:44:57] [INFO ] Flatten gal took : 176 ms
[2021-05-17 03:44:58] [INFO ] Fuse similar labels procedure discarded/fused a total of 5 labels/synchronizations in 23 ms.
[2021-05-17 03:44:58] [INFO ] Time to serialize gal into /tmp/LTL18383319983543628386.gal : 5 ms
[2021-05-17 03:44:58] [INFO ] Time to serialize properties into /tmp/LTL12040267501514316502.ltl : 0 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-ltl-linux64, --gc-threshold, 2000000, -i, /tmp/LTL18383319983543628386.gal, -t, CGAL, -LTL, /tmp/LTL12040267501514316502.ltl, -c, -stutter-deadlock, --gen-order, FOLLOW], workingDir=/home/mcc/execution]
its-ltl command run as :
/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-ltl-linux64 --gc-threshold 2000000 -i /tmp/LTL18383319983543628386.gal -t CGAL -LTL /tmp/LTL12040267501514316502.ltl -c -stutter-deadlock --gen-order FOLLOW
Read 1 LTL properties
Checking formula 0 : !((X("((gu50.place_782_1<=gu50.mo3)||(gi1.gu86.TheSour_2>=1))")))
Formula 0 simplified : !X"((gu50.place_782_1<=gu50.mo3)||(gi1.gu86.TheSour_2>=1))"
Detected timeout of ITS tools.
Built C files in :
/tmp/ltsmin14267529679898586329
[2021-05-17 03:45:13] [INFO ] Built C files in 9ms conformant to PINS (ltsmin variant)in folder :/tmp/ltsmin14267529679898586329
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/ltsmin14267529679898586329]
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/ltsmin14267529679898586329] 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/ltsmin14267529679898586329] 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)
Treatment of property PolyORBNT-PT-S05J40-09 finished in 54285 ms.
Running Spot : CommandLine [args=[/home/mcc/BenchKit/bin//..//ltl2tgba, --hoaf=tv, -f, !((G(F(p0))||G(p1)))], workingDir=/home/mcc/execution]
Support contains 3 out of 625 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 625/625 places, 840/840 transitions.
Ensure Unique test removed 1 places
Drop transitions removed 45 transitions
Trivial Post-agglo rules discarded 45 transitions
Performed 45 trivial Post agglomeration. Transition count delta: 45
Iterating post reduction 0 with 45 rules applied. Total rules applied 45 place count 624 transition count 795
Reduce places removed 45 places and 0 transitions.
Performed 1 Post agglomeration using F-continuation condition.Transition count delta: 1
Iterating post reduction 1 with 46 rules applied. Total rules applied 91 place count 579 transition count 794
Reduce places removed 1 places and 0 transitions.
Iterating post reduction 2 with 1 rules applied. Total rules applied 92 place count 578 transition count 794
Performed 45 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 3 with 45 Pre rules applied. Total rules applied 92 place count 578 transition count 749
Deduced a syphon composed of 45 places in 1 ms
Reduce places removed 45 places and 0 transitions.
Iterating global reduction 3 with 90 rules applied. Total rules applied 182 place count 533 transition count 749
Performed 2 Post agglomeration using F-continuation condition.Transition count delta: 2
Deduced a syphon composed of 2 places in 1 ms
Reduce places removed 2 places and 0 transitions.
Iterating global reduction 3 with 4 rules applied. Total rules applied 186 place count 531 transition count 747
Applied a total of 186 rules in 72 ms. Remains 531 /625 variables (removed 94) and now considering 747/840 (removed 93) transitions.
[2021-05-17 03:45:14] [INFO ] Flow matrix only has 743 transitions (discarded 4 similar events)
// Phase 1: matrix 743 rows 531 cols
[2021-05-17 03:45:14] [INFO ] Computed 97 place invariants in 11 ms
[2021-05-17 03:45:14] [INFO ] Dead Transitions using invariants and state equation in 438 ms returned []
[2021-05-17 03:45:14] [INFO ] Flow matrix only has 743 transitions (discarded 4 similar events)
// Phase 1: matrix 743 rows 531 cols
[2021-05-17 03:45:14] [INFO ] Computed 97 place invariants in 17 ms
[2021-05-17 03:45:15] [INFO ] Implicit Places using invariants in 564 ms returned []
[2021-05-17 03:45:15] [INFO ] Flow matrix only has 743 transitions (discarded 4 similar events)
// Phase 1: matrix 743 rows 531 cols
[2021-05-17 03:45:15] [INFO ] Computed 97 place invariants in 17 ms
[2021-05-17 03:45:15] [INFO ] State equation strengthened by 1 read => feed constraints.
[2021-05-17 03:45:21] [INFO ] Implicit Places using invariants and state equation in 6176 ms returned []
Implicit Place search using SMT with State Equation took 6741 ms to find 0 implicit places.
[2021-05-17 03:45:21] [INFO ] Redundant transitions in 9 ms returned []
[2021-05-17 03:45:21] [INFO ] Flow matrix only has 743 transitions (discarded 4 similar events)
// Phase 1: matrix 743 rows 531 cols
[2021-05-17 03:45:21] [INFO ] Computed 97 place invariants in 12 ms
[2021-05-17 03:45:21] [INFO ] Dead Transitions using invariants and state equation in 486 ms returned []
Finished structural reductions, in 1 iterations. Remains : 531/625 places, 747/840 transitions.
Stuttering acceptance computed with spot in 103 ms :[(AND (NOT p1) (NOT p0)), (NOT p0), (NOT p0)]
Running random walk in product with property : PolyORBNT-PT-S05J40-13 automaton TGBA [mat=[[{ cond=p1, acceptance={} source=0 dest: 0}, { cond=(AND (NOT p0) (NOT p1)), acceptance={} source=0 dest: 1}, { cond=(NOT p1), acceptance={} source=0 dest: 2}], [{ cond=(NOT p0), acceptance={0} source=1 dest: 1}], [{ cond=(NOT p0), acceptance={} source=2 dest: 1}, { cond=true, acceptance={} source=2 dest: 2}]], initial=0, aps=[p1:(GT 1 s108), p0:(LEQ s361 s37)], nbAcceptance=1, properties=[trans-labels, explicit-labels, trans-acc, no-univ-branch, stutter-invariant, very-weak, weak, inherently-weak], stateDesc=[null, null, null][true, true, true]]
Stuttering criterion allowed to conclude after 43572 steps with 2279 reset in 204 ms.
FORMULA PolyORBNT-PT-S05J40-13 FALSE TECHNIQUES STUTTER_TEST
Treatment of property PolyORBNT-PT-S05J40-13 finished in 8095 ms.
Running Spot : CommandLine [args=[/home/mcc/BenchKit/bin//..//ltl2tgba, --hoaf=tv, -f, !((G(p0)||X((G(p1) U (!p0&&G(p1))))))], workingDir=/home/mcc/execution]
Support contains 4 out of 625 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 625/625 places, 840/840 transitions.
Ensure Unique test removed 1 places
Iterating post reduction 0 with 1 rules applied. Total rules applied 1 place count 624 transition count 840
Discarding 1 places :
Symmetric choice reduction at 1 with 1 rule applications. Total rules 2 place count 623 transition count 839
Iterating global reduction 1 with 1 rules applied. Total rules applied 3 place count 623 transition count 839
Applied a total of 3 rules in 22 ms. Remains 623 /625 variables (removed 2) and now considering 839/840 (removed 1) transitions.
[2021-05-17 03:45:22] [INFO ] Flow matrix only has 835 transitions (discarded 4 similar events)
// Phase 1: matrix 835 rows 623 cols
[2021-05-17 03:45:22] [INFO ] Computed 97 place invariants in 17 ms
[2021-05-17 03:45:23] [INFO ] Dead Transitions using invariants and state equation in 742 ms returned []
[2021-05-17 03:45:23] [INFO ] Flow matrix only has 835 transitions (discarded 4 similar events)
// Phase 1: matrix 835 rows 623 cols
[2021-05-17 03:45:23] [INFO ] Computed 97 place invariants in 17 ms
[2021-05-17 03:45:23] [INFO ] Implicit Places using invariants in 609 ms returned []
[2021-05-17 03:45:23] [INFO ] Flow matrix only has 835 transitions (discarded 4 similar events)
// Phase 1: matrix 835 rows 623 cols
[2021-05-17 03:45:23] [INFO ] Computed 97 place invariants in 16 ms
[2021-05-17 03:45:24] [INFO ] State equation strengthened by 1 read => feed constraints.
[2021-05-17 03:45:32] [INFO ] Implicit Places using invariants and state equation in 9229 ms returned []
Implicit Place search using SMT with State Equation took 9841 ms to find 0 implicit places.
[2021-05-17 03:45:32] [INFO ] Flow matrix only has 835 transitions (discarded 4 similar events)
// Phase 1: matrix 835 rows 623 cols
[2021-05-17 03:45:32] [INFO ] Computed 97 place invariants in 16 ms
[2021-05-17 03:45:33] [INFO ] Dead Transitions using invariants and state equation in 710 ms returned []
Finished structural reductions, in 1 iterations. Remains : 623/625 places, 839/840 transitions.
Stuttering acceptance computed with spot in 152 ms :[true, (AND (NOT p0) (NOT p1)), (NOT p1), (NOT p0), (OR (NOT p1) p0), (AND (NOT p1) (NOT p0))]
Running random walk in product with property : PolyORBNT-PT-S05J40-15 automaton TGBA [mat=[[{ cond=true, acceptance={0} source=0 dest: 0}], [{ cond=(NOT p0), acceptance={} source=1 dest: 4}, { cond=p0, acceptance={} source=1 dest: 5}], [{ cond=(NOT p1), acceptance={} source=2 dest: 0}, { cond=p1, acceptance={} source=2 dest: 2}], [{ cond=(NOT p0), acceptance={} source=3 dest: 0}, { cond=p0, acceptance={} source=3 dest: 3}], [{ cond=(NOT p1), acceptance={0} source=4 dest: 0}, { cond=(AND (NOT p0) p1), acceptance={0} source=4 dest: 2}, { cond=(AND p0 p1), acceptance={0} source=4 dest: 4}], [{ cond=(AND (NOT p0) (NOT p1)), acceptance={} source=5 dest: 0}, { cond=(AND (NOT p0) p1), acceptance={} source=5 dest: 2}, { cond=(AND p0 (NOT p1)), acceptance={} source=5 dest: 3}, { cond=(AND p0 p1), acceptance={} source=5 dest: 5}]], initial=1, aps=[p0:(LEQ s78 s306), p1:(LEQ s102 s402)], nbAcceptance=1, properties=[trans-labels, explicit-labels, trans-acc, complete, deterministic, no-univ-branch, unambiguous, semi-deterministic, very-weak, weak, inherently-weak], stateDesc=[null, null, null, null, null, null][false, false, false, false, false, false]]
Entered a terminal (fully accepting) state of product in 493 steps with 33 reset in 1 ms.
FORMULA PolyORBNT-PT-S05J40-15 FALSE TECHNIQUES STUTTER_TEST
Treatment of property PolyORBNT-PT-S05J40-15 finished in 11494 ms.
Using solver Z3 to compute partial order matrices.
Built C files in :
/tmp/ltsmin11156664329794241372
[2021-05-17 03:45:33] [INFO ] Computing symmetric may disable matrix : 840 transitions.
[2021-05-17 03:45:33] [INFO ] Applying decomposition
[2021-05-17 03:45:33] [INFO ] Computation of Complete disable matrix. took 7 ms. Total solver calls (SAT/UNSAT): 0(0/0)
[2021-05-17 03:45:33] [INFO ] Computing symmetric may enable matrix : 840 transitions.
[2021-05-17 03:45:33] [INFO ] Computation of Complete enable matrix. took 3 ms. Total solver calls (SAT/UNSAT): 0(0/0)
[2021-05-17 03:45:33] [INFO ] Flatten gal took : 33 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/graph11381998798482887113.txt, -o, /tmp/graph11381998798482887113.bin, -w, /tmp/graph11381998798482887113.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/graph11381998798482887113.bin, -l, -1, -v, -w, /tmp/graph11381998798482887113.weights, -q, 0, -e, 0.001], workingDir=null]
[2021-05-17 03:45:33] [INFO ] Decomposing Gal with order
[2021-05-17 03:45:33] [INFO ] Rewriting arrays to variables to allow decomposition.
[2021-05-17 03:45:33] [INFO ] Computing Do-Not-Accords matrix : 840 transitions.
[2021-05-17 03:45:33] [INFO ] Computation of Completed DNA matrix. took 51 ms. Total solver calls (SAT/UNSAT): 0(0/0)
[2021-05-17 03:45:33] [INFO ] Built C files in 182ms conformant to PINS (ltsmin variant)in folder :/tmp/ltsmin11156664329794241372
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/ltsmin11156664329794241372]
[2021-05-17 03:45:34] [INFO ] Removed a total of 1013 redundant transitions.
[2021-05-17 03:45:34] [INFO ] Flatten gal took : 140 ms
[2021-05-17 03:45:34] [INFO ] Fuse similar labels procedure discarded/fused a total of 55 labels/synchronizations in 15 ms.
[2021-05-17 03:45:34] [INFO ] Time to serialize gal into /tmp/LTLCardinality2937709572359798600.gal : 9 ms
[2021-05-17 03:45:34] [INFO ] Time to serialize properties into /tmp/LTLCardinality11244546263152534775.ltl : 1 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-ltl-linux64, --gc-threshold, 2000000, -i, /tmp/LTLCardinality2937709572359798600.gal, -t, CGAL, -LTL, /tmp/LTLCardinality11244546263152534775.ltl, -c, -stutter-deadlock, --gen-order, FOLLOW], workingDir=/home/mcc/execution]
its-ltl command run as :
/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-ltl-linux64 --gc-threshold 2000000 -i /tmp/LTLCardinality2937709572359798600.gal -t CGAL -LTL /tmp/LTLCardinality11244546263152534775.ltl -c -stutter-deadlock --gen-order FOLLOW
Read 2 LTL properties
Checking formula 0 : !((G(F("(((((((((((((((((((((((((((((((((((((((((gu38.Perform_Work_B_1_30+gu38.Perform_Work_B_1_23)+gu38.Perform_Work_B_1_20)+gu38.Perform_Work_B_1_13)+gu38.Perform_Work_B_1_22)+gu38.Perform_Work_B_1_31)+gu38.Perform_Work_B_1_40)+gu38.Perform_Work_B_1_12)+gu38.Perform_Work_B_1_3)+gu38.Perform_Work_B_1_14)+gu38.Perform_Work_B_1_35)+gu38.Perform_Work_B_1_21)+gu38.Perform_Work_B_1_28)+gu38.Perform_Work_B_1_7)+gu38.Perform_Work_B_1_0)+gu38.Perform_Work_B_1_1)+gu38.Perform_Work_B_1_29)+gu38.Perform_Work_B_1_15)+gu38.Perform_Work_B_1_9)+gu38.Perform_Work_B_1_16)+gu38.Perform_Work_B_1_37)+gu38.Perform_Work_B_1_34)+gu38.Perform_Work_B_1_6)+gu38.Perform_Work_B_1_27)+gu38.Perform_Work_B_1_17)+gu38.Perform_Work_B_1_36)+gu38.Perform_Work_B_1_8)+gu38.Perform_Work_B_1_26)+gu38.Perform_Work_B_1_32)+gu38.Perform_Work_B_1_39)+gu38.Perform_Work_B_1_25)+gu38.Perform_Work_B_1_4)+gu38.Perform_Work_B_1_18)+gu38.Perform_Work_B_1_11)+gu38.Perform_Work_B_1_24)+gu38.Perform_Work_B_1_38)+gu38.Perform_Work_B_1_33)+gu38.Perform_Work_B_1_10)+gu38.Perform_Work_B_1_5)+gu38.Perform_Work_B_1_19)+gu38.Perform_Work_B_1_2)<=gu38.Try_Check_Sources_E_1)"))))
Formula 0 simplified : !GF"(((((((((((((((((((((((((((((((((((((((((gu38.Perform_Work_B_1_30+gu38.Perform_Work_B_1_23)+gu38.Perform_Work_B_1_20)+gu38.Perform_Work_B_1_13)+gu38.Perform_Work_B_1_22)+gu38.Perform_Work_B_1_31)+gu38.Perform_Work_B_1_40)+gu38.Perform_Work_B_1_12)+gu38.Perform_Work_B_1_3)+gu38.Perform_Work_B_1_14)+gu38.Perform_Work_B_1_35)+gu38.Perform_Work_B_1_21)+gu38.Perform_Work_B_1_28)+gu38.Perform_Work_B_1_7)+gu38.Perform_Work_B_1_0)+gu38.Perform_Work_B_1_1)+gu38.Perform_Work_B_1_29)+gu38.Perform_Work_B_1_15)+gu38.Perform_Work_B_1_9)+gu38.Perform_Work_B_1_16)+gu38.Perform_Work_B_1_37)+gu38.Perform_Work_B_1_34)+gu38.Perform_Work_B_1_6)+gu38.Perform_Work_B_1_27)+gu38.Perform_Work_B_1_17)+gu38.Perform_Work_B_1_36)+gu38.Perform_Work_B_1_8)+gu38.Perform_Work_B_1_26)+gu38.Perform_Work_B_1_32)+gu38.Perform_Work_B_1_39)+gu38.Perform_Work_B_1_25)+gu38.Perform_Work_B_1_4)+gu38.Perform_Work_B_1_18)+gu38.Perform_Work_B_1_11)+gu38.Perform_Work_B_1_24)+gu38.Perform_Work_B_1_38)+gu38.Perform_Work_B_1_33)+gu38.Perform_Work_B_1_10)+gu38.Perform_Work_B_1_5)+gu38.Perform_Work_B_1_19)+gu38.Perform_Work_B_1_2)<=gu38.Try_Check_Sources_E_1)"
Compilation finished in 5545 ms.
Running link step : CommandLine [args=[gcc, -shared, -o, gal.so, model.o], workingDir=/tmp/ltsmin11156664329794241372]
Link finished in 58 ms.
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202104292328/bin/pins2lts-mc-linux64, ./gal.so, --threads=8, -p, --pins-guards, --when, --ltl, [](<>((LTLAPp0==true))), --buchi-type=spotba], workingDir=/tmp/ltsmin11156664329794241372]
WARNING : LTSmin timed out (>327 s) on command CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202104292328/bin/pins2lts-mc-linux64, ./gal.so, --threads=8, -p, --pins-guards, --when, --ltl, [](<>((LTLAPp0==true))), --buchi-type=spotba], workingDir=/tmp/ltsmin11156664329794241372]
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202104292328/bin/pins2lts-mc-linux64, ./gal.so, --threads=8, --when, --ltl, X((LTLAPp1==true)), --buchi-type=spotba], workingDir=/tmp/ltsmin11156664329794241372]
LTSmin run took 447 ms.
FORMULA PolyORBNT-PT-S05J40-09 TRUE TECHNIQUES EXPLICIT LTSMIN SAT_SMT
Retrying LTSmin with larger timeout 2616 s
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202104292328/bin/pins2lts-mc-linux64, ./gal.so, --threads=8, -p, --pins-guards, --when, --ltl, [](<>((LTLAPp0==true))), --buchi-type=spotba], workingDir=/tmp/ltsmin11156664329794241372]
Detected timeout of ITS tools.
[2021-05-17 04:06:47] [INFO ] Flatten gal took : 1082 ms
[2021-05-17 04:06:48] [INFO ] Time to serialize gal into /tmp/LTLCardinality9559321246608237735.gal : 495 ms
[2021-05-17 04:06:48] [INFO ] Time to serialize properties into /tmp/LTLCardinality16332056381277182364.ltl : 2 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-ltl-linux64, --gc-threshold, 2000000, -i, /tmp/LTLCardinality9559321246608237735.gal, -t, CGAL, -LTL, /tmp/LTLCardinality16332056381277182364.ltl, -c, -stutter-deadlock, --gen-order, FOLLOW], workingDir=/home/mcc/execution]
its-ltl command run as :
/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-ltl-linux64 --gc-threshold 2000000 -i /tmp/LTLCardinality9559321246608237735.gal -t CGAL -LTL /tmp/LTLCardinality16332056381277182364.ltl -c -stutter-deadlock --gen-order FOLLOW
Read 1 LTL properties
Checking formula 0 : !((G(F("(((((((((((((((((((((((((((((((((((((((((Perform_Work_B_1_30+Perform_Work_B_1_23)+Perform_Work_B_1_20)+Perform_Work_B_1_13)+Perform_Work_B_1_22)+Perform_Work_B_1_31)+Perform_Work_B_1_40)+Perform_Work_B_1_12)+Perform_Work_B_1_3)+Perform_Work_B_1_14)+Perform_Work_B_1_35)+Perform_Work_B_1_21)+Perform_Work_B_1_28)+Perform_Work_B_1_7)+Perform_Work_B_1_0)+Perform_Work_B_1_1)+Perform_Work_B_1_29)+Perform_Work_B_1_15)+Perform_Work_B_1_9)+Perform_Work_B_1_16)+Perform_Work_B_1_37)+Perform_Work_B_1_34)+Perform_Work_B_1_6)+Perform_Work_B_1_27)+Perform_Work_B_1_17)+Perform_Work_B_1_36)+Perform_Work_B_1_8)+Perform_Work_B_1_26)+Perform_Work_B_1_32)+Perform_Work_B_1_39)+Perform_Work_B_1_25)+Perform_Work_B_1_4)+Perform_Work_B_1_18)+Perform_Work_B_1_11)+Perform_Work_B_1_24)+Perform_Work_B_1_38)+Perform_Work_B_1_33)+Perform_Work_B_1_10)+Perform_Work_B_1_5)+Perform_Work_B_1_19)+Perform_Work_B_1_2)<=Try_Check_Sources_E_1)"))))
Formula 0 simplified : !GF"(((((((((((((((((((((((((((((((((((((((((Perform_Work_B_1_30+Perform_Work_B_1_23)+Perform_Work_B_1_20)+Perform_Work_B_1_13)+Perform_Work_B_1_22)+Perform_Work_B_1_31)+Perform_Work_B_1_40)+Perform_Work_B_1_12)+Perform_Work_B_1_3)+Perform_Work_B_1_14)+Perform_Work_B_1_35)+Perform_Work_B_1_21)+Perform_Work_B_1_28)+Perform_Work_B_1_7)+Perform_Work_B_1_0)+Perform_Work_B_1_1)+Perform_Work_B_1_29)+Perform_Work_B_1_15)+Perform_Work_B_1_9)+Perform_Work_B_1_16)+Perform_Work_B_1_37)+Perform_Work_B_1_34)+Perform_Work_B_1_6)+Perform_Work_B_1_27)+Perform_Work_B_1_17)+Perform_Work_B_1_36)+Perform_Work_B_1_8)+Perform_Work_B_1_26)+Perform_Work_B_1_32)+Perform_Work_B_1_39)+Perform_Work_B_1_25)+Perform_Work_B_1_4)+Perform_Work_B_1_18)+Perform_Work_B_1_11)+Perform_Work_B_1_24)+Perform_Work_B_1_38)+Perform_Work_B_1_33)+Perform_Work_B_1_10)+Perform_Work_B_1_5)+Perform_Work_B_1_19)+Perform_Work_B_1_2)<=Try_Check_Sources_E_1)"
pins2lts-mc-linux64, 0.000: Registering PINS so language module
pins2lts-mc-linux64( 4/ 8), 0.004: library has no initializer
pins2lts-mc-linux64( 3/ 8), 0.004: library has no initializer
pins2lts-mc-linux64( 3/ 8), 0.004: loading model GAL
pins2lts-mc-linux64( 0/ 8), 0.005: Loading model from ./gal.so
pins2lts-mc-linux64( 0/ 8), 0.005: library has no initializer
pins2lts-mc-linux64( 0/ 8), 0.005: loading model GAL
pins2lts-mc-linux64( 1/ 8), 0.005: library has no initializer
pins2lts-mc-linux64( 1/ 8), 0.005: loading model GAL
pins2lts-mc-linux64( 4/ 8), 0.004: loading model GAL
pins2lts-mc-linux64( 5/ 8), 0.013: library has no initializer
pins2lts-mc-linux64( 5/ 8), 0.013: loading model GAL
pins2lts-mc-linux64( 2/ 8), 0.003: library has no initializer
pins2lts-mc-linux64( 2/ 8), 0.015: loading model GAL
pins2lts-mc-linux64( 6/ 8), 0.037: library has no initializer
pins2lts-mc-linux64( 6/ 8), 0.037: loading model GAL
pins2lts-mc-linux64( 7/ 8), 0.041: library has no initializer
pins2lts-mc-linux64( 7/ 8), 0.041: loading model GAL
pins2lts-mc-linux64( 2/ 8), 1.700: completed loading model GAL
pins2lts-mc-linux64( 0/ 8), 2.112: completed loading model GAL
pins2lts-mc-linux64( 3/ 8), 2.112: completed loading model GAL
pins2lts-mc-linux64( 0/ 8), 2.167: Initializing POR dependencies: labels 842, guards 840
pins2lts-mc-linux64( 4/ 8), 2.427: completed loading model GAL
pins2lts-mc-linux64( 1/ 8), 2.803: completed loading model GAL
pins2lts-mc-linux64( 5/ 8), 2.879: completed loading model GAL
pins2lts-mc-linux64( 7/ 8), 3.035: completed loading model GAL
pins2lts-mc-linux64( 6/ 8), 3.087: completed loading model GAL
pins2lts-mc-linux64( 3/ 8), 8.809: LTL layer: formula: [](<>((LTLAPp0==true)))
pins2lts-mc-linux64( 3/ 8), 8.810: "[](<>((LTLAPp0==true)))" is not a file, parsing as formula...
pins2lts-mc-linux64( 3/ 8), 8.813: Using Spin LTL semantics
pins2lts-mc-linux64( 0/ 8), 8.832: Weak Buchi automaton detected, adding non-accepting as progress label.
pins2lts-mc-linux64( 0/ 8), 9.531: Forcing use of the an ignoring proviso (cndfs)
pins2lts-mc-linux64( 0/ 8), 9.734: There are 844 state labels and 1 edge labels
pins2lts-mc-linux64( 0/ 8), 9.735: State length is 626, there are 843 groups
pins2lts-mc-linux64( 0/ 8), 9.735: Running cndfs using 8 cores
pins2lts-mc-linux64( 0/ 8), 9.735: Using a tree table with 2^27 elements
pins2lts-mc-linux64( 0/ 8), 9.735: Successor permutation: dynamic
pins2lts-mc-linux64( 0/ 8), 9.735: Visible groups: 248 / 843, labels: 1 / 844
pins2lts-mc-linux64( 0/ 8), 9.735: POR cycle proviso: cndfs (ltl)
pins2lts-mc-linux64( 0/ 8), 9.735: Global bits: 2, count bits: 2, local bits: 0
pins2lts-mc-linux64( 3/ 8), 10.101: [Blue] ~39 levels ~960 states ~2072 transitions
pins2lts-mc-linux64( 3/ 8), 10.185: [Blue] ~39 levels ~1920 states ~4248 transitions
pins2lts-mc-linux64( 3/ 8), 10.259: [Blue] ~39 levels ~3840 states ~8800 transitions
pins2lts-mc-linux64( 0/ 8), 10.463: [Blue] ~30 levels ~7680 states ~16016 transitions
pins2lts-mc-linux64( 0/ 8), 10.731: [Blue] ~30 levels ~15360 states ~28712 transitions
pins2lts-mc-linux64( 0/ 8), 11.265: [Blue] ~30 levels ~30720 states ~54624 transitions
pins2lts-mc-linux64( 0/ 8), 12.356: [Blue] ~30 levels ~61440 states ~105544 transitions
pins2lts-mc-linux64( 7/ 8), 15.019: [Blue] ~30 levels ~122880 states ~211328 transitions
pins2lts-mc-linux64( 2/ 8), 20.993: [Blue] ~30 levels ~245760 states ~461712 transitions
pins2lts-mc-linux64( 1/ 8), 30.968: [Blue] ~65 levels ~491520 states ~1049888 transitions
pins2lts-mc-linux64( 1/ 8), 50.744: [Blue] ~65 levels ~983040 states ~2052944 transitions
pins2lts-mc-linux64( 1/ 8), 89.401: [Blue] ~65 levels ~1966080 states ~4038424 transitions
pins2lts-mc-linux64( 1/ 8), 165.100: [Blue] ~65 levels ~3932160 states ~8020216 transitions
pins2lts-mc-linux64( 3/ 8), 318.997: [Blue] ~55 levels ~7864320 states ~16193640 transitions
pins2lts-mc-linux64( 3/ 8), 613.644: [Blue] ~55 levels ~15728640 states ~31402936 transitions
pins2lts-mc-linux64( 4/ 8), 1172.463: Error: tree leafs table full! Change -s/--ratio.
pins2lts-mc-linux64( 0/ 8), 1172.502:
pins2lts-mc-linux64( 0/ 8), 1172.502: Explored 24998870 states 49760570 transitions, fanout: 1.991
pins2lts-mc-linux64( 0/ 8), 1172.507: Total exploration time 1162.740 sec (1162.690 sec minimum, 1162.722 sec on average)
pins2lts-mc-linux64( 0/ 8), 1172.507: States per second: 21500, Transitions per second: 42796
pins2lts-mc-linux64( 0/ 8), 1172.508:
pins2lts-mc-linux64( 0/ 8), 1172.508: State space has 25000737 states, 834097 are accepting
pins2lts-mc-linux64( 0/ 8), 1172.508: cndfs_1 (permutation: dynamic) stats:
pins2lts-mc-linux64( 0/ 8), 1172.508: blue states: 24998870 (99.99%), transitions: 0 (per worker)
pins2lts-mc-linux64( 0/ 8), 1172.508: red states: 0 (0.00%), bogus: 0 (0.00%), transitions: 0, waits: 0 (0.00 sec)
pins2lts-mc-linux64( 0/ 8), 1172.508: all-red states: 834097 (3.34%), bogus 7 (0.00%)
pins2lts-mc-linux64( 0/ 8), 1172.508:
pins2lts-mc-linux64( 0/ 8), 1172.508: Total memory used for local state coloring: 0.0MB
pins2lts-mc-linux64( 0/ 8), 1172.508:
pins2lts-mc-linux64( 0/ 8), 1172.508: Queue width: 8B, total height: 359, memory: 0.00MB
pins2lts-mc-linux64( 0/ 8), 1172.508: Tree memory: 446.7MB, 18.7 B/state, compr.: 0.7%
pins2lts-mc-linux64( 0/ 8), 1172.508: Tree fill ratio (roots/leafs): 18.0%/99.0%
pins2lts-mc-linux64( 0/ 8), 1172.509: Stored 847 string chucks using 0MB
pins2lts-mc-linux64( 0/ 8), 1172.509: Total memory used for chunk indexing: 0MB
pins2lts-mc-linux64( 0/ 8), 1172.509: Est. total memory use: 446.7MB (~1024.0MB paged-in)
WARNING : LTS min runner thread failed on error :java.lang.RuntimeException: Unexpected exception when executing ltsmin :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202104292328/bin/pins2lts-mc-linux64, ./gal.so, --threads=8, -p, --pins-guards, --when, --ltl, [](<>((LTLAPp0==true))), --buchi-type=spotba], workingDir=/tmp/ltsmin11156664329794241372]
255
java.lang.RuntimeException: Unexpected exception when executing ltsmin :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202104292328/bin/pins2lts-mc-linux64, ./gal.so, --threads=8, -p, --pins-guards, --when, --ltl, [](<>((LTLAPp0==true))), --buchi-type=spotba], workingDir=/tmp/ltsmin11156664329794241372]
255
at fr.lip6.move.gal.application.LTSminRunner.checkProperty(LTSminRunner.java:214)
at fr.lip6.move.gal.application.LTSminRunner.access$10(LTSminRunner.java:165)
at fr.lip6.move.gal.application.LTSminRunner$1.checkProperties(LTSminRunner.java:154)
at fr.lip6.move.gal.application.LTSminRunner$1.run(LTSminRunner.java:102)
at java.base/java.lang.Thread.run(Thread.java:834)
Detected timeout of ITS tools.
[2021-05-17 04:27:43] [INFO ] Flatten gal took : 277 ms
[2021-05-17 04:27:45] [INFO ] Input system was already deterministic with 840 transitions.
[2021-05-17 04:27:45] [INFO ] Transformed 625 places.
[2021-05-17 04:27:45] [INFO ] Transformed 840 transitions.
Running greatSPN : CommandLine [args=[/home/mcc/BenchKit/bin//..//greatspn//bin/pinvar, /home/mcc/execution/gspn], workingDir=/home/mcc/execution]
P-invariant computation with GreatSPN timed out. Skipping.
Running greatSPN : CommandLine [args=[/home/mcc/BenchKit/bin//..//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
[2021-05-17 04:28:15] [INFO ] Time to serialize gal into /tmp/LTLCardinality3176308916280725904.gal : 18 ms
[2021-05-17 04:28:15] [INFO ] Time to serialize properties into /tmp/LTLCardinality7233143710088066069.ltl : 11 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-ltl-linux64, --gc-threshold, 2000000, -i, /tmp/LTLCardinality3176308916280725904.gal, -t, CGAL, -LTL, /tmp/LTLCardinality7233143710088066069.ltl, -c, -stutter-deadlock, --load-order, /home/mcc/execution/model.ord, --gen-order, FOLLOW], workingDir=/home/mcc/execution]
its-ltl command run as :
/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-ltl-linux64 --gc-threshold 2000000 -i /tmp/LTLCardinality3176308916280725904.gal -t CGAL -LTL /tmp/LTLCardinality7233143710088066069.ltl -c -stutter-deadlock --load-order /home/mcc/execution/model.ord --gen-order FOLLOW
Read 1 LTL properties
Successfully loaded order from file /home/mcc/execution/model.ord
Checking formula 0 : !((G(F("(((((((((((((((((((((((((((((((((((((((((Perform_Work_B_1_30+Perform_Work_B_1_23)+Perform_Work_B_1_20)+Perform_Work_B_1_13)+Perform_Work_B_1_22)+Perform_Work_B_1_31)+Perform_Work_B_1_40)+Perform_Work_B_1_12)+Perform_Work_B_1_3)+Perform_Work_B_1_14)+Perform_Work_B_1_35)+Perform_Work_B_1_21)+Perform_Work_B_1_28)+Perform_Work_B_1_7)+Perform_Work_B_1_0)+Perform_Work_B_1_1)+Perform_Work_B_1_29)+Perform_Work_B_1_15)+Perform_Work_B_1_9)+Perform_Work_B_1_16)+Perform_Work_B_1_37)+Perform_Work_B_1_34)+Perform_Work_B_1_6)+Perform_Work_B_1_27)+Perform_Work_B_1_17)+Perform_Work_B_1_36)+Perform_Work_B_1_8)+Perform_Work_B_1_26)+Perform_Work_B_1_32)+Perform_Work_B_1_39)+Perform_Work_B_1_25)+Perform_Work_B_1_4)+Perform_Work_B_1_18)+Perform_Work_B_1_11)+Perform_Work_B_1_24)+Perform_Work_B_1_38)+Perform_Work_B_1_33)+Perform_Work_B_1_10)+Perform_Work_B_1_5)+Perform_Work_B_1_19)+Perform_Work_B_1_2)<=Try_Check_Sources_E_1)"))))
Formula 0 simplified : !GF"(((((((((((((((((((((((((((((((((((((((((Perform_Work_B_1_30+Perform_Work_B_1_23)+Perform_Work_B_1_20)+Perform_Work_B_1_13)+Perform_Work_B_1_22)+Perform_Work_B_1_31)+Perform_Work_B_1_40)+Perform_Work_B_1_12)+Perform_Work_B_1_3)+Perform_Work_B_1_14)+Perform_Work_B_1_35)+Perform_Work_B_1_21)+Perform_Work_B_1_28)+Perform_Work_B_1_7)+Perform_Work_B_1_0)+Perform_Work_B_1_1)+Perform_Work_B_1_29)+Perform_Work_B_1_15)+Perform_Work_B_1_9)+Perform_Work_B_1_16)+Perform_Work_B_1_37)+Perform_Work_B_1_34)+Perform_Work_B_1_6)+Perform_Work_B_1_27)+Perform_Work_B_1_17)+Perform_Work_B_1_36)+Perform_Work_B_1_8)+Perform_Work_B_1_26)+Perform_Work_B_1_32)+Perform_Work_B_1_39)+Perform_Work_B_1_25)+Perform_Work_B_1_4)+Perform_Work_B_1_18)+Perform_Work_B_1_11)+Perform_Work_B_1_24)+Perform_Work_B_1_38)+Perform_Work_B_1_33)+Perform_Work_B_1_10)+Perform_Work_B_1_5)+Perform_Work_B_1_19)+Perform_Work_B_1_2)<=Try_Check_Sources_E_1)"
BK_TIME_CONFINEMENT_REACHED
--------------------
content from stderr:
+ export BINDIR=/home/mcc/BenchKit/bin//../
+ BINDIR=/home/mcc/BenchKit/bin//../
++ pwd
+ export MODEL=/home/mcc/execution
+ MODEL=/home/mcc/execution
+ [[ LTLCardinality = StateSpace ]]
+ /home/mcc/BenchKit/bin//..//runeclipse.sh /home/mcc/execution LTLCardinality -its -ltsmin -greatspnpath /home/mcc/BenchKit/bin//..//greatspn/ -order META -manyOrder -smt -timeout 3600
+ 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 LTLCardinality -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 3600 -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="PolyORBNT-PT-S05J40"
export BK_EXAMINATION="LTLCardinality"
export BK_TOOL="itstools"
export BK_RESULT_DIR="/tmp/BK_RESULTS/OUTPUTS"
export BK_TIME_CONFINEMENT="3600"
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 PolyORBNT-PT-S05J40, 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 r159-oct2-162089268400460"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"
tar xzf /home/mcc/BenchKit/INPUTS/PolyORBNT-PT-S05J40.tgz
mv PolyORBNT-PT-S05J40 execution
cd execution
if [ "LTLCardinality" = "ReachabilityDeadlock" ] || [ "LTLCardinality" = "UpperBounds" ] || [ "LTLCardinality" = "QuasiLiveness" ] || [ "LTLCardinality" = "StableMarking" ] || [ "LTLCardinality" = "Liveness" ] || [ "LTLCardinality" = "OneSafe" ] || [ "LTLCardinality" = "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 [ "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 '
echo "FORMULA_NAME $x"
done
elif [ "LTLCardinality" = "ReachabilityDeadlock" ] || [ "LTLCardinality" = "QuasiLiveness" ] || [ "LTLCardinality" = "StableMarking" ] || [ "LTLCardinality" = "Liveness" ] || [ "LTLCardinality" = "OneSafe" ] ; then
echo "FORMULA_NAME LTLCardinality"
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 ;