Execution Chart

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

Trace from the execution

Waiting for the VM to be ready (probing ssh)
......................
/home/mcc/execution
total 252K
-rw-r--r-- 1 mcc users 3.8K May 15 18:54 CTLCardinality.txt
-rw-r--r-- 1 mcc users 19K May 15 18:54 CTLCardinality.xml
-rw-r--r-- 1 mcc users 2.8K May 15 18:54 CTLFireability.txt
-rw-r--r-- 1 mcc users 17K May 15 18:54 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.0K May 15 18:50 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 6.2K May 15 18:50 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 2.7K May 26 09:27 LTLCardinality.txt
-rw-r--r-- 1 mcc users 12K May 26 09:27 LTLCardinality.xml
-rw-r--r-- 1 mcc users 1.9K May 26 09:27 LTLFireability.txt
-rw-r--r-- 1 mcc users 7.5K May 26 09:27 LTLFireability.xml
-rw-r--r-- 1 mcc users 3.7K May 15 18:54 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 17K May 15 18:54 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 111 May 15 18:54 ReachabilityDeadlock.txt
-rw-r--r-- 1 mcc users 349 May 15 18:54 ReachabilityDeadlock.xml
-rw-r--r-- 1 mcc users 3.0K May 15 18:54 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 16K May 15 18:54 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.8K May 15 18:54 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.8K May 15 18:54 UpperBounds.xml
-rw-r--r-- 1 mcc users 5 May 15 18:50 equiv_pt
-rw-r--r-- 1 mcc users 7 May 15 18:50 instance
-rw-r--r-- 1 mcc users 5 May 15 18:50 iscolored
-rw-r--r-- 1 mcc users 92K May 15 18:50 model.pnml
=====================================================================
Generated by BenchKit 2-3637
Executing tool itstools
Input is PolyORBNT-COL-S05J20, examination is LTLCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r212-smll-152732263200425
=====================================================================

--------------------
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-COL-S05J20-LTLCardinality-00
FORMULA_NAME PolyORBNT-COL-S05J20-LTLCardinality-01
FORMULA_NAME PolyORBNT-COL-S05J20-LTLCardinality-02
FORMULA_NAME PolyORBNT-COL-S05J20-LTLCardinality-03
FORMULA_NAME PolyORBNT-COL-S05J20-LTLCardinality-04
FORMULA_NAME PolyORBNT-COL-S05J20-LTLCardinality-05
FORMULA_NAME PolyORBNT-COL-S05J20-LTLCardinality-06
FORMULA_NAME PolyORBNT-COL-S05J20-LTLCardinality-07
FORMULA_NAME PolyORBNT-COL-S05J20-LTLCardinality-08
FORMULA_NAME PolyORBNT-COL-S05J20-LTLCardinality-09
FORMULA_NAME PolyORBNT-COL-S05J20-LTLCardinality-10
FORMULA_NAME PolyORBNT-COL-S05J20-LTLCardinality-11
FORMULA_NAME PolyORBNT-COL-S05J20-LTLCardinality-12
FORMULA_NAME PolyORBNT-COL-S05J20-LTLCardinality-13
FORMULA_NAME PolyORBNT-COL-S05J20-LTLCardinality-14
FORMULA_NAME PolyORBNT-COL-S05J20-LTLCardinality-15

=== Now, execution of the tool begins

BK_START 1527797021550

20:03:45.067 [main] ERROR PNML validation - The rng grammar file can't be accessed : www.pnml.org
20:03:45.071 [main] ERROR import - Grammar file errors have been raised, the validation can't be done, process will continue without Grammar validation
Using solver Z3 to compute partial order matrices.
Built C files in :
/home/mcc/execution
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.201805151631/bin/its-ltl-linux64, --gc-threshold, 2000000, -i, /home/mcc/execution/LTLCardinality.pnml.gal, -t, CGAL, -LTL, /home/mcc/execution/LTLCardinality.ltl, -c, -stutter-deadlock], workingDir=/home/mcc/execution]

