About the Execution of LoLA for DLCround-PT-10a
Execution Summary | |||||
Max Memory Used (MB) |
Time wait (ms) | CPU Usage (ms) | I/O Wait (ms) | Computed Result | Execution Status |
15918.940 | 731741.00 | 698536.00 | 2047.80 | FTFFFFFTFFFFF?TT | normal |
Execution Chart
We display below the execution chart for this examination (boot time has been removed).
Trace from the execution
Formatting '/data/fko/mcc2019-input.r049-oct2-155234405100436.qcow2', fmt=qcow2 size=4294967296 backing_file=/data/fko/mcc2019-input.qcow2 cluster_size=65536 lazy_refcounts=off refcount_bits=16
Waiting for the VM to be ready (probing ssh)
.............................................................................
=====================================================================
Generated by BenchKit 2-3954
Executing tool lola
Input is DLCround-PT-10a, examination is CTLCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r049-oct2-155234405100436
=====================================================================
--------------------
preparation of the directory to be used:
/home/mcc/execution
total 824K
-rw-r--r-- 1 mcc users 3.8K Feb 10 06:58 CTLCardinality.txt
-rw-r--r-- 1 mcc users 22K Feb 10 06:58 CTLCardinality.xml
-rw-r--r-- 1 mcc users 2.4K Feb 6 05:28 CTLFireability.txt
-rw-r--r-- 1 mcc users 16K Feb 6 05:28 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.0K Mar 10 17:31 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 5.9K Mar 10 17:31 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 102 Feb 24 15:05 GlobalProperties.txt
-rw-r--r-- 1 mcc users 340 Feb 24 15:05 GlobalProperties.xml
-rw-r--r-- 1 mcc users 2.3K Feb 4 23:22 LTLCardinality.txt
-rw-r--r-- 1 mcc users 9.8K Feb 4 23:22 LTLCardinality.xml
-rw-r--r-- 1 mcc users 1.8K Feb 4 22:33 LTLFireability.txt
-rw-r--r-- 1 mcc users 8.3K Feb 4 22:33 LTLFireability.xml
-rw-r--r-- 1 mcc users 3.1K Feb 2 22:44 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 15K Feb 2 22:44 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 2.9K Jan 30 13:03 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 18K Jan 30 13:03 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.6K Feb 4 22:19 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.6K Feb 4 22:19 UpperBounds.xml
-rw-r--r-- 1 mcc users 6 Jan 29 09:34 equiv_col
-rw-r--r-- 1 mcc users 4 Jan 29 09:34 instance
-rw-r--r-- 1 mcc users 6 Jan 29 09:34 iscolored
-rw-r--r-- 1 mcc users 660K Mar 10 17:31 model.pnml
--------------------
content from stdout:
=== Data for post analysis generated by BenchKit (invocation template)
The expected result is a vector of booleans
BOOL_VECTOR
here is the order used to build the result vector(from text file)
FORMULA_NAME DLCround-PT-10a-CTLCardinality-00
FORMULA_NAME DLCround-PT-10a-CTLCardinality-01
FORMULA_NAME DLCround-PT-10a-CTLCardinality-02
FORMULA_NAME DLCround-PT-10a-CTLCardinality-03
FORMULA_NAME DLCround-PT-10a-CTLCardinality-04
FORMULA_NAME DLCround-PT-10a-CTLCardinality-05
FORMULA_NAME DLCround-PT-10a-CTLCardinality-06
FORMULA_NAME DLCround-PT-10a-CTLCardinality-07
FORMULA_NAME DLCround-PT-10a-CTLCardinality-08
FORMULA_NAME DLCround-PT-10a-CTLCardinality-09
FORMULA_NAME DLCround-PT-10a-CTLCardinality-10
FORMULA_NAME DLCround-PT-10a-CTLCardinality-11
FORMULA_NAME DLCround-PT-10a-CTLCardinality-12
FORMULA_NAME DLCround-PT-10a-CTLCardinality-13
FORMULA_NAME DLCround-PT-10a-CTLCardinality-14
FORMULA_NAME DLCround-PT-10a-CTLCardinality-15
=== Now, execution of the tool begins
BK_START 1552457340591
info: Time: 3600 - MCC
vrfy: Checking CTLCardinality @ DLCround-PT-10a @ 3570 seconds
FORMULA DLCround-PT-10a-CTLCardinality-00 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT
FORMULA DLCround-PT-10a-CTLCardinality-01 TRUE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT
FORMULA DLCround-PT-10a-CTLCardinality-02 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT
FORMULA DLCround-PT-10a-CTLCardinality-03 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT
FORMULA DLCround-PT-10a-CTLCardinality-04 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT
FORMULA DLCround-PT-10a-CTLCardinality-05 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT
FORMULA DLCround-PT-10a-CTLCardinality-06 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT
FORMULA DLCround-PT-10a-CTLCardinality-07 TRUE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT
FORMULA DLCround-PT-10a-CTLCardinality-08 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT
FORMULA DLCround-PT-10a-CTLCardinality-09 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT
FORMULA DLCround-PT-10a-CTLCardinality-10 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT
FORMULA DLCround-PT-10a-CTLCardinality-12 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT
FORMULA DLCround-PT-10a-CTLCardinality-15 TRUE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT
FORMULA DLCround-PT-10a-CTLCardinality-14 TRUE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT
FORMULA DLCround-PT-10a-CTLCardinality-11 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT
FORMULA DLCround-PT-10a-CTLCardinality-13 CANNOT_COMPUTE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT
vrfy: finished
info: timeLeft: 2838
rslt: Output for CTLCardinality @ DLCround-PT-10a
{
"build":
{
"architecture": 64,
"assertions": false,
"build_hostname": "mcc2019",
"build_system": "x86_64-unknown-linux-gnu",
"optimizations": true,
"package_version": "2.0",
"svn_version": "3189M"
},
"call":
{
"exec_host": "mcc2019",
"markinglimit": null,
"parameters":
[
"--pnmlnet",
"model.pnml",
"--xmlformula",
"--formula=CTLCardinality.xml",
"--mcc",
"--donotcomputecapacities",
"--encoder=simplecompressed",
"--safe",
"--check=modelchecking",
"--stubborn=tarjan",
"--stateequation=par",
"--quickchecks",
"--timelimit=3570",
"--localtimelimit=0",
"--preference=force_ctl",
"--json=CTLCardinality.json",
"--jsoninclude=formula,formulastat,net"
],
"starttime": "Wed Mar 13 06:09:00 2019
",
"timelimit": 3570
},
"child":
[
{
"call":
{
"dynamic_timelimit": true,
"localtimelimit": 222
},
"exit":
{
"localtimelimitreached": false
},
"formula":
{
"count":
{
"A": 0,
"E": 0,
"F": 0,
"G": 0,
"U": 0,
"X": 0,
"aconj": 0,
"adisj": 0,
"aneg": 0,
"comp": 0,
"cont": 0,
"dl": 0,
"fir": 0,
"nodl": 0,
"place_references": 0,
"taut": 0,
"tconj": 0,
"tdisj": 0,
"tneg": 0,
"transition_references": 0,
"unfir": 0,
"visible_places": 0,
"visible_transitions": 0
},
"processed": "DEADLOCK",
"processed_size": 8,
"rewrites": 94
},
"result":
{
"edges": 0,
"markings": 0,
"produced_by": "preprocessing",
"value": false
},
"task":
{
"compoundnumber": 0,
"type": "initial_satisfaction",
"workflow": "preprocessing"
}
},
{
"call":
{
"dynamic_timelimit": true,
"localtimelimit": 237
},
"exit":
{
"localtimelimitreached": false
},
"formula":
{
"count":
{
"A": 0,
"E": 0,
"F": 0,
"G": 0,
"U": 0,
"X": 0,
"aconj": 0,
"adisj": 0,
"aneg": 0,
"comp": 0,
"cont": 0,
"dl": 0,
"fir": 0,
"nodl": 0,
"place_references": 0,
"taut": 0,
"tconj": 0,
"tdisj": 0,
"tneg": 0,
"transition_references": 0,
"unfir": 0,
"visible_places": 0,
"visible_transitions": 0
},
"processed": "TRUE",
"processed_size": 4,
"rewrites": 94
},
"result":
{
"edges": 0,
"markings": 0,
"produced_by": "preprocessing",
"value": true
},
"task":
{
"compoundnumber": 1,
"type": "initial_satisfaction",
"workflow": "preprocessing"
}
},
{
"call":
{
"dynamic_timelimit": true,
"localtimelimit": 254
},
"exit":
{
"localtimelimitreached": false
},
"formula":
{
"count":
{
"A": 0,
"E": 0,
"F": 0,
"G": 0,
"U": 0,
"X": 0,
"aconj": 0,
"adisj": 0,
"aneg": 0,
"comp": 0,
"cont": 0,
"dl": 0,
"fir": 0,
"nodl": 0,
"place_references": 0,
"taut": 0,
"tconj": 0,
"tdisj": 0,
"tneg": 0,
"transition_references": 0,
"unfir": 0,
"visible_places": 0,
"visible_transitions": 0
},
"processed": "FALSE",
"processed_size": 5,
"rewrites": 94
},
"result":
{
"edges": 0,
"markings": 0,
"produced_by": "preprocessing",
"value": false
},
"task":
{
"compoundnumber": 2,
"type": "initial_satisfaction",
"workflow": "preprocessing"
}
},
{
"call":
{
"dynamic_timelimit": true,
"localtimelimit": 274
},
"exit":
{
"localtimelimitreached": false
},
"formula":
{
"count":
{
"A": 0,
"E": 0,
"F": 0,
"G": 0,
"U": 0,
"X": 0,
"aconj": 0,
"adisj": 0,
"aneg": 0,
"comp": 0,
"cont": 0,
"dl": 0,
"fir": 0,
"nodl": 0,
"place_references": 0,
"taut": 0,
"tconj": 0,
"tdisj": 0,
"tneg": 0,
"transition_references": 0,
"unfir": 0,
"visible_places": 0,
"visible_transitions": 0
},
"processed": "FALSE",
"processed_size": 5,
"rewrites": 94
},
"result":
{
"edges": 0,
"markings": 0,
"produced_by": "preprocessing",
"value": false
},
"task":
{
"compoundnumber": 3,
"type": "initial_satisfaction",
"workflow": "preprocessing"
}
},
{
"call":
{
"dynamic_timelimit": true,
"localtimelimit": 297
},
"exit":
{
"localtimelimitreached": false
},
"formula":
{
"count":
{
"A": 0,
"E": 0,
"F": 0,
"G": 0,
"U": 0,
"X": 0,
"aconj": 0,
"adisj": 0,
"aneg": 0,
"comp": 0,
"cont": 0,
"dl": 0,
"fir": 0,
"nodl": 0,
"place_references": 0,
"taut": 0,
"tconj": 0,
"tdisj": 0,
"tneg": 0,
"transition_references": 0,
"unfir": 0,
"visible_places": 0,
"visible_transitions": 0
},
"processed": "FALSE",
"processed_size": 5,
"rewrites": 94
},
"result":
{
"edges": 0,
"markings": 0,
"produced_by": "preprocessing",
"value": false
},
"task":
{
"compoundnumber": 4,
"type": "initial_satisfaction",
"workflow": "preprocessing"
}
},
{
"call":
{
"dynamic_timelimit": true,
"localtimelimit": 324
},
"exit":
{
"localtimelimitreached": false
},
"formula":
{
"count":
{
"A": 0,
"E": 0,
"F": 0,
"G": 0,
"U": 0,
"X": 0,
"aconj": 1,
"adisj": 0,
"aneg": 0,
"comp": 1,
"cont": 0,
"dl": 0,
"fir": 0,
"nodl": 0,
"place_references": 1,
"taut": 0,
"tconj": 0,
"tdisj": 0,
"tneg": 0,
"transition_references": 0,
"unfir": 0,
"visible_places": 1,
"visible_transitions": 0
},
"processed": "((1 <= p291))",
"processed_size": 13,
"rewrites": 94
},
"result":
{
"edges": 0,
"markings": 0,
"produced_by": "preprocessing",
"value": false
},
"task":
{
"compoundnumber": 5,
"type": "initial_satisfaction",
"workflow": "preprocessing"
}
},
{
"call":
{
"dynamic_timelimit": true,
"localtimelimit": 356
},
"exit":
{
"localtimelimitreached": false
},
"formula":
{
"count":
{
"A": 0,
"E": 0,
"F": 0,
"G": 0,
"U": 0,
"X": 0,
"aconj": 0,
"adisj": 0,
"aneg": 0,
"comp": 0,
"cont": 0,
"dl": 0,
"fir": 0,
"nodl": 0,
"place_references": 0,
"taut": 0,
"tconj": 0,
"tdisj": 0,
"tneg": 0,
"transition_references": 0,
"unfir": 0,
"visible_places": 0,
"visible_transitions": 0
},
"processed": "FALSE",
"processed_size": 5,
"rewrites": 94
},
"result":
{
"edges": 0,
"markings": 0,
"produced_by": "preprocessing",
"value": false
},
"task":
{
"compoundnumber": 6,
"type": "initial_satisfaction",
"workflow": "preprocessing"
}
},
{
"call":
{
"dynamic_timelimit": true,
"localtimelimit": 396
},
"exit":
{
"localtimelimitreached": false
},
"formula":
{
"count":
{
"A": 0,
"E": 0,
"F": 0,
"G": 0,
"U": 0,
"X": 0,
"aconj": 0,
"adisj": 0,
"aneg": 0,
"comp": 0,
"cont": 0,
"dl": 0,
"fir": 0,
"nodl": 0,
"place_references": 0,
"taut": 0,
"tconj": 0,
"tdisj": 0,
"tneg": 0,
"transition_references": 0,
"unfir": 0,
"visible_places": 0,
"visible_transitions": 0
},
"processed": "TRUE",
"processed_size": 4,
"rewrites": 94
},
"result":
{
"edges": 0,
"markings": 0,
"produced_by": "preprocessing",
"value": true
},
"task":
{
"compoundnumber": 7,
"type": "initial_satisfaction",
"workflow": "preprocessing"
}
},
{
"call":
{
"dynamic_timelimit": true,
"localtimelimit": 445
},
"exit":
{
"localtimelimitreached": false
},
"formula":
{
"count":
{
"A": 0,
"E": 0,
"F": 0,
"G": 0,
"U": 0,
"X": 0,
"aconj": 0,
"adisj": 0,
"aneg": 0,
"comp": 0,
"cont": 0,
"dl": 0,
"fir": 0,
"nodl": 0,
"place_references": 0,
"taut": 0,
"tconj": 0,
"tdisj": 0,
"tneg": 0,
"transition_references": 0,
"unfir": 0,
"visible_places": 0,
"visible_transitions": 0
},
"processed": "FALSE",
"processed_size": 5,
"rewrites": 94
},
"result":
{
"edges": 0,
"markings": 0,
"produced_by": "preprocessing",
"value": false
},
"task":
{
"compoundnumber": 8,
"type": "initial_satisfaction",
"workflow": "preprocessing"
}
},
{
"call":
{
"dynamic_timelimit": true,
"localtimelimit": 509
},
"exit":
{
"localtimelimitreached": false
},
"formula":
{
"count":
{
"A": 0,
"E": 0,
"F": 0,
"G": 0,
"U": 0,
"X": 0,
"aconj": 0,
"adisj": 0,
"aneg": 0,
"comp": 0,
"cont": 0,
"dl": 0,
"fir": 0,
"nodl": 0,
"place_references": 0,
"taut": 0,
"tconj": 0,
"tdisj": 0,
"tneg": 0,
"transition_references": 0,
"unfir": 0,
"visible_places": 0,
"visible_transitions": 0
},
"processed": "FALSE",
"processed_size": 5,
"rewrites": 94
},
"result":
{
"edges": 0,
"markings": 0,
"produced_by": "preprocessing",
"value": false
},
"task":
{
"compoundnumber": 9,
"type": "initial_satisfaction",
"workflow": "preprocessing"
}
},
{
"call":
{
"dynamic_timelimit": true,
"localtimelimit": 594
},
"exit":
{
"localtimelimitreached": false
},
"formula":
{
"count":
{
"A": 0,
"E": 0,
"F": 0,
"G": 0,
"U": 0,
"X": 0,
"aconj": 0,
"adisj": 0,
"aneg": 0,
"comp": 0,
"cont": 0,
"dl": 0,
"fir": 0,
"nodl": 0,
"place_references": 0,
"taut": 0,
"tconj": 0,
"tdisj": 0,
"tneg": 0,
"transition_references": 0,
"unfir": 0,
"visible_places": 0,
"visible_transitions": 0
},
"processed": "FALSE",
"processed_size": 5,
"rewrites": 94
},
"result":
{
"edges": 0,
"markings": 0,
"produced_by": "preprocessing",
"value": false
},
"task":
{
"compoundnumber": 10,
"type": "initial_satisfaction",
"workflow": "preprocessing"
}
},
{
"call":
{
"dynamic_timelimit": true,
"localtimelimit": 712
},
"exit":
{
"localtimelimitreached": false
},
"formula":
{
"count":
{
"A": 0,
"E": 0,
"F": 0,
"G": 0,
"U": 0,
"X": 0,
"aconj": 0,
"adisj": 0,
"aneg": 0,
"comp": 0,
"cont": 0,
"dl": 0,
"fir": 0,
"nodl": 0,
"place_references": 0,
"taut": 0,
"tconj": 0,
"tdisj": 0,
"tneg": 0,
"transition_references": 0,
"unfir": 0,
"visible_places": 0,
"visible_transitions": 0
},
"processed": "FALSE",
"processed_size": 5,
"rewrites": 94
},
"result":
{
"edges": 0,
"markings": 0,
"produced_by": "preprocessing",
"value": false
},
"task":
{
"compoundnumber": 11,
"type": "initial_satisfaction",
"workflow": "preprocessing"
}
},
{
"call":
{
"dynamic_timelimit": true,
"localtimelimit": 891
},
"exit":
{
"localtimelimitreached": false
},
"formula":
{
"count":
{
"A": 0,
"E": 0,
"F": 0,
"G": 0,
"U": 0,
"X": 0,
"aconj": 0,
"adisj": 0,
"aneg": 0,
"comp": 0,
"cont": 0,
"dl": 0,
"fir": 0,
"nodl": 0,
"place_references": 0,
"taut": 0,
"tconj": 0,
"tdisj": 0,
"tneg": 0,
"transition_references": 0,
"unfir": 0,
"visible_places": 0,
"visible_transitions": 0
},
"processed": "TRUE",
"processed_size": 4,
"rewrites": 94
},
"result":
{
"edges": 0,
"markings": 0,
"produced_by": "preprocessing",
"value": true
},
"task":
{
"compoundnumber": 12,
"type": "initial_satisfaction",
"workflow": "preprocessing"
}
},
{
"call":
{
"dynamic_timelimit": true,
"localtimelimit": 1188
},
"exit":
{
"localtimelimitreached": false
},
"formula":
{
"count":
{
"A": 0,
"E": 1,
"F": 1,
"G": 0,
"U": 0,
"X": 0,
"aconj": 0,
"adisj": 0,
"aneg": 1,
"comp": 1,
"cont": 0,
"dl": 0,
"fir": 0,
"nodl": 0,
"place_references": 2,
"taut": 0,
"tconj": 0,
"tdisj": 0,
"tneg": 0,
"transition_references": 0,
"unfir": 0,
"visible_places": 2,
"visible_transitions": 0
},
"processed": "E (F ((p118 + 1 <= p76)))",
"processed_size": 25,
"rewrites": 95
},
"result":
{
"edges": 4,
"markings": 5,
"produced_by": "state space",
"value": true
},
"task":
{
"compoundnumber": 13,
"search":
{
"store":
{
"encoder": "simple compression",
"type": "prefix"
},
"stubborn":
{
"type": "reachability preserving/insertion"
},
"threads": 1,
"type": "dfs"
},
"stateequation":
{
"literals": 1,
"problems": 1
},
"type": "reachability",
"workflow": "stateequation||search"
}
},
{
"call":
{
"dynamic_timelimit": true,
"localtimelimit": 1782
},
"exit":
{
"localtimelimitreached": false
},
"formula":
{
"count":
{
"A": 1,
"E": 0,
"F": 0,
"G": 1,
"U": 0,
"X": 0,
"aconj": 0,
"adisj": 0,
"aneg": 0,
"comp": 1,
"cont": 0,
"dl": 0,
"fir": 0,
"nodl": 0,
"place_references": 2,
"taut": 0,
"tconj": 0,
"tdisj": 0,
"tneg": 0,
"transition_references": 0,
"unfir": 0,
"visible_places": 2,
"visible_transitions": 0
},
"processed": "A (G ((p124 <= p97)))",
"processed_size": 21,
"rewrites": 96
},
"result":
{
"edges": 10,
"markings": 9,
"produced_by": "state space",
"value": false
},
"task":
{
"compoundnumber": 14,
"search":
{
"store":
{
"encoder": "simple compression",
"type": "prefix"
},
"stubborn":
{
"type": "reachability preserving/insertion"
},
"threads": 1,
"type": "dfs"
},
"stateequation":
{
"literals": 1,
"problems": 1
},
"type": "invariance",
"workflow": "stateequation||search"
}
}
],
"exit":
{
"error": null,
"memory": 33328,
"runtime": 708.000000,
"signal": null,
"timelimitreached": false
},
"files":
{
"formula": "CTLCardinality.xml",
"net": "model.pnml"
},
"formula":
{
"skeleton": "DEADLOCK : TRUE : FALSE : FALSE : FALSE : ** : FALSE : TRUE : FALSE : FALSE : FALSE : A(G(**)) : FALSE : E(G(E(F(*)))) : E(F(*)) : TRUE"
},
"net":
{
"arcs": 10130,
"conflict_clusters": 25,
"places": 337,
"places_significant": 124,
"singleton_clusters": 0,
"transitions": 2605
},
"result":
{
"preliminary_value": "no yes no no no no no yes no no no no no unknown yes yes ",
"value": "no yes no no no no no yes no no no no no unknown yes yes "
},
"task":
{
"type": "compound"
}
}
lola: LoLA will run for 3570 seconds at most (--timelimit)
lola: NET
lola: input: PNML file (--pnml)
lola: reading net from model.pnml
lola: reading pnml
lola: PNML file contains place/transition net
lola: finished parsing
lola: closed net file model.pnml
lola: 2942/268435456 symbol table entries, 0 collisions
lola: preprocessing...
lola: Size of bit vector: 337
lola: finding significant places
lola: 337 places, 2605 transitions, 124 significant places
lola: compute conflict clusters
lola: computed conflict clusters
lola: Computing conflicting sets
lola: Computing back conflicting sets
lola: TASK
lola: Reading formula in XML format (--xmlformula)
lola: reading pnml
lola: reading formula from CTLCardinality.xml
lola: LP says that atomic proposition is always false: (2 <= p12)
lola: place invariant simplifies atomic proposition
lola: before: (p301 <= p213)
lola: after: (0 <= 0)
lola: LP says that atomic proposition is always false: (2 <= p296)
lola: LP says that atomic proposition is always false: (2 <= p193)
lola: place invariant simplifies atomic proposition
lola: before: (p157 <= p272)
lola: after: (0 <= 0)
lola: LP says that atomic proposition is always false: (2 <= p32)
lola: LP says that atomic proposition is always false: (3 <= p12)
lola: LP says that atomic proposition is always false: (3 <= p24)
lola: place invariant simplifies atomic proposition
lola: before: (p167 <= p222)
lola: after: (0 <= 0)
lola: place invariant simplifies atomic proposition
lola: before: (p272 <= p246)
lola: after: (0 <= 0)
lola: LP says that atomic proposition is always false: (3 <= p3)
lola: LP says that atomic proposition is always false: (3 <= p257)
lola: LP says that atomic proposition is always false: (3 <= p187)
lola: LP says that atomic proposition is always false: (3 <= p128)
lola: place invariant simplifies atomic proposition
lola: before: (p263 <= p156)
lola: after: (0 <= 0)
lola: LP says that atomic proposition is always false: (2 <= p128)
lola: LP says that atomic proposition is always true: (p39 <= p221)
lola: LP says that atomic proposition is always false: (3 <= p258)
lola: place invariant simplifies atomic proposition
lola: before: (p279 <= p221)
lola: after: (0 <= 0)
lola: place invariant simplifies atomic proposition
lola: before: (p277 <= p156)
lola: after: (0 <= 0)
lola: place invariant simplifies atomic proposition
lola: before: (p323 <= p147)
lola: after: (0 <= 0)
lola: LP says that atomic proposition is always false: (2 <= p210)
lola: LP says that atomic proposition is always true: (p46 <= p203)
lola: LP says that atomic proposition is always true: (p17 <= p215)
lola: place invariant simplifies atomic proposition
lola: before: (p301 <= p325)
lola: after: (0 <= 0)
lola: LP says that atomic proposition is always false: (2 <= p36)
lola: place invariant simplifies atomic proposition
lola: before: (p139 <= p178)
lola: after: (0 <= 0)
lola: LP says that atomic proposition is always false: (3 <= p310)
lola: LP says that atomic proposition is always false: (2 <= p53)
lola: LP says that atomic proposition is always false: (3 <= p123)
lola: LP says that atomic proposition is always false: (2 <= p100)
lola: LP says that atomic proposition is always true: (p137 <= p260)
lola: LP says that atomic proposition is always true: (p63 <= p199)
lola: place invariant simplifies atomic proposition
lola: before: (p156 <= p165)
lola: after: (0 <= 0)
lola: LP says that atomic proposition is always true: (p18 <= p262)
lola: LP says that atomic proposition is always false: (2 <= p150)
lola: place invariant simplifies atomic proposition
lola: before: (p239 <= p269)
lola: after: (0 <= 0)
lola: LP says that atomic proposition is always false: (3 <= p36)
lola: place invariant simplifies atomic proposition
lola: before: (p148 <= p158)
lola: after: (0 <= 0)
lola: A (X (E (F (())))) : NOT(E ((() U ()))) : E (F ((() AND E (F ((3 <= p12)))))) : E (F (())) : E (F ((E (X ((3 <= p3))) AND ()))) : A ((E (F ((3 <= p187))) U ((1 <= p291)))) : A (G (E (F ((1 <= 0))))) : ((2 <= p128) OR A (G (E (F ((p39 <= p221)))))) : E ((() U ())) : (((E (X ((p124 <= p77))) OR ()) AND ()) OR ((p64 <= p37) AND E (((0 <= 0) U (3 <= p310))))) : E (F (A (((2 <= p53) U (3 <= p123))))) : ((() AND E (F (()))) AND A (G (E (G ((p124 <= p97)))))) : NOT(A (X (A (G ((p18 <= p262)))))) : NOT(A (F (A (G ((p0 <= p46)))))) : NOT(((A (G ((p76 <= p118))) AND ()) AND ())) : A (G ((A (G ((p245 <= p57))) OR A (F ((0 <= 0))))))
lola: rewrite Frontend/Parser/formula_rewrite.k:98
lola: rewrite Frontend/Parser/formula_rewrite.k:157
lola: rewrite Frontend/Parser/formula_rewrite.k:148
lola: rewrite Frontend/Parser/formula_rewrite.k:139
lola: rewrite Frontend/Parser/formula_rewrite.k:100
lola: rewrite Frontend/Parser/formula_rewrite.k:98
lola: rewrite Frontend/Parser/formula_rewrite.k:169
lola: rewrite Frontend/Parser/formula_rewrite.k:157
lola: rewrite Frontend/Parser/formula_rewrite.k:148
lola: rewrite Frontend/Parser/formula_rewrite.k:282
lola: rewrite Frontend/Parser/formula_rewrite.k:98
lola: rewrite Frontend/Parser/formula_rewrite.k:98
lola: rewrite Frontend/Parser/formula_rewrite.k:157
lola: rewrite Frontend/Parser/formula_rewrite.k:148
lola: rewrite Frontend/Parser/formula_rewrite.k:118
lola: rewrite Frontend/Parser/formula_rewrite.k:157
lola: rewrite Frontend/Parser/formula_rewrite.k:148
lola: rewrite Frontend/Parser/formula_rewrite.k:98
lola: rewrite Frontend/Parser/formula_rewrite.k:157
lola: rewrite Frontend/Parser/formula_rewrite.k:148
lola: rewrite Frontend/Parser/formula_rewrite.k:98
lola: rewrite Frontend/Parser/formula_rewrite.k:133
lola: rewrite Frontend/Parser/formula_rewrite.k:100
lola: rewrite Frontend/Parser/formula_rewrite.k:118
lola: rewrite Frontend/Parser/formula_rewrite.k:157
lola: rewrite Frontend/Parser/formula_rewrite.k:148
lola: rewrite Frontend/Parser/formula_rewrite.k:98
lola: rewrite Frontend/Parser/formula_rewrite.k:157
lola: rewrite Frontend/Parser/formula_rewrite.k:148
lola: rewrite Frontend/Parser/formula_rewrite.k:184
lola: rewrite Frontend/Parser/formula_rewrite.k:98
lola: rewrite Frontend/Parser/formula_rewrite.k:157
lola: rewrite Frontend/Parser/formula_rewrite.k:148
lola: rewrite Frontend/Parser/formula_rewrite.k:163
lola: rewrite Frontend/Parser/formula_rewrite.k:151
lola: rewrite Frontend/Parser/formula_rewrite.k:98
lola: rewrite Frontend/Parser/formula_rewrite.k:100
lola: rewrite Frontend/Parser/formula_rewrite.k:154
lola: rewrite Frontend/Parser/formula_rewrite.k:148
lola: rewrite Frontend/Parser/formula_rewrite.k:160
lola: rewrite Frontend/Parser/formula_rewrite.k:151
lola: rewrite Frontend/Parser/formula_rewrite.k:122
lola: rewrite Frontend/Parser/formula_rewrite.k:100
lola: rewrite Frontend/Parser/formula_rewrite.k:98
lola: rewrite Frontend/Parser/formula_rewrite.k:169
lola: rewrite Frontend/Parser/formula_rewrite.k:157
lola: rewrite Frontend/Parser/formula_rewrite.k:148
lola: rewrite Frontend/Parser/formula_rewrite.k:100
lola: rewrite Frontend/Parser/formula_rewrite.k:123
lola: rewrite Frontend/Parser/formula_rewrite.k:98
lola: rewrite Frontend/Parser/formula_rewrite.k:116
lola: rewrite Frontend/Parser/formula_rewrite.k:100
lola: rewrite Frontend/Parser/formula_rewrite.k:98
lola: rewrite Frontend/Parser/formula_rewrite.k:169
lola: rewrite Frontend/Parser/formula_rewrite.k:157
lola: rewrite Frontend/Parser/formula_rewrite.k:148
lola: rewrite Frontend/Parser/formula_rewrite.k:117
lola: rewrite Frontend/Parser/formula_rewrite.k:122
lola: rewrite Frontend/Parser/formula_rewrite.k:98
lola: rewrite Frontend/Parser/formula_rewrite.k:98
lola: rewrite Frontend/Parser/formula_rewrite.k:180
lola: rewrite Frontend/Parser/formula_rewrite.k:151
lola: rewrite Frontend/Parser/formula_rewrite.k:157
lola: rewrite Frontend/Parser/formula_rewrite.k:148
lola: rewrite Frontend/Parser/formula_rewrite.k:100
lola: rewrite Frontend/Parser/formula_rewrite.k:100
lola: rewrite Frontend/Parser/formula_rewrite.k:154
lola: rewrite Frontend/Parser/formula_rewrite.k:148
lola: rewrite Frontend/Parser/formula_rewrite.k:116
lola: rewrite Frontend/Parser/formula_rewrite.k:458
lola: rewrite Frontend/Parser/formula_rewrite.k:116
lola: rewrite Frontend/Parser/formula_rewrite.k:100
lola: rewrite Frontend/Parser/formula_rewrite.k:160
lola: rewrite Frontend/Parser/formula_rewrite.k:151
lola: rewrite Frontend/Parser/formula_rewrite.k:136
lola: rewrite Frontend/Parser/formula_rewrite.k:279
lola: rewrite Frontend/Parser/formula_rewrite.k:323
lola: rewrite Frontend/Parser/formula_rewrite.k:332
lola: rewrite Frontend/Parser/formula_rewrite.k:323
lola: rewrite Frontend/Parser/formula_rewrite.k:329
lola: rewrite Frontend/Parser/formula_rewrite.k:297
lola: rewrite Frontend/Parser/formula_rewrite.k:100
lola: rewrite Frontend/Parser/formula_rewrite.k:115
lola: rewrite Frontend/Parser/formula_rewrite.k:100
lola: rewrite Frontend/Parser/formula_rewrite.k:115
lola: rewrite Frontend/Parser/formula_rewrite.k:323
lola: rewrite Frontend/Parser/formula_rewrite.k:329
lola: rewrite Frontend/Parser/formula_rewrite.k:297
lola: rewrite Frontend/Parser/formula_rewrite.k:100
lola: rewrite Frontend/Parser/formula_rewrite.k:154
lola: rewrite Frontend/Parser/formula_rewrite.k:151
lola: rewrite Frontend/Parser/formula_rewrite.k:123
lola: rewrite Frontend/Parser/formula_rewrite.k:160
lola: rewrite Frontend/Parser/formula_rewrite.k:151
lola: computing a collection of formulas
lola: RUNNING
lola: subprocess 0 will run for 222 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: DEADLOCK
lola: ========================================
lola: SUBTASK
lola: checking initial satisfaction
lola: processed formula: DEADLOCK
lola: processed formula length: 8
lola: 94 rewrites
lola: closed formula file CTLCardinality.xml
lola: processed formula with 0 atomic propositions
lola: RUNNING
lola: SUBRESULT
lola: result: no
lola: produced by: preprocessing
lola: The net violates the given property already in its initial state.
lola: 0 markings, 0 edges
lola: ========================================
lola: subprocess 1 will run for 237 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: TRUE
lola: ========================================
lola: SUBTASK
lola: checking initial satisfaction
lola: processed formula: TRUE
lola: processed formula length: 4
lola: 94 rewrites
lola: closed formula file CTLCardinality.xml
lola: processed formula with 0 atomic propositions
lola: RUNNING
lola: SUBRESULT
lola: result: yes
lola: produced by: preprocessing
lola: The net satisfies the property already in its initial state.
lola: 0 markings, 0 edges
lola: ========================================
lola: subprocess 2 will run for 254 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: FALSE
lola: ========================================
lola: SUBTASK
lola: checking initial satisfaction
lola: processed formula: FALSE
lola: processed formula length: 5
lola: 94 rewrites
lola: closed formula file CTLCardinality.xml
lola: processed formula with 0 atomic propositions
lola: RUNNING
lola: SUBRESULT
lola: result: no
lola: produced by: preprocessing
lola: The net violates the given property already in its initial state.
lola: 0 markings, 0 edges
lola: ========================================
lola: subprocess 3 will run for 274 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: FALSE
lola: ========================================
lola: SUBTASK
lola: checking initial satisfaction
lola: processed formula: FALSE
lola: processed formula length: 5
lola: 94 rewrites
lola: closed formula file CTLCardinality.xml
lola: processed formula with 0 atomic propositions
lola: RUNNING
lola: SUBRESULT
lola: result: no
lola: produced by: preprocessing
lola: The net violates the given property already in its initial state.
lola: 0 markings, 0 edges
lola: ========================================
lola: subprocess 4 will run for 297 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: FALSE
lola: ========================================
lola: SUBTASK
lola: checking initial satisfaction
lola: processed formula: FALSE
lola: processed formula length: 5
lola: 94 rewrites
lola: closed formula file CTLCardinality.xml
lola: processed formula with 0 atomic propositions
lola: RUNNING
lola: SUBRESULT
lola: result: no
lola: produced by: preprocessing
lola: The net violates the given property already in its initial state.
lola: 0 markings, 0 edges
lola: ========================================
lola: subprocess 5 will run for 324 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: ((1 <= p291))
lola: ========================================
lola: SUBTASK
lola: checking initial satisfaction
lola: processed formula: ((1 <= p291))
lola: processed formula length: 13
lola: 94 rewrites
lola: closed formula file CTLCardinality.xml
lola: processed formula with 1 atomic propositions
lola: RUNNING
lola: SUBRESULT
lola: result: no
lola: produced by: preprocessing
lola: The net violates the given property already in its initial state.
lola: 0 markings, 0 edges
lola: ========================================
lola: subprocess 6 will run for 356 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: FALSE
lola: ========================================
lola: SUBTASK
lola: checking initial satisfaction
lola: processed formula: FALSE
lola: processed formula length: 5
lola: 94 rewrites
lola: closed formula file CTLCardinality.xml
lola: processed formula with 0 atomic propositions
lola: RUNNING
lola: SUBRESULT
lola: result: no
lola: produced by: preprocessing
lola: The net violates the given property already in its initial state.
lola: 0 markings, 0 edges
lola: ========================================
lola: subprocess 7 will run for 396 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: TRUE
lola: ========================================
lola: SUBTASK
lola: checking initial satisfaction
lola: processed formula: TRUE
lola: processed formula length: 4
lola: 94 rewrites
lola: closed formula file CTLCardinality.xml
lola: processed formula with 0 atomic propositions
lola: RUNNING
lola: SUBRESULT
lola: result: yes
lola: produced by: preprocessing
lola: The net satisfies the property already in its initial state.
lola: 0 markings, 0 edges
lola: ========================================
lola: subprocess 8 will run for 445 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: FALSE
lola: ========================================
lola: SUBTASK
lola: checking initial satisfaction
lola: processed formula: FALSE
lola: processed formula length: 5
lola: 94 rewrites
lola: closed formula file CTLCardinality.xml
lola: processed formula with 0 atomic propositions
lola: RUNNING
lola: SUBRESULT
lola: result: no
lola: produced by: preprocessing
lola: The net violates the given property already in its initial state.
lola: 0 markings, 0 edges
lola: ========================================
lola: subprocess 9 will run for 509 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: FALSE
lola: ========================================
lola: SUBTASK
lola: checking initial satisfaction
lola: processed formula: FALSE
lola: processed formula length: 5
lola: 94 rewrites
lola: closed formula file CTLCardinality.xml
lola: processed formula with 0 atomic propositions
lola: RUNNING
lola: SUBRESULT
lola: result: no
lola: produced by: preprocessing
lola: The net violates the given property already in its initial state.
lola: 0 markings, 0 edges
lola: ========================================
lola: subprocess 10 will run for 594 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: FALSE
lola: ========================================
lola: SUBTASK
lola: checking initial satisfaction
lola: processed formula: FALSE
lola: processed formula length: 5
lola: 94 rewrites
lola: closed formula file CTLCardinality.xml
lola: processed formula with 0 atomic propositions
lola: RUNNING
lola: SUBRESULT
lola: result: no
lola: produced by: preprocessing
lola: The net violates the given property already in its initial state.
lola: 0 markings, 0 edges
lola: ========================================
lola: subprocess 11 will run for 712 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: FALSE
lola: ========================================
lola: SUBTASK
lola: checking initial satisfaction
lola: processed formula: FALSE
lola: processed formula length: 5
lola: 94 rewrites
lola: closed formula file CTLCardinality.xml
lola: processed formula with 0 atomic propositions
lola: RUNNING
lola: SUBRESULT
lola: result: no
lola: produced by: preprocessing
lola: The net violates the given property already in its initial state.
lola: 0 markings, 0 edges
lola: ========================================
lola: subprocess 12 will run for 891 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: TRUE
lola: ========================================
lola: SUBTASK
lola: checking initial satisfaction
lola: processed formula: TRUE
lola: processed formula length: 4
lola: 94 rewrites
lola: closed formula file CTLCardinality.xml
lola: processed formula with 0 atomic propositions
lola: RUNNING
lola: SUBRESULT
lola: result: yes
lola: produced by: preprocessing
lola: The net satisfies the property already in its initial state.
lola: 0 markings, 0 edges
lola: ========================================
lola: subprocess 13 will run for 1188 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: E (F ((p118 + 1 <= p76)))
lola: ========================================
lola: SUBTASK
lola: checking reachability
lola: Planning: workflow for reachability check: stateequation||search (--findpath=off)
lola: rewrite Frontend/Parser/formula_rewrite.k:711
lola: processed formula: E (F ((p118 + 1 <= p76)))
lola: processed formula length: 25
lola: 95 rewrites
lola: closed formula file CTLCardinality.xml
lola: STORE
lola: using a simple compression encoder (--encoder=simplecompressed)
lola: using a prefix tree store (--store=prefix)
lola: SEARCH (state space)
lola: state space: using reachability graph (--search=depth)
lola: state space: using reachability preserving stubborn set method with insertion algorithm (--stubborn=tarjan)
lola: built state equation task
lola: RUNNING
lola: state equation task get result started, id 0
lola: rewrite Frontend/Parser/formula_rewrite.k:711
lola: state equation task get result rewrite finished id 0
lola: state equation task get result unparse finished++ id 0
lola: formula 0: (p118 + 1 <= p76)
lola: state equation task get result unparse finished id 0
lola: state equation: Generated DNF with 1 literals and 1 conjunctive subformulas
lola: SUBRESULT
lola: result: yes
lola: produced by: state space
lola: The predicate is reachable.
lola: 5 markings, 4 edges
lola: subprocess 14 will run for 1782 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: A (G ((p124 <= p97)))
lola: ========================================
lola: SUBTASK
lola: checking invariance
lola: Planning: workflow for reachability check: stateequation||search (--findpath=off)
lola: rewrite Frontend/Parser/formula_rewrite.k:721
lola: rewrite Frontend/Parser/formula_rewrite.k:787
lola: processed formula: A (G ((p124 <= p97)))
lola: processed formula length: 21
lola: 96 rewrites
lola: closed formula file CTLCardinality.xml
lola: STORE
lola: using a simple compression encoder (--encoder=simplecompressed)
lola: using a prefix tree store (--store=prefix)
lola: SEARCH (state space)
lola: state space: using reachability graph (--search=depth)
lola: state space: using reachability preserving stubborn set method with insertion algorithm (--stubborn=tarjan)
lola: built state equation task
lola: RUNNING
lola: state equation task get result started, id 0
lola: rewrite Frontend/Parser/formula_rewrite.k:721
lola: rewrite Frontend/Parser/formula_rewrite.k:787
lola: state equation task get result rewrite finished id 0
lola: state equation task get result unparse finished++ id 0
lola: formula 0: (p97 + 1 <= p124)
lola: state equation task get result unparse finished id 0
lola: state equation: Generated DNF with 1 literals and 1 conjunctive subformulas
lola: ========================================
lola: SUBRESULT
lola: result: no
lola: produced by: state space
lola: The predicate is not invariant.
lola: 9 markings, 10 edges
lola: ========================================
lola: subprocess 15 will run for 3564 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: E (G (E (F ((p46 + 1 <= p0)))))
lola: ========================================
lola: SUBTASK
lola: checking possible preservation of reachability
lola: rewrite Frontend/Parser/formula_rewrite.k:593
lola: rewrite Frontend/Parser/formula_rewrite.k:628
lola: rewrite Frontend/Parser/formula_rewrite.k:731
lola: processed formula: (p46 + 1 <= p0)
lola: processed formula length: 15
lola: 97 rewrites
lola: closed formula file CTLCardinality.xml
lola: STORE
lola: using a simple compression encoder (--encoder=simplecompressed)
lola: using a prefix tree store (--store=prefix)
lola: SEARCH (state space /EGEF)
lola: state space: using reachability graph (EGEF version) (--search=depth)
lola: state space: using ctl preserving stubborn set method (--stubborn=tarjan)
lola: Planning: workflow for reachability check: stateequation (--findpath=off)
lola: built state equation task
lola: Planning: workflow for reachability check: stateequation (--findpath=off)
lola: built state equation task
lola: RUNNING
lola: state equation task get result started, id 0
lola: rewrite Frontend/Parser/formula_rewrite.k:721
lola: rewrite Frontend/Parser/formula_rewrite.k:788
lola: state equation task get result rewrite finished id 0
lola: state equation task get result unparse finished++ id 0
lola: formula 0: (p0 <= p46)
lola: state equation task get result unparse finished id 0
lola: state equation: Generated DNF with 1 literals and 1 conjunctive subformulas
lola: state equation task get result started, id 1
lola: rewrite Frontend/Parser/formula_rewrite.k:711
lola: state equation task get result rewrite finished id 1
lola: state equation task get result unparse finished++ id 1
lola: formula 1: (p46 + 1 <= p0)
lola: state equation task get result unparse finished id 1
lola: state equation: Generated DNF with 1 literals and 1 conjunctive subformulas
lola: state equation: write sara problem file to CTLCardinality-15-0.sara
lola: state equation: calling and running sara
sara: try reading problem file CTLCardinality-15-0.sara.
lola: state equation: write sara problem file to CTLCardinality-15-1.sara
lola: state equation: calling and running sara
sara: try reading problem file CTLCardinality-15-1.sara.
sara: place or transition ordering is non-deterministic
sara: place or transition ordering is non-deterministic
lola: state equation 0: solution produced
lola: state equation 1: solution produced
lola: sara is running 0 secs || sara is running 0 secs || 196981 markings, 4809023 edges, 39396 markings/sec, 0 secs
lola: sara is running 5 secs || sara is running 5 secs || 376064 markings, 9493991 edges, 35817 markings/sec, 5 secs
lola: sara is running 10 secs || sara is running 10 secs || 548954 markings, 14071869 edges, 34578 markings/sec, 10 secs
lola: sara is running 15 secs || sara is running 15 secs || 730073 markings, 18756268 edges, 36224 markings/sec, 15 secs
lola: sara is running 20 secs || sara is running 20 secs || 909399 markings, 23418068 edges, 35865 markings/sec, 20 secs
lola: sara is running 25 secs || sara is running 25 secs || 1068493 markings, 28096866 edges, 31819 markings/sec, 25 secs
lola: sara is running 30 secs || sara is running 30 secs || 1226373 markings, 32756495 edges, 31576 markings/sec, 30 secs
lola: sara is running 35 secs || sara is running 35 secs || 1386883 markings, 37420741 edges, 32102 markings/sec, 35 secs
lola: sara is running 40 secs || sara is running 40 secs || 1549701 markings, 42098456 edges, 32564 markings/sec, 40 secs
lola: sara is running 45 secs || sara is running 45 secs || 1707341 markings, 46822609 edges, 31528 markings/sec, 45 secs
lola: sara is running 50 secs || sara is running 50 secs || 1864991 markings, 51828698 edges, 31530 markings/sec, 50 secs
lola: sara is running 55 secs || sara is running 55 secs || 2020216 markings, 56782329 edges, 31045 markings/sec, 55 secs
lola: sara is running 60 secs || sara is running 60 secs || 2175138 markings, 61652955 edges, 30984 markings/sec, 60 secs
lola: sara is running 65 secs || sara is running 65 secs || 2332715 markings, 66549900 edges, 31515 markings/sec, 65 secs
lola: sara is running 70 secs || sara is running 70 secs || 2482891 markings, 71341059 edges, 30035 markings/sec, 70 secs
lola: sara is running 75 secs || sara is running 75 secs || 2625866 markings, 75905302 edges, 28595 markings/sec, 75 secs
lola: sara is running 80 secs || sara is running 80 secs || 2767950 markings, 80431852 edges, 28417 markings/sec, 80 secs
lola: sara is running 85 secs || sara is running 85 secs || 2916046 markings, 85083066 edges, 29619 markings/sec, 85 secs
lola: sara is running 90 secs || sara is running 90 secs || 3063849 markings, 89693873 edges, 29561 markings/sec, 90 secs
lola: sara is running 95 secs || sara is running 95 secs || 3206723 markings, 94264744 edges, 28575 markings/sec, 95 secs
lola: sara is running 100 secs || sara is running 100 secs || 3352324 markings, 99048106 edges, 29120 markings/sec, 100 secs
lola: sara is running 105 secs || sara is running 105 secs || 3491205 markings, 103811546 edges, 27776 markings/sec, 105 secs
lola: sara is running 110 secs || sara is running 110 secs || 3634844 markings, 108665962 edges, 28728 markings/sec, 110 secs
lola: sara is running 115 secs || sara is running 115 secs || 3770875 markings, 113315908 edges, 27206 markings/sec, 115 secs
lola: sara is running 120 secs || sara is running 120 secs || 3914436 markings, 118119455 edges, 28712 markings/sec, 120 secs
lola: sara is running 125 secs || sara is running 125 secs || 4052898 markings, 122860255 edges, 27692 markings/sec, 125 secs
lola: sara is running 130 secs || sara is running 130 secs || 4205203 markings, 127369770 edges, 30461 markings/sec, 130 secs
lola: sara is running 135 secs || sara is running 135 secs || 4357440 markings, 131845130 edges, 30447 markings/sec, 135 secs
lola: sara is running 140 secs || sara is running 140 secs || 4514093 markings, 136374757 edges, 31331 markings/sec, 140 secs
lola: sara is running 145 secs || sara is running 145 secs || 4673693 markings, 140946551 edges, 31920 markings/sec, 145 secs
lola: sara is running 150 secs || sara is running 150 secs || 4829445 markings, 145491038 edges, 31150 markings/sec, 150 secs
lola: sara is running 155 secs || sara is running 155 secs || 4976950 markings, 150105851 edges, 29501 markings/sec, 155 secs
lola: sara is running 160 secs || sara is running 160 secs || 5127142 markings, 154904104 edges, 30038 markings/sec, 160 secs
lola: sara is running 165 secs || sara is running 165 secs || 5280221 markings, 159672595 edges, 30616 markings/sec, 165 secs
lola: sara is running 170 secs || sara is running 170 secs || 5432548 markings, 164426617 edges, 30465 markings/sec, 170 secs
lola: sara is running 175 secs || sara is running 175 secs || 5580573 markings, 169133478 edges, 29605 markings/sec, 175 secs
lola: sara is running 180 secs || sara is running 180 secs || 5727358 markings, 173730203 edges, 29357 markings/sec, 180 secs
lola: sara is running 185 secs || sara is running 185 secs || 5866838 markings, 178170332 edges, 27896 markings/sec, 185 secs
lola: sara is running 190 secs || sara is running 190 secs || 6013237 markings, 182748339 edges, 29280 markings/sec, 190 secs
lola: sara is running 195 secs || sara is running 195 secs || 6153420 markings, 187189000 edges, 28037 markings/sec, 195 secs
lola: sara is running 200 secs || sara is running 200 secs || 6301896 markings, 191779762 edges, 29695 markings/sec, 200 secs
lola: sara is running 205 secs || sara is running 205 secs || 6442902 markings, 196272772 edges, 28201 markings/sec, 205 secs
lola: sara is running 210 secs || sara is running 210 secs || 6594605 markings, 200890652 edges, 30341 markings/sec, 210 secs
lola: sara is running 215 secs || sara is running 215 secs || 6744568 markings, 205402919 edges, 29993 markings/sec, 215 secs
lola: sara is running 220 secs || sara is running 220 secs || 6898382 markings, 209899305 edges, 30763 markings/sec, 220 secs
lola: sara is running 225 secs || sara is running 225 secs || 7074594 markings, 215015733 edges, 35242 markings/sec, 225 secs
lola: sara is running 230 secs || sara is running 230 secs || 7257019 markings, 220123469 edges, 36485 markings/sec, 230 secs
lola: sara is running 235 secs || sara is running 235 secs || 7427513 markings, 225142159 edges, 34099 markings/sec, 235 secs
lola: sara is running 240 secs || sara is running 240 secs || 7597508 markings, 230082400 edges, 33999 markings/sec, 240 secs
lola: sara is running 245 secs || sara is running 245 secs || 7766245 markings, 235032771 edges, 33747 markings/sec, 245 secs
lola: sara is running 250 secs || sara is running 250 secs || 7932935 markings, 239933721 edges, 33338 markings/sec, 250 secs
lola: sara is running 255 secs || sara is running 255 secs || 8109687 markings, 244928863 edges, 35350 markings/sec, 255 secs
lola: sara is running 260 secs || sara is running 260 secs || 8276843 markings, 249860321 edges, 33431 markings/sec, 260 secs
lola: sara is running 265 secs || sara is running 265 secs || 8442031 markings, 254754567 edges, 33038 markings/sec, 265 secs
lola: sara is running 270 secs || sara is running 270 secs || 8603990 markings, 259629410 edges, 32392 markings/sec, 270 secs
lola: sara is running 275 secs || sara is running 275 secs || 8777416 markings, 264528661 edges, 34685 markings/sec, 275 secs
lola: sara is running 280 secs || sara is running 280 secs || 8941228 markings, 269386167 edges, 32762 markings/sec, 280 secs
lola: sara is running 285 secs || sara is running 285 secs || 9122217 markings, 274296181 edges, 36198 markings/sec, 285 secs
lola: sara is running 290 secs || sara is running 290 secs || 9313103 markings, 279137333 edges, 38177 markings/sec, 290 secs
lola: sara is running 295 secs || sara is running 295 secs || 9487512 markings, 283956159 edges, 34882 markings/sec, 295 secs
lola: sara is running 300 secs || sara is running 300 secs || 9662054 markings, 288879875 edges, 34908 markings/sec, 300 secs
lola: sara is running 305 secs || sara is running 305 secs || 9830071 markings, 293731763 edges, 33603 markings/sec, 305 secs
lola: sara is running 310 secs || sara is running 310 secs || 9987116 markings, 298553212 edges, 31409 markings/sec, 310 secs
lola: sara is running 315 secs || sara is running 315 secs || 10148949 markings, 303373969 edges, 32367 markings/sec, 315 secs
lola: sara is running 320 secs || sara is running 320 secs || 10314028 markings, 308213799 edges, 33016 markings/sec, 320 secs
lola: sara is running 325 secs || sara is running 325 secs || 10470841 markings, 312935959 edges, 31363 markings/sec, 325 secs
lola: sara is running 330 secs || sara is running 330 secs || 10523715 markings, 314459132 edges, 10575 markings/sec, 330 secs
lola: sara is running 335 secs || sara is running 335 secs || 10524806 markings, 314486441 edges, 218 markings/sec, 335 secs
lola: sara is running 340 secs || sara is running 340 secs || 10525623 markings, 314506596 edges, 163 markings/sec, 340 secs
lola: sara is running 345 secs || sara is running 345 secs || 10525638 markings, 314506900 edges, 3 markings/sec, 345 secs
lola: sara is running 350 secs || sara is running 350 secs || 10525706 markings, 314508328 edges, 14 markings/sec, 350 secs
lola: Child process aborted or communication problem between parent and child process
lola: ========================================
lola: ...considering subproblem: E (G (E (F ((p46 + 1 <= p0)))))
lola: ========================================
lola: SUBTASK
lola: checking possible preservation of reachability
lola: rewrite Frontend/Parser/formula_rewrite.k:593
lola: rewrite Frontend/Parser/formula_rewrite.k:628
lola: rewrite Frontend/Parser/formula_rewrite.k:731
lola: processed formula: (p46 + 1 <= p0)
lola: processed formula length: 15
lola: 97 rewrites
lola: closed formula file CTLCardinality.xml
lola: STORE
lola: using a simple compression encoder (--encoder=simplecompressed)
lola: using a prefix tree store (--store=prefix)
lola: SEARCH (state space /EGEF)
lola: state space: using reachability graph (EGEF version) (--search=depth)
lola: state space: using ctl preserving stubborn set method (--stubborn=tarjan)
lola: Planning: workflow for reachability check: stateequation (--findpath=off)
lola: built state equation task
lola: Planning: workflow for reachability check: stateequation (--findpath=off)
lola: built state equation task
lola: RUNNING
lola: state equation task get result started, id 1
lola: rewrite Frontend/Parser/formula_rewrite.k:711
lola: state equation task get result rewrite finished id 1
lola: state equation task get result started, id 0
lola: rewrite Frontend/Parser/formula_rewrite.k:721
lola: rewrite Frontend/Parser/formula_rewrite.k:788
lola: state equation task get result rewrite finished id 0
lola: state equation task get result unparse finished++ id 0
lola: formula 0: (p0 <= p46)
lola: state equation task get result unparse finished id 0
lola: state equation: Generated DNF with 1 literals and 1 conjunctive subformulas
lola: state equation task get result unparse finished++ id 1
lola: formula 1: (p46 + 1 <= p0)
lola: state equation task get result unparse finished id 1
lola: state equation: Generated DNF with 1 literals and 1 conjunctive subformulas
lola: state equation: write sara problem file to CTLCardinality-16-0.sara
lola: state equation: calling and running sara
sara: try reading problem file CTLCardinality-16-0.sara.
lola: state equation: write sara problem file to CTLCardinality-16-1.sara
lola: state equation: calling and running sara
sara: try reading problem file CTLCardinality-16-1.sara.
sara: place or transition ordering is non-deterministic
lola: state equation 0: solution produced
sara: place or transition ordering is non-deterministic
lola: state equation 1: solution produced
lola: sara is running 0 secs || sara is running 0 secs || 176038 markings, 4328530 edges, 35208 markings/sec, 0 secs
lola: sara is running 5 secs || sara is running 5 secs || 363297 markings, 9146320 edges, 37452 markings/sec, 5 secs
lola: sara is running 10 secs || sara is running 10 secs || 539176 markings, 13806205 edges, 35176 markings/sec, 10 secs
lola: sara is running 15 secs || sara is running 15 secs || 723140 markings, 18563727 edges, 36793 markings/sec, 15 secs
lola: sara is running 20 secs || sara is running 20 secs || 905556 markings, 23304031 edges, 36483 markings/sec, 20 secs
lola: sara is running 25 secs || sara is running 25 secs || 1066256 markings, 28028912 edges, 32140 markings/sec, 25 secs
lola: sara is running 30 secs || sara is running 30 secs || 1223367 markings, 32672696 edges, 31422 markings/sec, 30 secs
lola: sara is running 35 secs || sara is running 35 secs || 1383196 markings, 37313117 edges, 31966 markings/sec, 35 secs
lola: sara is running 40 secs || sara is running 40 secs || 1546033 markings, 41987370 edges, 32567 markings/sec, 40 secs
lola: sara is running 45 secs || sara is running 45 secs || 1703189 markings, 46688540 edges, 31431 markings/sec, 45 secs
lola: sara is running 50 secs || sara is running 50 secs || 1860822 markings, 51700275 edges, 31527 markings/sec, 50 secs
lola: sara is running 55 secs || sara is running 55 secs || 2015344 markings, 56638562 edges, 30904 markings/sec, 55 secs
lola: sara is running 60 secs || sara is running 60 secs || 2170471 markings, 61501067 edges, 31025 markings/sec, 60 secs
lola: sara is running 65 secs || sara is running 65 secs || 2327250 markings, 66378362 edges, 31356 markings/sec, 65 secs
lola: sara is running 70 secs || sara is running 70 secs || 2476530 markings, 71146053 edges, 29856 markings/sec, 70 secs
lola: sara is running 75 secs || sara is running 75 secs || 2617841 markings, 75645124 edges, 28262 markings/sec, 75 secs
lola: sara is running 80 secs || sara is running 80 secs || 2757693 markings, 80095396 edges, 27970 markings/sec, 80 secs
lola: sara is running 85 secs || sara is running 85 secs || 2904596 markings, 84703304 edges, 29381 markings/sec, 85 secs
lola: sara is running 90 secs || sara is running 90 secs || 3049580 markings, 89243993 edges, 28997 markings/sec, 90 secs
lola: sara is running 95 secs || sara is running 95 secs || 3190597 markings, 93769292 edges, 28203 markings/sec, 95 secs
lola: sara is running 100 secs || sara is running 100 secs || 3335838 markings, 98487582 edges, 29048 markings/sec, 100 secs
lola: sara is running 105 secs || sara is running 105 secs || 3474594 markings, 103246376 edges, 27751 markings/sec, 105 secs
lola: sara is running 110 secs || sara is running 110 secs || 3616593 markings, 108092906 edges, 28400 markings/sec, 110 secs
lola: sara is running 115 secs || sara is running 115 secs || 3757645 markings, 112867978 edges, 28210 markings/sec, 115 secs
lola: sara is running 120 secs || sara is running 120 secs || 3901563 markings, 117681276 edges, 28784 markings/sec, 120 secs
lola: sara is running 125 secs || sara is running 125 secs || 4039868 markings, 122413035 edges, 27661 markings/sec, 125 secs
lola: sara is running 130 secs || sara is running 130 secs || 4188355 markings, 126856673 edges, 29697 markings/sec, 130 secs
lola: sara is running 135 secs || sara is running 135 secs || 4336827 markings, 131238397 edges, 29694 markings/sec, 135 secs
lola: sara is running 140 secs || sara is running 140 secs || 4493650 markings, 135757507 edges, 31365 markings/sec, 140 secs
lola: sara is running 145 secs || sara is running 145 secs || 4649135 markings, 140236014 edges, 31097 markings/sec, 145 secs
lola: sara is running 150 secs || sara is running 150 secs || 4800753 markings, 144681045 edges, 30324 markings/sec, 150 secs
lola: sara is running 155 secs || sara is running 155 secs || 4953718 markings, 149375963 edges, 30593 markings/sec, 155 secs
lola: sara is running 160 secs || sara is running 160 secs || 5101690 markings, 154073834 edges, 29594 markings/sec, 160 secs
lola: sara is running 165 secs || sara is running 165 secs || 5254374 markings, 158846925 edges, 30537 markings/sec, 165 secs
lola: sara is running 170 secs || sara is running 170 secs || 5403818 markings, 163537313 edges, 29889 markings/sec, 170 secs
lola: sara is running 175 secs || sara is running 175 secs || 5552454 markings, 168228267 edges, 29727 markings/sec, 175 secs
lola: sara is running 180 secs || sara is running 180 secs || 5698097 markings, 172838837 edges, 29129 markings/sec, 180 secs
lola: sara is running 185 secs || sara is running 185 secs || 5839571 markings, 177302284 edges, 28295 markings/sec, 185 secs
lola: sara is running 190 secs || sara is running 190 secs || 5982310 markings, 181837532 edges, 28548 markings/sec, 190 secs
lola: sara is running 195 secs || sara is running 195 secs || 6127512 markings, 186365077 edges, 29040 markings/sec, 195 secs
lola: sara is running 200 secs || sara is running 200 secs || 6275494 markings, 190950228 edges, 29596 markings/sec, 200 secs
lola: sara is running 205 secs || sara is running 205 secs || 6417604 markings, 195453905 edges, 28422 markings/sec, 205 secs
lola: sara is running 210 secs || sara is running 210 secs || 6569139 markings, 200115139 edges, 30307 markings/sec, 210 secs
lola: sara is running 215 secs || sara is running 215 secs || 6720350 markings, 204656067 edges, 30242 markings/sec, 215 secs
lola: sara is running 220 secs || sara is running 220 secs || 6872977 markings, 209138166 edges, 30525 markings/sec, 220 secs
lola: sara is running 225 secs || sara is running 225 secs || 7044070 markings, 214126419 edges, 34219 markings/sec, 225 secs
lola: sara is running 230 secs || sara is running 230 secs || 7225594 markings, 219264191 edges, 36305 markings/sec, 230 secs
lola: sara is running 235 secs || sara is running 235 secs || 7400233 markings, 224339346 edges, 34928 markings/sec, 235 secs
lola: sara is running 240 secs || sara is running 240 secs || 7570614 markings, 229316976 edges, 34076 markings/sec, 240 secs
lola: sara is running 245 secs || sara is running 245 secs || 7741225 markings, 234292332 edges, 34122 markings/sec, 245 secs
lola: sara is running 250 secs || sara is running 250 secs || 7909386 markings, 239230005 edges, 33632 markings/sec, 250 secs
lola: sara is running 255 secs || sara is running 255 secs || 8086121 markings, 244248974 edges, 35347 markings/sec, 255 secs
lola: sara is running 260 secs || sara is running 260 secs || 8254803 markings, 249192834 edges, 33736 markings/sec, 260 secs
lola: sara is running 265 secs || sara is running 265 secs || 8421127 markings, 254125292 edges, 33265 markings/sec, 265 secs
lola: sara is running 270 secs || sara is running 270 secs || 8585451 markings, 259059682 edges, 32865 markings/sec, 270 secs
lola: sara is running 275 secs || sara is running 275 secs || 8755658 markings, 263954639 edges, 34041 markings/sec, 275 secs
lola: sara is running 280 secs || sara is running 280 secs || 8921381 markings, 268813577 edges, 33145 markings/sec, 280 secs
lola: sara is running 285 secs || sara is running 285 secs || 9101273 markings, 273769935 edges, 35978 markings/sec, 285 secs
lola: sara is running 290 secs || sara is running 290 secs || 9289284 markings, 278614830 edges, 37602 markings/sec, 290 secs
lola: sara is running 295 secs || sara is running 295 secs || 9469239 markings, 283431185 edges, 35991 markings/sec, 295 secs
lola: sara is running 300 secs || sara is running 300 secs || 9647332 markings, 288462941 edges, 35619 markings/sec, 300 secs
lola: sara is running 305 secs || sara is running 305 secs || 9820920 markings, 293452110 edges, 34718 markings/sec, 305 secs
lola: sara is running 310 secs || sara is running 310 secs || 9981767 markings, 298384035 edges, 32169 markings/sec, 310 secs
lola: sara is running 315 secs || sara is running 315 secs || 10146823 markings, 303307789 edges, 33011 markings/sec, 315 secs
lola: sara is running 320 secs || sara is running 320 secs || 10315353 markings, 308256216 edges, 33706 markings/sec, 320 secs
lola: sara is running 325 secs || sara is running 325 secs || 10475584 markings, 313072299 edges, 32046 markings/sec, 325 secs
lola: sara is running 330 secs || sara is running 330 secs || 10523781 markings, 314460878 edges, 9639 markings/sec, 330 secs
lola: Child process aborted or communication problem between parent and child process
lola: RESULT
lola:
SUMMARY: no yes no no no no no yes no no no no no unknown yes yes
lola:
preliminary result: no yes no no no no no yes no no no no no unknown yes yes
lola: memory consumption: 33328 KB
lola: time consumption: 708 seconds
lola: print data as JSON (--json)
lola: writing JSON to CTLCardinality.json
lola: closed JSON file CTLCardinality.json
rslt: finished
BK_STOP 1552458072332
--------------------
content from stderr:
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="DLCround-PT-10a"
export BK_EXAMINATION="CTLCardinality"
export BK_TOOL="lola"
export BK_RESULT_DIR="/tmp/BK_RESULTS/OUTPUTS"
export BK_TIME_CONFINEMENT="3600"
export BK_MEMORY_CONFINEMENT="16384"
# this is specific to your benchmark or test
export BIN_DIR="$HOME/BenchKit/bin"
# remove the execution directoty if it exists (to avoid increse of .vmdk images)
if [ -d execution ] ; then
rm -rf execution
fi
# this is for BenchKit: explicit launching of the test
echo "====================================================================="
echo " Generated by BenchKit 2-3954"
echo " Executing tool lola"
echo " Input is DLCround-PT-10a, examination is CTLCardinality"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 4"
echo " Run identifier is r049-oct2-155234405100436"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"
tar xzf /home/mcc/BenchKit/INPUTS/DLCround-PT-10a.tgz
mv DLCround-PT-10a execution
cd execution
if [ "CTLCardinality" = "GlobalProperties" ] ; then
rm -f GenericPropertiesVerdict.xml
fi
if [ "CTLCardinality" = "UpperBounds" ] ; then
rm -f GenericPropertiesVerdict.xml
fi
pwd
ls -lh
echo
echo "--------------------"
echo "content from stdout:"
echo
echo "=== Data for post analysis generated by BenchKit (invocation template)"
echo
if [ "CTLCardinality" = "UpperBounds" ] ; then
echo "The expected result is a vector of positive values"
echo NUM_VECTOR
elif [ "CTLCardinality" != "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 "CTLCardinality.txt" ] ; then
echo "here is the order used to build the result vector(from text file)"
for x in $(grep Property CTLCardinality.txt | cut -d ' ' -f 2 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ -f "CTLCardinality.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
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 ;