Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ModelicaTest_3.2.2_ModelicaTest.Fluid.TestComponents.Machines.TestWaterPumpDCMotorHeatTransfer.conf.json
Using package ModelicaTest with version 3.2.2 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.2+maint.om/package.mo)
Using package ModelicaServices with version 3.2.2 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.2+maint.om/package.mo)
Using package Modelica with version 3.2.2 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/package.mo)
Using package Complex with version 3.2.2 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.2+maint.om/package.mo)
Running command: "" <> buildModelFMU(ModelicaTest.Fluid.TestComponents.Machines.TestWaterPumpDCMotorHeatTransfer,fileNamePrefix="ModelicaTest_3_2_2_ModelicaTest_Fluid_TestComponents_Machines_TestWaterPumpDCMotorHeatTransfer",fmuType="me",version="2.0",platforms={"static"})
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.2+maint.om/package.mo): time 0.01041/0.01041, allocations: 173.2 kB / 15.12 MB, free: 5.934 MB / 13.93 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/package.mo): time 1.935/1.935, allocations: 194.5 MB / 210.3 MB, free: 8.582 MB / 170.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.2+maint.om/package.mo): time 0.002012/0.002011, allocations: 124.7 kB / 255.6 MB, free: 11.2 MB / 218.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.2+maint.om/package.mo): time 0.2962/0.2962, allocations: 40.01 MB / 340.8 MB, free: 11.53 MB / 250.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004772/0.0004773, allocations: 11.59 kB / 406.3 MB, free: 52.01 MB / 298.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1034/0.1039, allocations: 54.87 MB / 461.1 MB, free: 3.309 MB / 298.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 7.823/7.927, allocations: 2.629 GB / 3.079 GB, free: 30.6 MB / 490.7 MB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0003329/7.928, allocations: 87.77 kB / 3.079 GB, free: 30.55 MB / 490.7 MB
Notification: Performance of FrontEnd - DAE generated: time 2.569/10.5, allocations: 457.6 MB / 3.526 GB, free: 51.18 MB / 490.7 MB
Notification: Performance of FrontEnd: time 2.375e-06/10.5, allocations: 0 / 3.526 GB, free: 51.18 MB / 490.7 MB
Notification: Performance of Transformations before backend: time 0.0001303/10.5, allocations: 32.36 kB / 3.526 GB, free: 51.18 MB / 490.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 337
 * Number of variables: 337