its-ltl command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.201805151631/bin/its-ltl-linux64 --gc-threshold 2000000 -i /home/mcc/execution/LTLCardinality.pnml.gal -t CGAL -LTL /home/mcc/execution/LTLCardinality.ltl -c -stutter-deadlock
Read 16 LTL properties
Checking formula 0 : !(("(((((((((((((((((((((Perform_Work_B_0+Perform_Work_B_1)+Perform_Work_B_2)+Perform_Work_B_3)+Perform_Work_B_4)+Perform_Work_B_5)+Perform_Work_B_6)+Perform_Work_B_7)+Perform_Work_B_8)+Perform_Work_B_9)+Perform_Work_B_10)+Perform_Work_B_11)+Perform_Work_B_12)+Perform_Work_B_13)+Perform_Work_B_14)+Perform_Work_B_15)+Perform_Work_B_16)+Perform_Work_B_17)+Perform_Work_B_18)+Perform_Work_B_19)+Perform_Work_B_20)>=3)"))
Formula 0 simplified : !"(((((((((((((((((((((Perform_Work_B_0+Perform_Work_B_1)+Perform_Work_B_2)+Perform_Work_B_3)+Perform_Work_B_4)+Perform_Work_B_5)+Perform_Work_B_6)+Perform_Work_B_7)+Perform_Work_B_8)+Perform_Work_B_9)+Perform_Work_B_10)+Perform_Work_B_11)+Perform_Work_B_12)+Perform_Work_B_13)+Perform_Work_B_14)+Perform_Work_B_15)+Perform_Work_B_16)+Perform_Work_B_17)+Perform_Work_B_18)+Perform_Work_B_19)+Perform_Work_B_20)>=3)"
Presburger conditions satisfied. Using coverability to approximate state space in K-Induction.
Normalized transition count is 571
// Phase 1: matrix 571 rows 369 cols
invariant :CreatedJobs_45 + CreatedJobs_46 + CreatedJobs_47 + CreatedJobs_48 + CreatedJobs_49 + AvailableJobId_9 = 1
invariant :block_0 + f3_0 + f3_1 + f3_2 + f3_3 + f3_4 + f3_5 + f3_6 + f3_7 + f3_8 + f3_9 + f3_10 + f3_11 + f3_12 + f3_13 + f3_14 + f3_15 + f3_16 + f3_17 + f3_18 + f3_19 + f3_20 + f2_0 + f2_1 + f2_2 + f2_3 + f2_4 + f2_5 + f2_6 + f2_7 + f2_8 + f2_9 + f2_10 + f2_11 + f2_12 + f2_13 + f2_14 + f2_15 + f2_16 + f2_17 + f2_18 + f2_19 + f2_20 + f1_0 + f1_1 + f1_2 + f1_3 + f1_4 + f1_5 + f1_6 + f1_7 + f1_8 + f1_9 + f1_10 + f1_11 + f1_12 + f1_13 + f1_14 + f1_15 + f1_16 + f1_17 + f1_18 + f1_19 + f1_20 = 3
invariant :CreatedJobs_75 + CreatedJobs_76 + CreatedJobs_77 + CreatedJobs_78 + CreatedJobs_79 + AvailableJobId_15 = 1
invariant :FetchJobE_0 + FetchJobE_1 + FetchJobE_2 + FetchJobE_3 + FetchJobE_4 + FetchJobE_5 + FetchJobE_6 + FetchJobE_7 + FetchJobE_8 + FetchJobE_9 + FetchJobE_10 + FetchJobE_11 + FetchJobE_12 + FetchJobE_13 + FetchJobE_14 + FetchJobE_15 + FetchJobE_16 + FetchJobE_17 + FetchJobE_18 + FetchJobE_19 + FetchJobE_20 + QueueJobB_0 + QueueJobB_1 + QueueJobB_2 + QueueJobB_3 + QueueJobB_4 + QueueJobB_5 + QueueJobB_6 + QueueJobB_7 + QueueJobB_8 + QueueJobB_9 + QueueJobB_10 + QueueJobB_11 + QueueJobB_12 + QueueJobB_13 + QueueJobB_14 + QueueJobB_15 + QueueJobB_16 + QueueJobB_17 + QueueJobB_18 + QueueJobB_19 + QueueJobB_20 + f3_0 + f3_1 + f3_2 + f3_3 + f3_4 + f3_5 + f3_6 + f3_7 + f3_8 + f3_9 + f3_10 + f3_11 + f3_12 + f3_13 + f3_14 + f3_15 + f3_16 + f3_17 + f3_18 + f3_19 + f3_20 + f2_0 + f2_1 + f2_2 + f2_3 + f2_4 + f2_5 + f2_6 + f2_7 + f2_8 + f2_9 + f2_10 + f2_11 + f2_12 + f2_13 + f2_14 + f2_15 + f2_16 + f2_17 + f2_18 + f2_19 + f2_20 + f1_0 + f1_1 + f1_2 + f1_3 + f1_4 + f1_5 + f1_6 + f1_7 + f1_8 + f1_9 + f1_10 + f1_11 + f1_12 + f1_13 + f1_14 + f1_15 + f1_16 + f1_17 + f1_18 + f1_19 + f1_20 + NotifyEventEndOfCheckSourcesE_0 + NotifyEventEndOfCheckSourcesB_0 + -1'CanInjectEvent_0 + Check_Sources_B_0 + place_782_0 + place_787_0 + Perform_Work_E_0 + Perform_Work_B_0 + Perform_Work_B_1 + Perform_Work_B_2 + Perform_Work_B_3 + Perform_Work_B_4 + Perform_Work_B_5 + Perform_Work_B_6 + Perform_Work_B_7 + Perform_Work_B_8 + Perform_Work_B_9 + Perform_Work_B_10 + Perform_Work_B_11 + Perform_Work_B_12 + Perform_Work_B_13 + Perform_Work_B_14 + Perform_Work_B_15 + Perform_Work_B_16 + Perform_Work_B_17 + Perform_Work_B_18 + Perform_Work_B_19 + Perform_Work_B_20 + Schedule_Task_E_0 + Schedule_Task_E_1 + Schedule_Task_E_2 + Schedule_Task_E_3 + Schedule_Task_E_4 + Schedule_Task_E_5 + Schedule_Task_E_6 + Schedule_Task_E_7 + Schedule_Task_E_8 + Schedule_Task_E_9 + Schedule_Task_E_10 + Schedule_Task_E_11 + Schedule_Task_E_12 + Schedule_Task_E_13 + Schedule_Task_E_14 + Schedule_Task_E_15 + Schedule_Task_E_16 + Schedule_Task_E_17 + Schedule_Task_E_18 + Schedule_Task_E_19 + Schedule_Task_E_20 + Schedule_Task_E_21 + Schedule_Task_E_22 + Schedule_Task_E_23 + Schedule_Task_E_24 + Schedule_Task_E_25 + Schedule_Task_E_26 + Schedule_Task_E_27 + Schedule_Task_E_28 + Schedule_Task_E_29 + Schedule_Task_E_30 + Schedule_Task_E_31 + Schedule_Task_E_32 + Schedule_Task_E_33 + Schedule_Task_E_34 + Schedule_Task_E_35 + Schedule_Task_E_36 + Schedule_Task_E_37 + Schedule_Task_E_38 + Schedule_Task_E_39 + Schedule_Task_E_40 + Schedule_Task_E_41 + Schedule_Task_B_0 + cJobCnt_0 + Try_Check_Sources_E_0 + Try_Check_Sources_B_0 = 10
invariant :f3_0 + f3_1 + f3_2 + f3_3 + f3_4 + f3_5 + f3_6 + f3_7 + f3_8 + f3_9 + f3_10 + f3_11 + f3_12 + f3_13 + f3_14 + f3_15 + f3_16 + f3_17 + f3_18 + f3_19 + f3_20 + mo1_0 + -1'f1_0 + -1'f1_1 + -1'f1_2 + -1'f1_3 + -1'f1_4 + -1'f1_5 + -1'f1_6 + -1'f1_7 + -1'f1_8 + -1'f1_9 + -1'f1_10 + -1'f1_11 + -1'f1_12 + -1'f1_13 + -1'f1_14 + -1'f1_15 + -1'f1_16 + -1'f1_17 + -1'f1_18 + -1'f1_19 + -1'f1_20 + -1'mi1_0 = 0
invariant :FetchJobE_7 + QueueJobB_7 + f3_7 + f2_7 + f1_7 + NotifyEventJobQueuedB_7 + AvailableJobId_7 + Perform_Work_B_7 + Schedule_Task_E_7 = 1
invariant :mi3_0 + mi2_0 + mi1_0 = 1
invariant :FetchJobE_18 + QueueJobB_18 + f3_18 + f2_18 + f1_18 + NotifyEventJobQueuedB_18 + AvailableJobId_18 + Perform_Work_B_18 + Schedule_Task_E_18 = 1
invariant :CreatedJobs_90 + CreatedJobs_91 + CreatedJobs_92 + CreatedJobs_93 + CreatedJobs_94 + AvailableJobId_18 = 1
invariant :FetchJobE_3 + QueueJobB_3 + f3_3 + f2_3 + f1_3 + NotifyEventJobQueuedB_3 + AvailableJobId_3 + Perform_Work_B_3 + Schedule_Task_E_3 = 1
invariant :FetchJobB_0 + -1'QueueJobB_0 + -1'QueueJobB_1 + -1'QueueJobB_2 + -1'QueueJobB_3 + -1'QueueJobB_4 + -1'QueueJobB_5 + -1'QueueJobB_6 + -1'QueueJobB_7 + -1'QueueJobB_8 + -1'QueueJobB_9 + -1'QueueJobB_10 + -1'QueueJobB_11 + -1'QueueJobB_12 + -1'QueueJobB_13 + -1'QueueJobB_14 + -1'QueueJobB_15 + -1'QueueJobB_16 + -1'QueueJobB_17 + -1'QueueJobB_18 + -1'QueueJobB_19 + -1'QueueJobB_20 + -1'f3_0 + -1'f3_1 + -1'f3_2 + -1'f3_3 + -1'f3_4 + -1'f3_5 + -1'f3_6 + -1'f3_7 + -1'f3_8 + -1'f3_9 + -1'f3_10 + -1'f3_11 + -1'f3_12 + -1'f3_13 + -1'f3_14 + -1'f3_15 + -1'f3_16 + -1'f3_17 + -1'f3_18 + -1'f3_19 + -1'f3_20 + -1'f2_0 + -1'f2_1 + -1'f2_2 + -1'f2_3 + -1'f2_4 + -1'f2_5 + -1'f2_6 + -1'f2_7 + -1'f2_8 + -1'f2_9 + -1'f2_10 + -1'f2_11 + -1'f2_12 + -1'f2_13 + -1'f2_14 + -1'f2_15 + -1'f2_16 + -1'f2_17 + -1'f2_18 + -1'f2_19 + -1'f2_20 + -1'f1_0 + -1'f1_1 + -1'f1_2 + -1'f1_3 + -1'f1_4 + -1'f1_5 + -1'f1_6 + -1'f1_7 + -1'f1_8 + -1'f1_9 + -1'f1_10 + -1'f1_11 + -1'f1_12 + -1'f1_13 + -1'f1_14 + -1'f1_15 + -1'f1_16 + -1'f1_17 + -1'f1_18 + -1'f1_19 + -1'f1_20 + -1'cJobCnt_0 = -10
invariant :CreatedJobs_100 + CreatedJobs_101 + CreatedJobs_102 + CreatedJobs_103 + CreatedJobs_104 + AvailableJobId_20 = 1
invariant :-1'f3_0 + -1'f3_1 + -1'f3_2 + -1'f3_3 + -1'f3_4 + -1'f3_5 + -1'f3_6 + -1'f3_7 + -1'f3_8 + -1'f3_9 + -1'f3_10 + -1'f3_11 + -1'f3_12 + -1'f3_13 + -1'f3_14 + -1'f3_15 + -1'f3_16 + -1'f3_17 + -1'f3_18 + -1'f3_19 + -1'f3_20 + mo3_0 + f2_0 + f2_1 + f2_2 + f2_3 + f2_4 + f2_5 + f2_6 + f2_7 + f2_8 + f2_9 + f2_10 + f2_11 + f2_12 + f2_13 + f2_14 + f2_15 + f2_16 + f2_17 + f2_18 + f2_19 + f2_20 + -1'mi3_0 = 0
invariant :FetchJobE_13 + QueueJobB_13 + f3_13 + f2_13 + f1_13 + NotifyEventJobQueuedB_13 + AvailableJobId_13 + Perform_Work_B_13 + Schedule_Task_E_13 = 1
invariant :FetchJobE_12 + QueueJobB_12 + f3_12 + f2_12 + f1_12 + NotifyEventJobQueuedB_12 + AvailableJobId_12 + Perform_Work_B_12 + Schedule_Task_E_12 = 1
invariant :JobCnt_0 + cJobCnt_0 = 10
invariant :ModifiedSrc_4 + CreatedJobs_4 + CreatedJobs_9 + CreatedJobs_14 + CreatedJobs_19 + CreatedJobs_24 + CreatedJobs_29 + CreatedJobs_34 + CreatedJobs_39 + CreatedJobs_44 + CreatedJobs_49 + CreatedJobs_54 + CreatedJobs_59 + CreatedJobs_64 + CreatedJobs_69 + CreatedJobs_74 + CreatedJobs_79 + CreatedJobs_84 + CreatedJobs_89 + CreatedJobs_94 + CreatedJobs_99 + CreatedJobs_104 + place_482_4 + TheSour_4 = 1
invariant :CreatedJobs_55 + CreatedJobs_56 + CreatedJobs_57 + CreatedJobs_58 + CreatedJobs_59 + AvailableJobId_11 = 1
invariant :CreatedJobs_65 + CreatedJobs_66 + CreatedJobs_67 + CreatedJobs_68 + CreatedJobs_69 + AvailableJobId_13 = 1
invariant :ModifiedSrc_3 + CreatedJobs_3 + CreatedJobs_8 + CreatedJobs_13 + CreatedJobs_18 + CreatedJobs_23 + CreatedJobs_28 + CreatedJobs_33 + CreatedJobs_38 + CreatedJobs_43 + CreatedJobs_48 + CreatedJobs_53 + CreatedJobs_58 + CreatedJobs_63 + CreatedJobs_68 + CreatedJobs_73 + CreatedJobs_78 + CreatedJobs_83 + CreatedJobs_88 + CreatedJobs_93 + CreatedJobs_98 + CreatedJobs_103 + place_482_3 + TheSour_3 = 1
invariant :CreatedJobs_30 + CreatedJobs_31 + CreatedJobs_32 + CreatedJobs_33 + CreatedJobs_34 + AvailableJobId_6 = 1
invariant :FetchJobE_0 + QueueJobB_0 + f3_0 + f2_0 + f1_0 + NotifyEventJobQueuedB_0 + AvailableJobId_0 + Perform_Work_B_0 + Schedule_Task_E_0 = 1
invariant :FetchJobE_16 + QueueJobB_16 + f3_16 + f2_16 + f1_16 + NotifyEventJobQueuedB_16 + AvailableJobId_16 + Perform_Work_B_16 + Schedule_Task_E_16 = 1
invariant :CreatedJobs_10 + CreatedJobs_11 + CreatedJobs_12 + CreatedJobs_13 + CreatedJobs_14 + AvailableJobId_2 = 1
invariant :CreatedJobs_60 + CreatedJobs_61 + CreatedJobs_62 + CreatedJobs_63 + CreatedJobs_64 + AvailableJobId_12 = 1
invariant :ModifiedSrc_1 + CreatedJobs_1 + CreatedJobs_6 + CreatedJobs_11 + CreatedJobs_16 + CreatedJobs_21 + CreatedJobs_26 + CreatedJobs_31 + CreatedJobs_36 + CreatedJobs_41 + CreatedJobs_46 + CreatedJobs_51 + CreatedJobs_56 + CreatedJobs_61 + CreatedJobs_66 + CreatedJobs_71 + CreatedJobs_76 + CreatedJobs_81 + CreatedJobs_86 + CreatedJobs_91 + CreatedJobs_96 + CreatedJobs_101 + place_482_1 + TheSour_1 = 1
invariant :CreatedJobs_70 + CreatedJobs_71 + CreatedJobs_72 + CreatedJobs_73 + CreatedJobs_74 + AvailableJobId_14 = 1
invariant :DataOnSrc_2 + -1'TheSour_2 = 0
invariant :FetchJobE_20 + QueueJobB_20 + f3_20 + f2_20 + f1_20 + NotifyEventJobQueuedB_20 + AvailableJobId_20 + Perform_Work_B_20 + Schedule_Task_E_20 = 1
invariant :CreatedJobs_15 + CreatedJobs_16 + CreatedJobs_17 + CreatedJobs_18 + CreatedJobs_19 + AvailableJobId_3 = 1
invariant :DataOnSrc_0 + -1'TheSour_0 = 0
invariant :FetchJobE_9 + QueueJobB_9 + f3_9 + f2_9 + f1_9 + NotifyEventJobQueuedB_9 + AvailableJobId_9 + Perform_Work_B_9 + Schedule_Task_E_9 = 1
invariant :FetchJobE_14 + QueueJobB_14 + f3_14 + f2_14 + f1_14 + NotifyEventJobQueuedB_14 + AvailableJobId_14 + Perform_Work_B_14 + Schedule_Task_E_14 = 1
invariant :CreatedJobs_0 + CreatedJobs_1 + CreatedJobs_2 + CreatedJobs_3 + CreatedJobs_4 + AvailableJobId_0 = 1
invariant :DataOnSrc_3 + -1'TheSour_3 = 0
invariant :CreatedJobs_95 + CreatedJobs_96 + CreatedJobs_97 + CreatedJobs_98 + CreatedJobs_99 + AvailableJobId_19 = 1
invariant :FetchJobE_1 + QueueJobB_1 + f3_1 + f2_1 + f1_1 + NotifyEventJobQueuedB_1 + AvailableJobId_1 + Perform_Work_B_1 + Schedule_Task_E_1 = 1
invariant :DataOnSrc_4 + -1'TheSour_4 = 0
invariant :CreatedJobs_50 + CreatedJobs_51 + CreatedJobs_52 + CreatedJobs_53 + CreatedJobs_54 + AvailableJobId_10 = 1
invariant :FetchJobE_17 + QueueJobB_17 + f3_17 + f2_17 + f1_17 + NotifyEventJobQueuedB_17 + AvailableJobId_17 + Perform_Work_B_17 + Schedule_Task_E_17 = 1
invariant :CreatedJobs_80 + CreatedJobs_81 + CreatedJobs_82 + CreatedJobs_83 + CreatedJobs_84 + AvailableJobId_16 = 1
invariant :3'place_523_0 + 4'place_522_0 + 6'place_521_0 + 12'place_520_0 + 12'place_518_0 + 12'place_500_0 + 3'place_462_0 + 4'place_460_0 + 6'place_458_0 + 12'place_456_0 + 12'Check_Sources_E_0 + 12'CanInjectEvent_0 = 12
invariant :mo2_0 + -1'f2_0 + -1'f2_1 + -1'f2_2 + -1'f2_3 + -1'f2_4 + -1'f2_5 + -1'f2_6 + -1'f2_7 + -1'f2_8 + -1'f2_9 + -1'f2_10 + -1'f2_11 + -1'f2_12 + -1'f2_13 + -1'f2_14 + -1'f2_15 + -1'f2_16 + -1'f2_17 + -1'f2_18 + -1'f2_19 + -1'f2_20 + f1_0 + f1_1 + f1_2 + f1_3 + f1_4 + f1_5 + f1_6 + f1_7 + f1_8 + f1_9 + f1_10 + f1_11 + f1_12 + f1_13 + f1_14 + f1_15 + f1_16 + f1_17 + f1_18 + f1_19 + f1_20 + mi3_0 + mi1_0 = 1
invariant :CreatedJobs_5 + CreatedJobs_6 + CreatedJobs_7 + CreatedJobs_8 + CreatedJobs_9 + AvailableJobId_1 = 1
invariant :FetchJobE_6 + QueueJobB_6 + f3_6 + f2_6 + f1_6 + NotifyEventJobQueuedB_6 + AvailableJobId_6 + Perform_Work_B_6 + Schedule_Task_E_6 = 1
invariant :CreatedJobs_35 + CreatedJobs_36 + CreatedJobs_37 + CreatedJobs_38 + CreatedJobs_39 + AvailableJobId_7 = 1
invariant :-1'FetchJobE_0 + -1'FetchJobE_1 + -1'FetchJobE_2 + -1'FetchJobE_3 + -1'FetchJobE_4 + -1'FetchJobE_5 + -1'FetchJobE_6 + -1'FetchJobE_7 + -1'FetchJobE_8 + -1'FetchJobE_9 + -1'FetchJobE_10 + -1'FetchJobE_11 + -1'FetchJobE_12 + -1'FetchJobE_13 + -1'FetchJobE_14 + -1'FetchJobE_15 + -1'FetchJobE_16 + -1'FetchJobE_17 + -1'FetchJobE_18 + -1'FetchJobE_19 + -1'FetchJobE_20 + QueueJobE_0 + -1'f3_0 + -1'f3_1 + -1'f3_2 + -1'f3_3 + -1'f3_4 + -1'f3_5 + -1'f3_6 + -1'f3_7 + -1'f3_8 + -1'f3_9 + -1'f3_10 + -1'f3_11 + -1'f3_12 + -1'f3_13 + -1'f3_14 + -1'f3_15 + -1'f3_16 + -1'f3_17 + -1'f3_18 + -1'f3_19 + -1'f3_20 + -1'f2_0 + -1'f2_1 + -1'f2_2 + -1'f2_3 + -1'f2_4 + -1'f2_5 + -1'f2_6 + -1'f2_7 + -1'f2_8 + -1'f2_9 + -1'f2_10 + -1'f2_11 + -1'f2_12 + -1'f2_13 + -1'f2_14 + -1'f2_15 + -1'f2_16 + -1'f2_17 + -1'f2_18 + -1'f2_19 + -1'f2_20 + -1'f1_0 + -1'f1_1 + -1'f1_2 + -1'f1_3 + -1'f1_4 + -1'f1_5 + -1'f1_6 + -1'f1_7 + -1'f1_8 + -1'f1_9 + -1'f1_10 + -1'f1_11 + -1'f1_12 + -1'f1_13 + -1'f1_14 + -1'f1_15 + -1'f1_16 + -1'f1_17 + -1'f1_18 + -1'f1_19 + -1'f1_20 + NotifyEventJobQueuedE_0 + place_482_0 + place_482_1 + place_482_2 + place_482_3 + place_482_4 + -1'place_462_0 + -1'place_460_0 + -1'place_458_0 + -1'place_456_0 + -1'AvailableJobId_0 + -1'AvailableJobId_1 + -1'AvailableJobId_2 + -1'AvailableJobId_3 + -1'AvailableJobId_4 + -1'AvailableJobId_5 + -1'AvailableJobId_6 + -1'AvailableJobId_7 + -1'AvailableJobId_8 + -1'AvailableJobId_9 + -1'AvailableJobId_10 + -1'AvailableJobId_11 + -1'AvailableJobId_12 + -1'AvailableJobId_13 + -1'AvailableJobId_14 + -1'AvailableJobId_15 + -1'AvailableJobId_16 + -1'AvailableJobId_17 + -1'AvailableJobId_18 + -1'AvailableJobId_19 + -1'AvailableJobId_20 + -1'Perform_Work_B_0 + -1'Perform_Work_B_1 + -1'Perform_Work_B_2 + -1'Perform_Work_B_3 + -1'Perform_Work_B_4 + -1'Perform_Work_B_5 + -1'Perform_Work_B_6 + -1'Perform_Work_B_7 + -1'Perform_Work_B_8 + -1'Perform_Work_B_9 + -1'Perform_Work_B_10 + -1'Perform_Work_B_11 + -1'Perform_Work_B_12 + -1'Perform_Work_B_13 + -1'Perform_Work_B_14 + -1'Perform_Work_B_15 + -1'Perform_Work_B_16 + -1'Perform_Work_B_17 + -1'Perform_Work_B_18 + -1'Perform_Work_B_19 + -1'Perform_Work_B_20 + -1'Schedule_Task_E_0 + -1'Schedule_Task_E_1 + -1'Schedule_Task_E_2 + -1'Schedule_Task_E_3 + -1'Schedule_Task_E_4 + -1'Schedule_Task_E_5 + -1'Schedule_Task_E_6 + -1'Schedule_Task_E_7 + -1'Schedule_Task_E_8 + -1'Schedule_Task_E_9 + -1'Schedule_Task_E_10 + -1'Schedule_Task_E_11 + -1'Schedule_Task_E_12 + -1'Schedule_Task_E_13 + -1'Schedule_Task_E_14 + -1'Schedule_Task_E_15 + -1'Schedule_Task_E_16 + -1'Schedule_Task_E_17 + -1'Schedule_Task_E_18 + -1'Schedule_Task_E_19 + -1'Schedule_Task_E_20 = -21
invariant :DataOnSrc_1 + -1'TheSour_1 = 0
invariant :CreatedJobs_40 + CreatedJobs_41 + CreatedJobs_42 + CreatedJobs_43 + CreatedJobs_44 + AvailableJobId_8 = 1
invariant :FetchJobE_10 + QueueJobB_10 + f3_10 + f2_10 + f1_10 + NotifyEventJobQueuedB_10 + AvailableJobId_10 + Perform_Work_B_10 + Schedule_Task_E_10 = 1
invariant :CreatedJobs_20 + CreatedJobs_21 + CreatedJobs_22 + CreatedJobs_23 + CreatedJobs_24 + AvailableJobId_4 = 1
invariant :FetchJobE_8 + QueueJobB_8 + f3_8 + f2_8 + f1_8 + NotifyEventJobQueuedB_8 + AvailableJobId_8 + Perform_Work_B_8 + Schedule_Task_E_8 = 1
invariant :CreatedJobs_25 + CreatedJobs_26 + CreatedJobs_27 + CreatedJobs_28 + CreatedJobs_29 + AvailableJobId_5 = 1
invariant :FetchJobE_11 + QueueJobB_11 + f3_11 + f2_11 + f1_11 + NotifyEventJobQueuedB_11 + AvailableJobId_11 + Perform_Work_B_11 + Schedule_Task_E_11 = 1
invariant :FetchJobE_5 + QueueJobB_5 + f3_5 + f2_5 + f1_5 + NotifyEventJobQueuedB_5 + AvailableJobId_5 + Perform_Work_B_5 + Schedule_Task_E_5 = 1
invariant :FetchJobE_19 + QueueJobB_19 + f3_19 + f2_19 + f1_19 + NotifyEventJobQueuedB_19 + AvailableJobId_19 + Perform_Work_B_19 + Schedule_Task_E_19 = 1
invariant :ModifiedSrc_2 + CreatedJobs_2 + CreatedJobs_7 + CreatedJobs_12 + CreatedJobs_17 + CreatedJobs_22 + CreatedJobs_27 + CreatedJobs_32 + CreatedJobs_37 + CreatedJobs_42 + CreatedJobs_47 + CreatedJobs_52 + CreatedJobs_57 + CreatedJobs_62 + CreatedJobs_67 + CreatedJobs_72 + CreatedJobs_77 + CreatedJobs_82 + CreatedJobs_87 + CreatedJobs_92 + CreatedJobs_97 + CreatedJobs_102 + place_482_2 + TheSour_2 = 1
invariant :FetchJobE_15 + QueueJobB_15 + f3_15 + f2_15 + f1_15 + NotifyEventJobQueuedB_15 + AvailableJobId_15 + Perform_Work_B_15 + Schedule_Task_E_15 = 1
invariant :FetchJobE_4 + QueueJobB_4 + f3_4 + f2_4 + f1_4 + NotifyEventJobQueuedB_4 + AvailableJobId_4 + Perform_Work_B_4 + Schedule_Task_E_4 = 1
invariant :FetchJobE_0 + FetchJobE_1 + FetchJobE_2 + FetchJobE_3 + FetchJobE_4 + FetchJobE_5 + FetchJobE_6 + FetchJobE_7 + FetchJobE_8 + FetchJobE_9 + FetchJobE_10 + FetchJobE_11 + FetchJobE_12 + FetchJobE_13 + FetchJobE_14 + FetchJobE_15 + FetchJobE_16 + FetchJobE_17 + FetchJobE_18 + FetchJobE_19 + FetchJobE_20 + -1'QueueJobE_0 + f3_0 + f3_1 + f3_2 + f3_3 + f3_4 + f3_5 + f3_6 + f3_7 + f3_8 + f3_9 + f3_10 + f3_11 + f3_12 + f3_13 + f3_14 + f3_15 + f3_16 + f3_17 + f3_18 + f3_19 + f3_20 + f2_0 + f2_1 + f2_2 + f2_3 + f2_4 + f2_5 + f2_6 + f2_7 + f2_8 + f2_9 + f2_10 + f2_11 + f2_12 + f2_13 + f2_14 + f2_15 + f2_16 + f2_17 + f2_18 + f2_19 + f2_20 + f1_0 + f1_1 + f1_2 + f1_3 + f1_4 + f1_5 + f1_6 + f1_7 + f1_8 + f1_9 + f1_10 + f1_11 + f1_12 + f1_13 + f1_14 + f1_15 + f1_16 + f1_17 + f1_18 + f1_19 + f1_20 + -1'NotifyEventJobQueuedE_0 + ModifiedSrc_0 + -1'CreatedJobs_1 + -1'CreatedJobs_2 + -1'CreatedJobs_3 + -1'CreatedJobs_4 + -1'CreatedJobs_6 + -1'CreatedJobs_7 + -1'CreatedJobs_8 + -1'CreatedJobs_9 + -1'CreatedJobs_11 + -1'CreatedJobs_12 + -1'CreatedJobs_13 + -1'CreatedJobs_14 + -1'CreatedJobs_16 + -1'CreatedJobs_17 + -1'CreatedJobs_18 + -1'CreatedJobs_19 + -1'CreatedJobs_21 + -1'CreatedJobs_22 + -1'CreatedJobs_23 + -1'CreatedJobs_24 + -1'CreatedJobs_26 + -1'CreatedJobs_27 + -1'CreatedJobs_28 + -1'CreatedJobs_29 + -1'CreatedJobs_31 + -1'CreatedJobs_32 + -1'CreatedJobs_33 + -1'CreatedJobs_34 + -1'CreatedJobs_36 + -1'CreatedJobs_37 + -1'CreatedJobs_38 + -1'CreatedJobs_39 + -1'CreatedJobs_41 + -1'CreatedJobs_42 + -1'CreatedJobs_43 + -1'CreatedJobs_44 + -1'CreatedJobs_46 + -1'CreatedJobs_47 + -1'CreatedJobs_48 + -1'CreatedJobs_49 + -1'CreatedJobs_51 + -1'CreatedJobs_52 + -1'CreatedJobs_53 + -1'CreatedJobs_54 + -1'CreatedJobs_56 + -1'CreatedJobs_57 + -1'CreatedJobs_58 + -1'CreatedJobs_59 + -1'CreatedJobs_61 + -1'CreatedJobs_62 + -1'CreatedJobs_63 + -1'CreatedJobs_64 + -1'CreatedJobs_66 + -1'CreatedJobs_67 + -1'CreatedJobs_68 + -1'CreatedJobs_69 + -1'CreatedJobs_71 + -1'CreatedJobs_72 + -1'CreatedJobs_73 + -1'CreatedJobs_74 + -1'CreatedJobs_76 + -1'CreatedJobs_77 + -1'CreatedJobs_78 + -1'CreatedJobs_79 + -1'CreatedJobs_81 + -1'CreatedJobs_82 + -1'CreatedJobs_83 + -1'CreatedJobs_84 + -1'CreatedJobs_86 + -1'CreatedJobs_87 + -1'CreatedJobs_88 + -1'CreatedJobs_89 + -1'CreatedJobs_91 + -1'CreatedJobs_92 + -1'CreatedJobs_93 + -1'CreatedJobs_94 + -1'CreatedJobs_96 + -1'CreatedJobs_97 + -1'CreatedJobs_98 + -1'CreatedJobs_99 + -1'CreatedJobs_101 + -1'CreatedJobs_102 + -1'CreatedJobs_103 + -1'CreatedJobs_104 + -1'place_482_1 + -1'place_482_2 + -1'place_482_3 + -1'place_482_4 + place_462_0 + place_460_0 + place_458_0 + place_456_0 + TheSour_0 + Perform_Work_B_0 + Perform_Work_B_1 + Perform_Work_B_2 + Perform_Work_B_3 + Perform_Work_B_4 + Perform_Work_B_5 + Perform_Work_B_6 + Perform_Work_B_7 + Perform_Work_B_8 + Perform_Work_B_9 + Perform_Work_B_10 + Perform_Work_B_11 + Perform_Work_B_12 + Perform_Work_B_13 + Perform_Work_B_14 + Perform_Work_B_15 + Perform_Work_B_16 + Perform_Work_B_17 + Perform_Work_B_18 + Perform_Work_B_19 + Perform_Work_B_20 + Schedule_Task_E_0 + Schedule_Task_E_1 + Schedule_Task_E_2 + Schedule_Task_E_3 + Schedule_Task_E_4 + Schedule_Task_E_5 + Schedule_Task_E_6 + Schedule_Task_E_7 + Schedule_Task_E_8 + Schedule_Task_E_9 + Schedule_Task_E_10 + Schedule_Task_E_11 + Schedule_Task_E_12 + Schedule_Task_E_13 + Schedule_Task_E_14 + Schedule_Task_E_15 + Schedule_Task_E_16 + Schedule_Task_E_17 + Schedule_Task_E_18 + Schedule_Task_E_19 + Schedule_Task_E_20 = 1
invariant :CreatedJobs_85 + CreatedJobs_86 + CreatedJobs_87 + CreatedJobs_88 + CreatedJobs_89 + AvailableJobId_17 = 1
invariant :FetchJobE_2 + QueueJobB_2 + f3_2 + f2_2 + f1_2 + NotifyEventJobQueuedB_2 + AvailableJobId_2 + Perform_Work_B_2 + Schedule_Task_E_2 = 1
Running compilation step : CommandLine [args=[gcc, -c, -I/home/mcc/BenchKit//lts_install_dir//include, -I., -std=c99, -fPIC, -O3, model.c], workingDir=/home/mcc/execution]
Compilation finished in 12700 ms.
Running link step : CommandLine [args=[gcc, -shared, -o, gal.so, model.o], workingDir=/home/mcc/execution]
Link finished in 64 ms.
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=1, -p, --pins-guards, --when, --ltl, (LTLAP0==true), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 1043 ms.
FORMULA PolyORBNT-COL-S05J20-LTLCardinality-00 FALSE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=1, -p, --pins-guards, --when, --ltl, []((<>((LTLAP1==true)))U(<>((LTLAP2==true)))), --buchi-type=spotba], workingDir=/home/mcc/execution]
sparsehash FATAL ERROR: failed to allocate 38 groups
WARNING : LTSmin timed out (>225 s) on command CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=1, -p, --pins-guards, --when, --ltl, []((<>((LTLAP1==true)))U(<>((LTLAP2==true)))), --buchi-type=spotba], workingDir=/home/mcc/execution]
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=1, -p, --pins-guards, --when, --ltl, []((LTLAP3==true)), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 921 ms.
FORMULA PolyORBNT-COL-S05J20-LTLCardinality-02 FALSE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=1, --when, --ltl, <>(<>([](X((LTLAP4==true))))), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 35 ms.
FORMULA PolyORBNT-COL-S05J20-LTLCardinality-03 FALSE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=1, --when, --ltl, (X(X((LTLAP5==true))))U(X([]((LTLAP6==true)))), --buchi-type=spotba], workingDir=/home/mcc/execution]
WARNING : LTSmin timed out (>225 s) on command CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=1, --when, --ltl, (X(X((LTLAP5==true))))U(X([]((LTLAP6==true)))), --buchi-type=spotba], workingDir=/home/mcc/execution]
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=1, -p, --pins-guards, --when, --ltl, <>(<>(((LTLAP7==true))U((LTLAP8==true)))), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 972 ms.
FORMULA PolyORBNT-COL-S05J20-LTLCardinality-05 FALSE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=1, --when, --ltl, (X((LTLAP9==true)))U([]([]((LTLAP10==true)))), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 37 ms.
FORMULA PolyORBNT-COL-S05J20-LTLCardinality-06 FALSE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=1, --when, --ltl, X([]((LTLAP11==true))), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 34 ms.
FORMULA PolyORBNT-COL-S05J20-LTLCardinality-07 FALSE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=1, --when, --ltl, ([](X((LTLAP12==true))))U(X(<>((LTLAP13==true)))), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 32 ms.
FORMULA PolyORBNT-COL-S05J20-LTLCardinality-08 TRUE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=1, -p, --pins-guards, --when, --ltl, <>(([]((LTLAP14==true)))U((LTLAP15==true))), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 876 ms.
FORMULA PolyORBNT-COL-S05J20-LTLCardinality-09 FALSE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=1, -p, --pins-guards, --when, --ltl, <>((<>((LTLAP16==true)))U(<>((LTLAP17==true)))), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 676 ms.
FORMULA PolyORBNT-COL-S05J20-LTLCardinality-10 FALSE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=1, -p, --pins-guards, --when, --ltl, <>((LTLAP18==true)), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 897 ms.
FORMULA PolyORBNT-COL-S05J20-LTLCardinality-11 TRUE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=1, -p, --pins-guards, --when, --ltl, ([]([]((LTLAP19==true))))U(((LTLAP20==true))U((LTLAP21==true))), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 662 ms.
FORMULA PolyORBNT-COL-S05J20-LTLCardinality-12 FALSE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=1, -p, --pins-guards, --when, --ltl, []((LTLAP22==true)), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 873 ms.
FORMULA PolyORBNT-COL-S05J20-LTLCardinality-13 FALSE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=1, --when, --ltl, <>(<>(X(X((LTLAP23==true))))), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 35 ms.
FORMULA PolyORBNT-COL-S05J20-LTLCardinality-14 TRUE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=1, --when, --ltl, X([]((LTLAP24==true))), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 43 ms.
FORMULA PolyORBNT-COL-S05J20-LTLCardinality-15 FALSE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Retrying LTSmin with larger timeout 1800 s
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=1, -p, --pins-guards, --when, --ltl, []((<>((LTLAP1==true)))U(<>((LTLAP2==true)))), --buchi-type=spotba], workingDir=/home/mcc/execution]
WARNING : LTSmin timed out (>1800 s) on command CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=1, -p, --pins-guards, --when, --ltl, []((<>((LTLAP1==true)))U(<>((LTLAP2==true)))), --buchi-type=spotba], workingDir=/home/mcc/execution]
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=1, --when, --ltl, (X(X((LTLAP5==true))))U(X([]((LTLAP6==true)))), --buchi-type=spotba], workingDir=/home/mcc/execution]

