Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.HeaterCooler_u.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo", uses=false)
Using package IDEAS with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo)
Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo)
Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Running command: translateModel(IDEAS.Fluid.Interfaces.Examples.HeaterCooler_u,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.HeaterCooler_u")
translateModel(IDEAS.Fluid.Interfaces.Examples.HeaterCooler_u,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.HeaterCooler_u")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.0009686/0.0009685, allocations: 86.95 kB / 15.06 MB, free: 1.09 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.000986/0.0009861, allocations: 168.7 kB / 15.95 MB, free: 204 kB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.37/1.37, allocations: 223.3 MB / 240 MB, free: 5.395 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 0.9904/0.9904, allocations: 135.3 MB / 426.4 MB, free: 14.21 MB / 350.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.0003622/0.0003624, allocations: 15.98 kB / 0.507 GB, free: 5.16 MB / 414.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1736/0.174, allocations: 82.31 MB / 0.5874 GB, free: 3.027 MB / 494.1 MB
Notification: Performance of NFInst.instantiate(IDEAS.Fluid.Interfaces.Examples.HeaterCooler_u): time 0.5661/0.7401, allocations: 277.5 MB / 0.8584 GB, free: 6.84 MB / 0.67 GB
Notification: Performance of NFInst.instExpressions: time 0.4998/1.24, allocations: 46.94 MB / 0.9042 GB, free: 65.11 MB / 0.67 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01366/1.254, allocations: 263.3 kB / 0.9045 GB, free: 65.11 MB / 0.67 GB
Notification: Performance of NFTyping.typeComponents: time 0.0116/1.265, allocations: 2.383 MB / 0.9068 GB, free: 65.07 MB / 0.67 GB
Notification: Performance of NFTyping.typeBindings: time 0.02991/1.295, allocations: 7.242 MB / 0.9139 GB, free: 64.76 MB / 0.67 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01965/1.315, allocations: 4.767 MB / 0.9185 GB, free: 64.64 MB / 0.67 GB
Notification: Performance of NFFlatten.flatten: time 0.03619/1.351, allocations: 21.04 MB / 0.9391 GB, free: 62.72 MB / 0.67 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.01223/1.363, allocations: 4.314 MB / 0.9433 GB, free: 62.02 MB / 0.67 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01812/1.382, allocations: 5.904 MB / 0.949 GB, free: 60.08 MB / 0.67 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01105/1.393, allocations: 4.611 MB / 0.9535 GB, free: 58.27 MB / 0.67 GB
Notification: Performance of NFPackage.collectConstants: time 0.002707/1.395, allocations: 229 kB / 0.9538 GB, free: 58.27 MB / 0.67 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01376/1.409, allocations: 2.643 MB / 0.9563 GB, free: 57.55 MB / 0.67 GB
Notification: Performance of NFScalarize.scalarize: time 0.002913/1.412, allocations: 1.058 MB / 0.9574 GB, free: 57.05 MB / 0.67 GB
Notification: Performance of NFVerifyModel.verify: time 0.004181/1.416, allocations: 1.375 MB / 0.9587 GB, free: 56.8 MB / 0.67 GB
Notification: Performance of NFConvertDAE.convert: time 0.01192/1.428, allocations: 7.44 MB / 0.966 GB, free: 52.98 MB / 0.67 GB
Notification: Performance of FrontEnd - DAE generated: time 5.811e-06/1.428, allocations: 4 kB / 0.966 GB, free: 52.97 MB / 0.67 GB
Notification: Performance of FrontEnd: time 1.894e-06/1.428, allocations: 0 / 0.966 GB, free: 52.97 MB / 0.67 GB
Notification: Performance of Transformations before backend: time 0.0003026/1.429, allocations: 0 / 0.966 GB, free: 52.97 MB / 0.67 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1035
 * Number of variables: 1035
Notification: Performance of Generate backend data structure: time 0.01117/1.44, allocations: 6.27 MB / 0.9721 GB, free: 49.07 MB / 0.67 GB
Notification: Performance of prepare preOptimizeDAE: time 3.806e-05/1.44, allocations: 14.81 kB / 0.9721 GB, free: 49.06 MB / 0.67 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003319/1.443, allocations: 0.7835 MB / 0.9729 GB, free: 48.68 MB / 0.67 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01197/1.455, allocations: 4.999 MB / 0.9778 GB, free: 46.61 MB / 0.67 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003378/1.456, allocations: 323.5 kB / 0.9781 GB, free: 46.6 MB / 0.67 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0009864/1.457, allocations: 439.1 kB / 0.9785 GB, free: 46.59 MB / 0.67 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.007203/1.464, allocations: 4.35 MB / 0.9828 GB, free: 43.69 MB / 0.67 GB
Notification: Performance of preOpt findStateOrder (simulation): time 8.554e-05/1.464, allocations: 15.19 kB / 0.9828 GB, free: 43.68 MB / 0.67 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003289/1.464, allocations: 173.8 kB / 0.9829 GB, free: 43.63 MB / 0.67 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 8.596e-05/1.464, allocations: 126.4 kB / 0.9831 GB, free: 43.52 MB / 0.67 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.004507/1.469, allocations: 2.939 MB / 0.9859 GB, free: 41.58 MB / 0.67 GB
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.02072/1.49, allocations: 25.03 MB / 1.01 GB, free: 18.72 MB / 0.67 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002344/1.492, allocations: 2.747 MB / 1.013 GB, free: 16.51 MB / 0.67 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001131/1.493, allocations: 0.9998 MB / 1.014 GB, free: 15.89 MB / 0.67 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001944/1.495, allocations: 3.913 MB / 1.018 GB, free: 11.17 MB / 0.67 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.603e-05/1.495, allocations: 66.75 kB / 1.018 GB, free: 11.11 MB / 0.67 GB
Notification: Performance of pre-optimization done (n=217): time 4.098e-06/1.495, allocations: 0 / 1.018 GB, free: 11.11 MB / 0.67 GB
Notification: Performance of matching and sorting (n=217): time 0.008442/1.504, allocations: 4.064 MB / 1.022 GB, free: 7.785 MB / 0.67 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.095e-05/1.504, allocations: 77.39 kB / 1.022 GB, free: 7.699 MB / 0.67 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.005225/1.509, allocations: 4.186 MB / 1.026 GB, free: 4.668 MB / 0.67 GB
Notification: Performance of collectPreVariables (initialization): time 0.0004744/1.509, allocations: 84.02 kB / 1.026 GB, free: 4.613 MB / 0.67 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001544/1.511, allocations: 2.794 MB / 1.029 GB, free: 2.332 MB / 0.67 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0006635/1.512, allocations: 0.7608 MB / 1.03 GB, free: 1.578 MB / 0.67 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001036/1.512, allocations: 56 kB / 1.03 GB, free: 1.523 MB / 0.67 GB
Notification: Performance of setup shared object (initialization): time 0.0001099/1.512, allocations: 419.8 kB / 1.03 GB, free: 1.109 MB / 0.67 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001099/1.513, allocations: 0.7787 MB / 1.031 GB, free: 336 kB / 0.67 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001947/1.515, allocations: 1.801 MB / 1.033 GB, free: 14.09 MB / 0.6856 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001693/1.517, allocations: 1.074 MB / 1.034 GB, free: 13.01 MB / 0.6856 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.271e-05/1.517, allocations: 12 kB / 1.034 GB, free: 13 MB / 0.6856 GB
Notification: Performance of matching and sorting (n=365) (initialization): time 0.0072/1.524, allocations: 3.485 MB / 1.037 GB, free: 9.457 MB / 0.6856 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0005024/1.524, allocations: 0.7462 MB / 1.038 GB, free: 8.406 MB / 0.6856 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.608e-05/1.524, allocations: 24 kB / 1.038 GB, free: 8.383 MB / 0.6856 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002286/1.527, allocations: 0.5495 MB / 1.038 GB, free: 7.828 MB / 0.6856 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001741/1.528, allocations: 0.5577 MB / 1.039 GB, free: 7.27 MB / 0.6856 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002123/1.531, allocations: 2.698 MB / 1.041 GB, free: 4.473 MB / 0.6856 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004845/1.535, allocations: 0.5957 MB / 1.042 GB, free: 3.875 MB / 0.6856 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003975/1.536, allocations: 136 kB / 1.042 GB, free: 3.742 MB / 0.6856 GB
Notification: Performance of prepare postOptimizeDAE: time 1.324e-05/1.536, allocations: 4 kB / 1.042 GB, free: 3.738 MB / 0.6856 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.005088/1.541, allocations: 2.81 MB / 1.045 GB, free: 0.875 MB / 0.6856 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.87e-05/1.541, allocations: 20 kB / 1.045 GB, free: 0.8555 MB / 0.6856 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0009156/1.542, allocations: 367.2 kB / 1.045 GB, free: 496 kB / 0.6856 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001645/1.544, allocations: 0.5577 MB / 1.046 GB, free: 15.93 MB / 0.7012 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.008087/1.552, allocations: 7.705 MB / 1.053 GB, free: 7.672 MB / 0.7012 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004692/1.556, allocations: 0.5527 MB / 1.054 GB, free: 7.121 MB / 0.7012 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003904/1.557, allocations: 140 kB / 1.054 GB, free: 6.984 MB / 0.7012 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 97
 * Number of states: 0 ()
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (323):
 * Single equations (assignments): 319
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 4
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 4 {1 12,1 9,1 12,1 9}
Notification: Performance of prepare postOptimizeDAE: time 0.002324/1.559, allocations: 1.002 MB / 1.055 GB, free: 5.973 MB / 0.7012 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001393/1.561, allocations: 0.5094 MB / 1.056 GB, free: 5.457 MB / 0.7012 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.006185/1.567, allocations: 3.562 MB / 1.059 GB, free: 1.836 MB / 0.7012 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 5.352e-05/1.567, allocations: 43.95 kB / 1.059 GB, free: 1.793 MB / 0.7012 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.603e-06/1.567, allocations: 4 kB / 1.059 GB, free: 1.789 MB / 0.7012 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.003671/1.571, allocations: 2.432 MB / 1.061 GB, free: 15.32 MB / 0.7169 GB
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 postOpt removeSimpleEquations (simulation): time 0.01763/1.588, allocations: 8.192 MB / 1.069 GB, free: 6.918 MB / 0.7169 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.319e-05/1.588, allocations: 4.766 kB / 1.069 GB, free: 6.914 MB / 0.7169 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001306/1.59, allocations: 363.5 kB / 1.07 GB, free: 6.559 MB / 0.7169 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0006854/1.59, allocations: 308.1 kB / 1.07 GB, free: 6.254 MB / 0.7169 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001291/1.59, allocations: 59.97 kB / 1.07 GB, free: 6.195 MB / 0.7169 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001734/1.592, allocations: 2.502 MB / 1.073 GB, free: 3.598 MB / 0.7169 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.374e-06/1.592, allocations: 4.25 kB / 1.073 GB, free: 3.594 MB / 0.7169 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.007148/1.599, allocations: 4.33 MB / 1.077 GB, free: 15.19 MB / 0.7325 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002789/1.602, allocations: 0.9778 MB / 1.078 GB, free: 14.19 MB / 0.7325 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0009304/1.603, allocations: 44 kB / 1.078 GB, free: 14.14 MB / 0.7325 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003295/1.606, allocations: 419.3 kB / 1.078 GB, free: 13.73 MB / 0.7325 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002303/1.607, allocations: 161.7 kB / 1.078 GB, free: 13.57 MB / 0.7325 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.000225/1.607, allocations: 111.9 kB / 1.078 GB, free: 13.46 MB / 0.7325 GB
Notification: Performance of sorting global known variables: time 0.004355/1.611, allocations: 2.746 MB / 1.081 GB, free: 10.75 MB / 0.7325 GB
Notification: Performance of sort global known variables: time 1.8e-07/1.611, allocations: 0 / 1.081 GB, free: 10.75 MB / 0.7325 GB
Notification: Performance of remove unused functions: time 0.01182/1.623, allocations: 3.257 MB / 1.084 GB, free: 7.48 MB / 0.7325 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 4
 * Number of states: 10 (hea1.vol.dynBal.U,hea2.vol.dynBal.U,hea3.vol.dynBal.U,hea4.vol.dynBal.U,mix1.dynBal.U,hea5.vol.dynBal.U,hea6.vol.dynBal.U,hea7.vol.dynBal.U,hea8.vol.dynBal.U,mix2.dynBal.U)
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (219):
 * Single equations (assignments): 181
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 34
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 4
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 4 {1 9,1 7,1 9,1 7}
Notification: Performance of Backend phase and start with SimCode phase: time 0.002887/1.626, allocations: 1.421 MB / 1.086 GB, free: 6.219 MB / 0.7325 GB
Notification: Performance of simCode: created initialization part: time 0.007551/1.634, allocations: 4.4 MB / 1.09 GB, free: 1.754 MB / 0.7325 GB
Notification: Performance of simCode: created event and clocks part: time 1.054e-05/1.634, allocations: 4 kB / 1.09 GB, free: 1.75 MB / 0.7325 GB
Notification: Performance of simCode: created simulation system equations: time 0.002087/1.636, allocations: 1.225 MB / 1.091 GB, free: 0.5273 MB / 0.7325 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01615/1.652, allocations: 2.656 MB / 1.094 GB, free: 13.91 MB / 0.7481 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.0205/1.672, allocations: 11.05 MB / 1.105 GB, free: 2.855 MB / 0.7481 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.002992/1.675, allocations: 2.876 MB / 1.107 GB, free: 15.96 MB / 0.7637 GB
Notification: Performance of simCode: alias equations: time 0.00526/1.681, allocations: 1.157 MB / 1.109 GB, free: 14.79 MB / 0.7637 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001113/1.682, allocations: 415.2 kB / 1.109 GB, free: 14.39 MB / 0.7637 GB
Notification: Performance of SimCode: time 9.92e-07/1.682, allocations: 0 / 1.109 GB, free: 14.39 MB / 0.7637 GB
Notification: Performance of Templates: time 0.513/2.195, allocations: 100.1 MB / 1.207 GB, free: 304 MB / 0.795 GB
make -j1 -f IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.HeaterCooler_u.makefile
(rm -f IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.HeaterCooler_u.pipe ; mkfifo IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.HeaterCooler_u.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.HeaterCooler_u.pipe >> ../files/IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.HeaterCooler_u.sim & ./IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.HeaterCooler_u  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.HeaterCooler_u.pipe 2>&1)