Notification: Performance of Generate backend data structure: time 0.01091/10.51, allocations: 2.483 MB / 3.528 GB, free: 49.93 MB / 490.7 MB
Notification: Performance of prepare preOptimizeDAE: time 5.22e-05/10.51, allocations: 7.25 kB / 3.528 GB, free: 49.93 MB / 490.7 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0006715/10.51, allocations: 200.7 kB / 3.529 GB, free: 49.89 MB / 490.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004142/10.51, allocations: 442.6 kB / 3.529 GB, free: 49.8 MB / 490.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.003122/10.52, allocations: 1.012 MB / 3.53 GB, free: 49.46 MB / 490.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001136/10.52, allocations: 111.3 kB / 3.53 GB, free: 49.46 MB / 490.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002865/10.52, allocations: 134.2 kB / 3.53 GB, free: 49.46 MB / 490.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.00529/10.52, allocations: 1.681 MB / 3.532 GB, free: 49.16 MB / 490.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 6.841e-05/10.52, allocations: 7.219 kB / 3.532 GB, free: 49.16 MB / 490.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001904/10.52, allocations: 59.66 kB / 3.532 GB, free: 49.16 MB / 490.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.788e-05/10.52, allocations: 44.42 kB / 3.532 GB, free: 49.16 MB / 490.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.005094/10.53, allocations: 1.376 MB / 3.533 GB, free: 49.14 MB / 490.7 MB
Warning: The model contains alias variables with redundant start and/or conflicting nominal values. It is recommended to resolve the conflicts, because otherwise the system could be hard to solve. To print the conflicting alias sets and the chosen candidates please use -d=aliasConflicts.
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.01188/10.54, allocations: 7.639 MB / 3.541 GB, free: 44.68 MB / 490.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.003707/10.54, allocations: 0.9133 MB / 3.542 GB, free: 44.65 MB / 490.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.05397/10.6, allocations: 18.38 MB / 3.56 GB, free: 33.18 MB / 490.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.143e-05/10.6, allocations: 42.7 kB / 3.56 GB, free: 33.14 MB / 490.7 MB
Notification: Performance of pre-optimization done (n=71): time 4.429e-06/10.6, allocations: 5.797 kB / 3.56 GB, free: 33.14 MB / 490.7 MB
Notification: Performance of matching and sorting (n=93): time 0.05423/10.65, allocations: 6.115 MB / 3.566 GB, free: 32.05 MB / 490.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.2041/10.86, allocations: 42.99 MB / 3.608 GB, free: 26.1 MB / 490.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001505/10.86, allocations: 0.7826 MB / 3.608 GB, free: 25.94 MB / 490.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0002084/10.86, allocations: 40.02 kB / 3.608 GB, free: 25.91 MB / 490.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0004822/10.86, allocations: 0.7029 MB / 3.609 GB, free: 25.54 MB / 490.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0003479/10.86, allocations: 333.4 kB / 3.609 GB, free: 25.33 MB / 490.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001286/10.86, allocations: 29.59 kB / 3.609 GB, free: 25.33 MB / 490.7 MB
Notification: Performance of setup shared object (initialization): time 0.0001037/10.86, allocations: 357.2 kB / 3.61 GB, free: 25.03 MB / 490.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001609/10.86, allocations: 486.2 kB / 3.61 GB, free: 25.02 MB / 490.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.00182/10.86, allocations: 0.9809 MB / 3.611 GB, free: 24.39 MB / 490.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002002/10.86, allocations: 0.6105 MB / 3.612 GB, free: 24.34 MB / 490.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.233e-05/10.86, allocations: 7.438 kB / 3.612 GB, free: 24.34 MB / 490.7 MB
Notification: Performance of matching and sorting (n=171) (initialization): time 0.005815/10.87, allocations: 1.777 MB / 3.614 GB, free: 24.2 MB / 490.7 MB
Notification: Performance of prepare postOptimizeDAE: time 0.001342/10.87, allocations: 6.275 MB / 3.62 GB, free: 17.61 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.542e-05/10.87, allocations: 18.31 kB / 3.62 GB, free: 17.61 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.008732/10.88, allocations: 1.009 MB / 3.621 GB, free: 17.52 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001985/10.88, allocations: 313.2 kB / 3.621 GB, free: 17.51 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003306/10.89, allocations: 1.623 MB / 3.623 GB, free: 16.45 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002383/10.89, allocations: 134.1 kB / 3.623 GB, free: 16.44 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002411/10.89, allocations: 87.42 kB / 3.623 GB, free: 16.38 MB / 490.7 MB
Notification: Performance of prepare postOptimizeDAE: time 1.329e-05/10.89, allocations: 4 kB / 3.623 GB, free: 16.38 MB / 490.7 MB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.007585/10.9, allocations: 1.864 MB / 3.625 GB, free: 15.3 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.808e-05/10.9, allocations: 20.16 kB / 3.625 GB, free: 15.29 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.005536/10.9, allocations: 0.7134 MB / 3.625 GB, free: 14.8 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001962/10.9, allocations: 306.6 kB / 3.626 GB, free: 14.58 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003636/10.91, allocations: 1.595 MB / 3.627 GB, free: 29.21 MB / 0.4948 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002239/10.91, allocations: 132.5 kB / 3.627 GB, free: 29.13 MB / 0.4948 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002691/10.91, allocations: 87.52 kB / 3.627 GB, free: 29.07 MB / 0.4948 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 72
 * Number of states: 0 ()
 * Number of discrete variables: 6 (Source.medium.phase,Sink.medium.phase,pump.heatTransfer.states[1].phase,Valve.state_b.phase,Valve.state_a.phase,pump.monitoring.state_in.phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (150):
 * Single equations (assignments): 146
 * Array equations: 2
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 2 {2 8,2 9}
Notification: Performance of prepare postOptimizeDAE: time 0.001145/10.91, allocations: 416.2 kB / 3.628 GB, free: 28.77 MB / 0.4948 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003742/10.91, allocations: 130.5 kB / 3.628 GB, free: 28.64 MB / 0.4948 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.007913/10.92, allocations: 3.721 MB / 3.632 GB, free: 26.64 MB / 0.4948 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.006618/10.93, allocations: 3.169 MB / 3.635 GB, free: 24.96 MB / 0.4948 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 8.616e-06/10.93, allocations: 0 / 3.635 GB, free: 24.96 MB / 0.4948 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 2.716e-05/10.93, allocations: 10.98 kB / 3.635 GB, free: 24.96 MB / 0.4948 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01238/10.94, allocations: 5.936 MB / 3.64 GB, free: 22.03 MB / 0.4948 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.036e-05/10.94, allocations: 0 / 3.64 GB, free: 22.03 MB / 0.4948 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001333/10.94, allocations: 182 kB / 3.641 GB, free: 21.89 MB / 0.4948 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.007923/10.95, allocations: 1.649 MB / 3.642 GB, free: 20.74 MB / 0.4948 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0002359/10.95, allocations: 32.42 kB / 3.642 GB, free: 20.73 MB / 0.4948 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.004395/10.95, allocations: 2.409 MB / 3.645 GB, free: 18.95 MB / 0.4948 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 0.09524/11.05, allocations: 24.66 MB / 3.669 GB, free: 13.14 MB / 0.5105 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.009881/11.06, allocations: 3.926 MB / 3.673 GB, free: 9.543 MB / 0.5105 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001173/11.06, allocations: 394.2 kB / 3.673 GB, free: 9.188 MB / 0.5105 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003125/11.06, allocations: 24 kB / 3.673 GB, free: 9.164 MB / 0.5105 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001571/11.06, allocations: 99.02 kB / 3.673 GB, free: 9.09 MB / 0.5105 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000228/11.06, allocations: 77.95 kB / 3.673 GB, free: 9.047 MB / 0.5105 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001326/11.06, allocations: 39.7 kB / 3.673 GB, free: 9.012 MB / 0.5105 GB
Notification: Performance of sorting global known variables: time 0.001443/11.06, allocations: 0.6386 MB / 3.674 GB, free: 8.469 MB / 0.5105 GB
Notification: Performance of sort global known variables: time 4.71e-07/11.06, allocations: 0 / 3.674 GB, free: 8.469 MB / 0.5105 GB
Notification: Performance of remove unused functions: time 0.0198/11.08, allocations: 4.02 MB / 3.678 GB, free: 4.512 MB / 0.5105 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 4
 * Number of states: 4 ($STATESET1.x[2],$STATESET1.x[1],motor.inertiaRotor.phi,motor.la.i)
 * Number of discrete variables: 21 ($cse9.phase,$cse9.region,$cse11.phase,$cse11.region,$cse12.region3boundary,$cse13.region3boundary,$cse14.phase,$cse14.region,$cse15.phase,$cse15.region,$cse20.phase,$cse20.region,$cse21.phase,$cse21.region,$cse23.phase,$cse23.region,$cse24.phase,$cse24.region,Source.medium.phase,Sink.medium.phase,pump.heatTransfer.states[1].phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (83):
 * Single equations (assignments): 75
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 6
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 2 {2 6,3 16}
Notification: Performance of Backend phase and start with SimCode phase: time 0.4363/11.52, allocations: 7.621 MB / 3.685 GB, free: 77.15 MB / 0.5105 GB
Notification: Performance of simCode: created initialization part: time 0.009329/11.53, allocations: 2.514 MB / 3.688 GB, free: 77.12 MB / 0.5105 GB
Notification: Performance of simCode: created event and clocks part: time 1.109e-05/11.53, allocations: 1.375 kB / 3.688 GB, free: 77.12 MB / 0.5105 GB
Notification: Performance of simCode: created simulation system equations: time 0.003625/11.53, allocations: 1.182 MB / 3.689 GB, free: 77.11 MB / 0.5105 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003666/11.54, allocations: 391.2 kB / 3.689 GB, free: 77.11 MB / 0.5105 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.2677/11.8, allocations: 93.27 MB / 3.78 GB, free: 60.25 MB / 0.5105 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001136/11.8, allocations: 1.442 MB / 3.782 GB, free: 59.49 MB / 0.5105 GB
Notification: Performance of simCode: alias equations: time 0.002881/11.81, allocations: 0.7153 MB / 3.782 GB, free: 59.44 MB / 0.5105 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001676/11.81, allocations: 0.7247 MB / 3.783 GB, free: 59.43 MB / 0.5105 GB
Notification: Performance of SimCode: time 9.31e-07/11.81, allocations: 0 / 3.783 GB, free: 59.43 MB / 0.5105 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.7313/12.54, allocations: 140.7 MB / 3.92 GB, free: 24.63 MB / 0.5105 GB
Notification: Performance of buildModelFMU: configured platform static using cached values: time 0.00019/12.54, allocations: 290 kB / 3.921 GB, free: 24.27 MB / 0.5105 GB
Notification: Performance of buildModelFMU: Generate platform static: time 10.05/22.6, allocations: 3.906 kB / 3.921 GB, free: 24.27 MB / 0.5105 GB
TODO: How the !@#!# did the simulation report success but simulation result ModelicaTest_3.2.2_ModelicaTest.Fluid.TestComponents.Machines.TestWaterPumpDCMotorHeatTransfer_res.mat does not exist to compare? outputFormat=mat