BK_TIME_CONFINEMENT_REACHED

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

+ export BINDIR=/home/mcc/BenchKit/
+ BINDIR=/home/mcc/BenchKit/
++ pwd
+ export MODEL=/home/mcc/execution
+ MODEL=/home/mcc/execution
+ /home/mcc/BenchKit//runeclipse.sh /home/mcc/execution LTLCardinality -its -ltsminpath /home/mcc/BenchKit//lts_install_dir/ -smt
+ ulimit -s 65536
+ [[ -z '' ]]
+ export LTSMIN_MEM_SIZE=8589934592
+ LTSMIN_MEM_SIZE=8589934592
+ /home/mcc/BenchKit//itstools/its-tools -consoleLog -data /home/mcc/execution/workspace -pnfolder /home/mcc/execution -examination LTLCardinality -z3path /home/mcc/BenchKit//z3/bin/z3 -yices2path /home/mcc/BenchKit//yices/bin/yices -its -ltsminpath /home/mcc/BenchKit//lts_install_dir/ -smt -vmargs -Dosgi.locking=none -Declipse.stateSaveDelayInterval=-1 -Dosgi.configuration.area=/tmp/.eclipse -Xss8m -Xms40m -Xmx8192m -Dfile.encoding=UTF-8 -Dosgi.requiredJavaVersion=1.6
May 31, 2018 8:03:44 PM fr.lip6.move.gal.application.Application start
INFO: Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, LTLCardinality, -z3path, /home/mcc/BenchKit//z3/bin/z3, -yices2path, /home/mcc/BenchKit//yices/bin/yices, -its, -ltsminpath, /home/mcc/BenchKit//lts_install_dir/, -smt]
May 31, 2018 8:03:44 PM fr.lip6.move.gal.application.MccTranslator transformPNML
INFO: Parsing pnml file : /home/mcc/execution/model.pnml
May 31, 2018 8:03:44 PM fr.lip6.move.gal.pnml.togal.PnmlToGalTransformer transform
INFO: Detected file is not PT type :http://www.pnml.org/version-2009/grammar/symmetricnet
May 31, 2018 8:03:45 PM fr.lip6.move.gal.pnml.togal.PnmlToGalTransformer transform
INFO: Load time of PNML (colored model parsed with PNMLFW) : 1351 ms
May 31, 2018 8:03:45 PM fr.lip6.move.gal.pnml.togal.HLGALTransformer handlePage
INFO: Transformed 48 places.
May 31, 2018 8:03:45 PM fr.lip6.move.gal.pnml.togal.HLGALTransformer handlePage
INFO: Computed order using colors.
May 31, 2018 8:03:45 PM fr.lip6.move.gal.pnml.togal.HLGALTransformer handlePage
INFO: sort/places :Threads->FetchJobB,QueueJobE,NotifyEventJobQueuedE,NotifyEventEndOfCheckSourcesE,NotifyEventEndOfCheckSourcesB,place_523,place_522,place_521,place_520,place_518,place_500,Check_Sources_E,Check_Sources_B,place_782,place_787,Perform_Work_E,Schedule_Task_B,Try_Check_Sources_E,Try_Check_Sources_B,
D4->place_482,
D5->Schedule_Task_E,
D6->CreatedJobs,
Jobs->f3,f2,f1,AvailableJobId,
Dot->block,mo3,mo2,mo1,mi3,mi2,mi1,cSources,place_462,place_460,place_458,place_456,CanInjectEvent,JobCnt,cJobCnt,
D1->FetchJobE,QueueJobB,NotifyEventJobQueuedB,Perform_Work_B,
Sources->ModifiedSrc,DataOnSrc,TheSour,

May 31, 2018 8:03:45 PM fr.lip6.move.gal.pnml.togal.HLGALTransformer detectBindingSymmetry
INFO: ms3 symmetric to ms2 in transition trans_489
May 31, 2018 8:03:45 PM fr.lip6.move.gal.pnml.togal.HLGALTransformer detectBindingSymmetry
INFO: ms2 symmetric to ms4 in transition trans_489
May 31, 2018 8:03:45 PM fr.lip6.move.gal.pnml.togal.HLGALTransformer detectBindingSymmetry
INFO: ms4 symmetric to ms1 in transition trans_489
May 31, 2018 8:03:45 PM fr.lip6.move.gal.pnml.togal.HLGALTransformer detectBindingSymmetry
INFO: ms3 symmetric to ms2 in transition trans_488
May 31, 2018 8:03:45 PM fr.lip6.move.gal.pnml.togal.HLGALTransformer detectBindingSymmetry
INFO: ms2 symmetric to ms1 in transition trans_488
May 31, 2018 8:03:45 PM fr.lip6.move.gal.pnml.togal.HLGALTransformer detectBindingSymmetry
INFO: ms2 symmetric to ms1 in transition trans_487
May 31, 2018 8:03:45 PM fr.lip6.move.gal.pnml.togal.HLGALTransformer handlePage
INFO: Transformed 38 transitions.
May 31, 2018 8:03:45 PM fr.lip6.move.gal.pnml.togal.PnmlToGalTransformer transform
INFO: Computed order based on color domains.
May 31, 2018 8:03:45 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/model.pnml.img.gal : 23 ms
May 31, 2018 8:03:46 PM fr.lip6.move.gal.instantiate.Instantiator instantiateParameters
INFO: On-the-fly reduction of False transitions avoided exploring 697.0 instantiations of transitions. Total transitions/syncs built is 751
May 31, 2018 8:03:46 PM fr.lip6.move.gal.instantiate.Instantiator fuseIsomorphicEffects
INFO: Removed a total of 63 redundant transitions.
May 31, 2018 8:03:46 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 614 ms
May 31, 2018 8:03:49 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/LTLCardinality.pnml.gal : 31 ms
May 31, 2018 8:03:49 PM fr.lip6.move.serialization.SerializationUtil serializePropertiesForITSLTLTools
INFO: Time to serialize properties into /home/mcc/execution/LTLCardinality.ltl : 2 ms
May 31, 2018 8:03:50 PM fr.lip6.move.gal.semantics.DeterministicNextBuilder getDeterministicNext
INFO: Input system was not deterministic with 319 transitions. Expanding to a total of 607 deterministic transitions.
May 31, 2018 8:03:50 PM fr.lip6.move.gal.semantics.DeterministicNextBuilder getDeterministicNext
INFO: Determinization took 15 ms.
May 31, 2018 8:03:51 PM fr.lip6.move.gal.gal2smt.bmc.KInductionSolver computeAndDeclareInvariants
INFO: Computed 62 place invariants in 267 ms
May 31, 2018 8:03:52 PM fr.lip6.move.gal.gal2smt.bmc.KInductionSolver init
INFO: Proved 369 variables to be positive in 1718 ms
May 31, 2018 8:03:52 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeAblingMatrix
INFO: Computing symmetric may disable matrix : 575 transitions.
May 31, 2018 8:03:52 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of disable matrix completed :0/575 took 1 ms. Total solver calls (SAT/UNSAT): 0(0/0)
May 31, 2018 8:03:52 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of Complete disable matrix. took 85 ms. Total solver calls (SAT/UNSAT): 0(0/0)
May 31, 2018 8:03:52 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeAblingMatrix
INFO: Computing symmetric may enable matrix : 575 transitions.
May 31, 2018 8:03:52 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of Complete enable matrix. took 27 ms. Total solver calls (SAT/UNSAT): 0(0/0)
May 31, 2018 8:04:00 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeCoEnablingMatrix
INFO: Computing symmetric co enabling matrix : 575 transitions.
May 31, 2018 8:04:01 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(0/575) took 1634 ms. Total solver calls (SAT/UNSAT): 338(280/58)
May 31, 2018 8:04:05 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(2/575) took 4845 ms. Total solver calls (SAT/UNSAT): 1011(837/174)
May 31, 2018 8:04:08 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(4/575) took 8059 ms. Total solver calls (SAT/UNSAT): 1680(1390/290)
May 31, 2018 8:04:11 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(6/575) took 11300 ms. Total solver calls (SAT/UNSAT): 2345(1939/406)
May 31, 2018 8:04:14 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(8/575) took 14445 ms. Total solver calls (SAT/UNSAT): 3006(2484/522)
May 31, 2018 8:04:17 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(10/575) took 17541 ms. Total solver calls (SAT/UNSAT): 3663(3025/638)
May 31, 2018 8:04:20 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(12/575) took 20673 ms. Total solver calls (SAT/UNSAT): 4316(3562/754)
May 31, 2018 8:04:24 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(14/575) took 24000 ms. Total solver calls (SAT/UNSAT): 4965(4095/870)
May 31, 2018 8:04:27 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(16/575) took 27060 ms. Total solver calls (SAT/UNSAT): 5610(4624/986)
May 31, 2018 8:04:30 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(18/575) took 30062 ms. Total solver calls (SAT/UNSAT): 6251(5149/1102)
May 31, 2018 8:04:37 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(21/575) took 36966 ms. Total solver calls (SAT/UNSAT): 7366(6131/1235)
May 31, 2018 8:04:41 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(22/575) took 40869 ms. Total solver calls (SAT/UNSAT): 7843(6591/1252)
May 31, 2018 8:04:45 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(23/575) took 44784 ms. Total solver calls (SAT/UNSAT): 8319(7050/1269)
May 31, 2018 8:04:49 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(24/575) took 48697 ms. Total solver calls (SAT/UNSAT): 8794(7508/1286)
May 31, 2018 8:04:52 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(25/575) took 52519 ms. Total solver calls (SAT/UNSAT): 9268(7965/1303)
May 31, 2018 8:04:56 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(26/575) took 56256 ms. Total solver calls (SAT/UNSAT): 9741(8421/1320)
May 31, 2018 8:05:00 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(27/575) took 60110 ms. Total solver calls (SAT/UNSAT): 10213(8876/1337)
May 31, 2018 8:05:04 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(28/575) took 63898 ms. Total solver calls (SAT/UNSAT): 10684(9330/1354)
May 31, 2018 8:05:07 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(29/575) took 67655 ms. Total solver calls (SAT/UNSAT): 11154(9783/1371)
May 31, 2018 8:05:11 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(30/575) took 71524 ms. Total solver calls (SAT/UNSAT): 11623(10235/1388)
May 31, 2018 8:05:15 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(31/575) took 75166 ms. Total solver calls (SAT/UNSAT): 12091(10686/1405)
May 31, 2018 8:05:19 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(32/575) took 79171 ms. Total solver calls (SAT/UNSAT): 12558(11136/1422)
May 31, 2018 8:05:23 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(33/575) took 83591 ms. Total solver calls (SAT/UNSAT): 13024(11585/1439)
May 31, 2018 8:05:27 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(34/575) took 87480 ms. Total solver calls (SAT/UNSAT): 13489(12033/1456)
May 31, 2018 8:05:32 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(35/575) took 92270 ms. Total solver calls (SAT/UNSAT): 13953(12480/1473)
May 31, 2018 8:05:36 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(36/575) took 96094 ms. Total solver calls (SAT/UNSAT): 14416(12926/1490)
May 31, 2018 8:05:40 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(37/575) took 100242 ms. Total solver calls (SAT/UNSAT): 14878(13371/1507)
May 31, 2018 8:05:44 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(38/575) took 103850 ms. Total solver calls (SAT/UNSAT): 15339(13815/1524)
May 31, 2018 8:05:48 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(39/575) took 108423 ms. Total solver calls (SAT/UNSAT): 15799(14258/1541)
May 31, 2018 8:05:53 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(40/575) took 113088 ms. Total solver calls (SAT/UNSAT): 16258(14700/1558)
May 31, 2018 8:05:57 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(41/575) took 116863 ms. Total solver calls (SAT/UNSAT): 16716(15141/1575)
May 31, 2018 8:06:02 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(42/575) took 122189 ms. Total solver calls (SAT/UNSAT): 17173(15582/1591)
May 31, 2018 8:06:07 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(43/575) took 127606 ms. Total solver calls (SAT/UNSAT): 17629(16022/1607)
May 31, 2018 8:06:12 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(44/575) took 132015 ms. Total solver calls (SAT/UNSAT): 18084(16461/1623)
May 31, 2018 8:06:17 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(45/575) took 137500 ms. Total solver calls (SAT/UNSAT): 18538(16899/1639)
May 31, 2018 8:06:22 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(46/575) took 141813 ms. Total solver calls (SAT/UNSAT): 18991(17336/1655)
May 31, 2018 8:06:26 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(47/575) took 146135 ms. Total solver calls (SAT/UNSAT): 19443(17772/1671)
May 31, 2018 8:06:31 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(48/575) took 151239 ms. Total solver calls (SAT/UNSAT): 19894(18207/1687)
May 31, 2018 8:06:36 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(49/575) took 156361 ms. Total solver calls (SAT/UNSAT): 20344(18641/1703)
May 31, 2018 8:06:41 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(50/575) took 161312 ms. Total solver calls (SAT/UNSAT): 20793(19074/1719)
May 31, 2018 8:06:47 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(51/575) took 166768 ms. Total solver calls (SAT/UNSAT): 21241(19506/1735)
May 31, 2018 8:06:52 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(52/575) took 171961 ms. Total solver calls (SAT/UNSAT): 21688(19937/1751)
May 31, 2018 8:06:56 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(53/575) took 176366 ms. Total solver calls (SAT/UNSAT): 22134(20367/1767)
May 31, 2018 8:07:01 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(54/575) took 181450 ms. Total solver calls (SAT/UNSAT): 22579(20796/1783)
May 31, 2018 8:07:07 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(55/575) took 186823 ms. Total solver calls (SAT/UNSAT): 23023(21224/1799)
May 31, 2018 8:07:12 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(56/575) took 192042 ms. Total solver calls (SAT/UNSAT): 23466(21651/1815)
May 31, 2018 8:07:16 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(57/575) took 196180 ms. Total solver calls (SAT/UNSAT): 23908(22077/1831)
May 31, 2018 8:07:21 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(58/575) took 201336 ms. Total solver calls (SAT/UNSAT): 24349(22502/1847)
May 31, 2018 8:07:26 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(59/575) took 205836 ms. Total solver calls (SAT/UNSAT): 24789(22926/1863)
May 31, 2018 8:07:31 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(60/575) took 210737 ms. Total solver calls (SAT/UNSAT): 25228(23349/1879)
May 31, 2018 8:07:34 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(61/575) took 214577 ms. Total solver calls (SAT/UNSAT): 25666(23771/1895)
May 31, 2018 8:07:39 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(62/575) took 219677 ms. Total solver calls (SAT/UNSAT): 26103(24192/1911)
May 31, 2018 8:07:44 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(63/575) took 224220 ms. Total solver calls (SAT/UNSAT): 26539(24613/1926)
May 31, 2018 8:07:48 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(64/575) took 228640 ms. Total solver calls (SAT/UNSAT): 26974(25033/1941)
May 31, 2018 8:07:53 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(65/575) took 233243 ms. Total solver calls (SAT/UNSAT): 27408(25452/1956)
May 31, 2018 8:07:58 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(66/575) took 237896 ms. Total solver calls (SAT/UNSAT): 27841(25870/1971)
May 31, 2018 8:08:03 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(67/575) took 242879 ms. Total solver calls (SAT/UNSAT): 28273(26287/1986)
May 31, 2018 8:08:08 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(68/575) took 248064 ms. Total solver calls (SAT/UNSAT): 28704(26703/2001)
May 31, 2018 8:08:13 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(69/575) took 252855 ms. Total solver calls (SAT/UNSAT): 29134(27118/2016)
May 31, 2018 8:08:17 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(70/575) took 257677 ms. Total solver calls (SAT/UNSAT): 29563(27532/2031)
May 31, 2018 8:08:21 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(71/575) took 261573 ms. Total solver calls (SAT/UNSAT): 29991(27945/2046)
May 31, 2018 8:08:25 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(72/575) took 265597 ms. Total solver calls (SAT/UNSAT): 30418(28357/2061)
May 31, 2018 8:08:29 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(73/575) took 269334 ms. Total solver calls (SAT/UNSAT): 30844(28768/2076)
May 31, 2018 8:08:33 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(74/575) took 273014 ms. Total solver calls (SAT/UNSAT): 31269(29178/2091)
May 31, 2018 8:08:37 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(75/575) took 276878 ms. Total solver calls (SAT/UNSAT): 31693(29587/2106)
May 31, 2018 8:08:41 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(76/575) took 280863 ms. Total solver calls (SAT/UNSAT): 32116(29995/2121)
May 31, 2018 8:08:45 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(77/575) took 284730 ms. Total solver calls (SAT/UNSAT): 32538(30402/2136)
May 31, 2018 8:08:48 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(78/575) took 288592 ms. Total solver calls (SAT/UNSAT): 32959(30808/2151)
May 31, 2018 8:08:52 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(79/575) took 292350 ms. Total solver calls (SAT/UNSAT): 33379(31213/2166)
May 31, 2018 8:08:56 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(80/575) took 296220 ms. Total solver calls (SAT/UNSAT): 33798(31617/2181)
May 31, 2018 8:09:00 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(81/575) took 300036 ms. Total solver calls (SAT/UNSAT): 34216(32020/2196)
May 31, 2018 8:09:03 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(82/575) took 303694 ms. Total solver calls (SAT/UNSAT): 34633(32422/2211)
May 31, 2018 8:09:07 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(83/575) took 307626 ms. Total solver calls (SAT/UNSAT): 35049(32823/2226)
May 31, 2018 8:09:11 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(86/575) took 311107 ms. Total solver calls (SAT/UNSAT): 35808(33480/2328)
May 31, 2018 8:09:15 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(89/575) took 314770 ms. Total solver calls (SAT/UNSAT): 36558(34128/2430)
May 31, 2018 8:09:18 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(92/575) took 318162 ms. Total solver calls (SAT/UNSAT): 37299(34767/2532)
May 31, 2018 8:09:21 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(95/575) took 321552 ms. Total solver calls (SAT/UNSAT): 38031(35397/2634)
May 31, 2018 8:09:25 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(98/575) took 324890 ms. Total solver calls (SAT/UNSAT): 38754(36018/2736)
May 31, 2018 8:09:28 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(101/575) took 328182 ms. Total solver calls (SAT/UNSAT): 39468(36630/2838)
May 31, 2018 8:09:31 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(104/575) took 331424 ms. Total solver calls (SAT/UNSAT): 40173(37233/2940)
May 31, 2018 8:09:35 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(107/575) took 334760 ms. Total solver calls (SAT/UNSAT): 40869(37890/2979)
May 31, 2018 8:09:38 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(110/575) took 338226 ms. Total solver calls (SAT/UNSAT): 41556(38538/3018)
May 31, 2018 8:09:41 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(113/575) took 341535 ms. Total solver calls (SAT/UNSAT): 42234(39177/3057)
May 31, 2018 8:09:45 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(116/575) took 344762 ms. Total solver calls (SAT/UNSAT): 42903(39807/3096)
May 31, 2018 8:09:48 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(119/575) took 347989 ms. Total solver calls (SAT/UNSAT): 43563(40428/3135)
May 31, 2018 8:09:51 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(122/575) took 351151 ms. Total solver calls (SAT/UNSAT): 44214(41040/3174)
May 31, 2018 8:09:54 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(125/575) took 354283 ms. Total solver calls (SAT/UNSAT): 44856(41643/3213)
May 31, 2018 8:10:03 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(126/575) took 363418 ms. Total solver calls (SAT/UNSAT): 45068(41843/3225)
SMT solver raised 'unknown', retrying with same input.
SMT solver raised 'unknown' twice, overapproximating result to 1.
May 31, 2018 8:10:04 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of Finished co-enabling matrix. took 364661 ms. Total solver calls (SAT/UNSAT): 45070(41845/3225)
May 31, 2018 8:10:05 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeDoNotAccord
INFO: Computing Do-Not-Accords matrix : 575 transitions.
May 31, 2018 8:10:08 PM fr.lip6.move.gal.gal2smt.bmc.NextBMCSolver checkSat
WARNING: SMT solver unexpectedly returned 'unknown' answer, retrying.
May 31, 2018 8:10:20 PM fr.lip6.move.gal.gal2smt.bmc.NextBMCSolver checkSat
WARNING: SMT solver unexpectedly returned 'unknown' answer, retrying.
May 31, 2018 8:10:21 PM fr.lip6.move.gal.gal2smt.bmc.NextBMCSolver checkSat
WARNING: SMT solver unexpectedly returned 'unknown' answer, retrying.
May 31, 2018 8:10:22 PM fr.lip6.move.gal.gal2smt.bmc.NextBMCSolver checkSat
WARNING: SMT solver unexpectedly returned 'unknown' answer, retrying.
May 31, 2018 8:10:23 PM fr.lip6.move.gal.gal2smt.bmc.NextBMCSolver checkSat
WARNING: SMT solver unexpectedly returned 'unknown' answer, retrying.
May 31, 2018 8:10:23 PM fr.lip6.move.gal.gal2smt.bmc.NextBMCSolver checkSat
WARNING: SMT solver unexpectedly returned 'unknown' answer, retrying.
May 31, 2018 8:10:24 PM fr.lip6.move.gal.gal2smt.bmc.NextBMCSolver checkSat
WARNING: SMT solver unexpectedly returned 'unknown' answer, retrying.
May 31, 2018 8:10:24 PM fr.lip6.move.gal.gal2smt.bmc.NextBMCSolver checkSat
WARNING: SMT solver unexpectedly returned 'unknown' answer, retrying.
May 31, 2018 8:10:25 PM fr.lip6.move.gal.gal2smt.bmc.NextBMCSolver checkSat
WARNING: SMT solver unexpectedly returned 'unknown' answer, retrying.
May 31, 2018 8:10:26 PM fr.lip6.move.gal.gal2smt.bmc.NextBMCSolver checkSat
WARNING: SMT solver unexpectedly returned 'unknown' answer, retrying.
May 31, 2018 8:10:26 PM fr.lip6.move.gal.gal2smt.bmc.NextBMCSolver checkSat
WARNING: SMT solver unexpectedly returned 'unknown' answer, retrying.
May 31, 2018 8:10:27 PM fr.lip6.move.gal.gal2smt.bmc.NextBMCSolver checkSat
WARNING: SMT solver unexpectedly returned 'unknown' answer, retrying.
May 31, 2018 8:10:58 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of Completed DNA matrix. took 53601 ms. Total solver calls (SAT/UNSAT): 17067(0/17067)
May 31, 2018 8:10:58 PM fr.lip6.move.gal.gal2pins.Gal2PinsTransformerNext transform
INFO: Built C files in 429007ms conformant to PINS in folder :/home/mcc/execution
ITS-tools command line returned an error code 1

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-COL-S05J20"
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"

# 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

tar xzf /home/mcc/BenchKit/INPUTS/PolyORBNT-COL-S05J20.tgz
mv PolyORBNT-COL-S05J20 execution
cd execution
pwd
ls -lh

# this is for BenchKit: explicit launching of the test
echo "====================================================================="
echo " Generated by BenchKit 2-3637"
echo " Executing tool itstools"
echo " Input is PolyORBNT-COL-S05J20, 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 r212-smll-152732263200425"
echo "====================================================================="
echo
echo "--------------------"
echo "content from stdout:"
echo
echo "=== Data for post analysis generated by BenchKit (invocation template)"
echo
if [ "LTLCardinality" = "UpperBounds" ] ; then
echo "The expected result is a vector of positive values"
echo NUM_VECTOR
elif [ "LTLCardinality" != "StateSpace" ] ; then
echo "The expected result is a vector of booleans"
echo BOOL_VECTOR
else
echo "no data necessary for post analysis"
fi
echo
if [ -f "LTLCardinality.txt" ] ; then
echo "here is the order used to build the result vector(from text file)"
for x in $(grep Property LTLCardinality.txt | cut -d ' ' -f 2 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ -f "LTLCardinality.xml" ] ; then # for cunf (txt files deleted;-)
echo echo "here is the order used to build the result vector(from xml file)"
for x in $(grep '' LTLCardinality.xml | cut -d '>' -f 2 | cut -d '<' -f 1 | sort -u) ; do
echo "FORMULA_NAME $x"
done
fi
echo
echo "=== Now, execution of the tool begins"
echo
echo -n "BK_START "
date -u +%s%3N
echo
timeout -s 9 $BK_TIME_CONFINEMENT bash -c "/home/mcc/BenchKit/BenchKit_head.sh 2> STDERR ; echo ; echo -n \"BK_STOP \" ; date -u +%s%3N"
if [ $? -eq 137 ] ; then
echo
echo "BK_TIME_CONFINEMENT_REACHED"
fi
echo
echo "--------------------"
echo "content from stderr:"
echo
cat STDERR ;