Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr IDEAS_dev_IDEAS.Airflow.AHU.Validation.IehWinter.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: "" <> buildModelFMU(IDEAS.Airflow.AHU.Validation.IehWinter,fileNamePrefix="IDEAS_dev_IDEAS_Airflow_AHU_Validation_IehWinter",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(IDEAS.Airflow.AHU.Validation.IehWinter,fileNamePrefix="IDEAS_dev_IDEAS_Airflow_AHU_Validation_IehWinter",fmuType="me",version="2.0",platforms={"static"})
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.0008021/0.0008021, 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.000822/0.0008221, 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.438/1.438, allocations: 223.3 MB / 240 MB, free: 5.422 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 0.9752/0.9752, allocations: 135.3 MB / 426.4 MB, free: 14.19 MB / 350.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.0003431/0.0003434, allocations: 13.2 kB / 0.5071 GB, free: 5.043 MB / 414.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1823/0.1827, allocations: 82.31 MB / 0.5875 GB, free: 2.906 MB / 494.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/Fluid/Interfaces.mo:202:5-202:64:writable] Warning: An inner declaration for outer component system could not be found and was automatically generated.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/Fluid/Interfaces.mo:202:5-202:64:writable] Notification: The diagnostics message for the missing inner is: 
Your model is using an outer "system" component but
an inner "system" component is not defined.
For simulation drag Modelica.Fluid.System into your model
to specify system properties.
Notification: Performance of NFInst.instantiate(IDEAS.Airflow.AHU.Validation.IehWinter): time 0.5414/0.7241, allocations: 212.9 MB / 0.7954 GB, free: 7.887 MB / 0.6075 GB
Notification: Performance of NFInst.instExpressions: time 0.02823/0.7524, allocations: 22.19 MB / 0.8171 GB, free: 1.656 MB / 0.6231 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.00324/0.7556, allocations: 59.62 kB / 0.8171 GB, free: 1.598 MB / 0.6231 GB
Notification: Performance of NFTyping.typeComponents: time 0.003147/0.7588, allocations: 0.8967 MB / 0.818 GB, free: 0.6953 MB / 0.6231 GB
Notification: Performance of NFTyping.typeBindings: time 0.009223/0.7681, allocations: 2.842 MB / 0.8208 GB, free: 13.84 MB / 0.6387 GB
Notification: Performance of NFTyping.typeClassSections: time 0.00534/0.7734, allocations: 1.618 MB / 0.8223 GB, free: 12.23 MB / 0.6387 GB
Notification: Performance of NFFlatten.flatten: time 0.007771/0.7812, allocations: 5.598 MB / 0.8278 GB, free: 6.613 MB / 0.6387 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.002484/0.7837, allocations: 1.347 MB / 0.8291 GB, free: 5.25 MB / 0.6387 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.004196/0.7879, allocations: 1.763 MB / 0.8308 GB, free: 3.48 MB / 0.6387 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.003021/0.791, allocations: 1.521 MB / 0.8323 GB, free: 1.953 MB / 0.6387 GB
Notification: Performance of NFPackage.collectConstants: time 0.0002826/0.7913, allocations: 80 kB / 0.8324 GB, free: 1.875 MB / 0.6387 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.006079/0.7973, allocations: 2.245 MB / 0.8346 GB, free: 15.62 MB / 0.6544 GB
Notification: Performance of NFScalarize.scalarize: time 0.0009455/0.7983, allocations: 0.6269 MB / 0.8352 GB, free: 15 MB / 0.6544 GB
Notification: Performance of NFVerifyModel.verify: time 0.0009644/0.7993, allocations: 460.6 kB / 0.8357 GB, free: 14.54 MB / 0.6544 GB
Notification: Performance of NFConvertDAE.convert: time 0.00523/0.8045, allocations: 3.086 MB / 0.8387 GB, free: 11.45 MB / 0.6544 GB
Notification: Performance of FrontEnd - DAE generated: time 6.553e-06/0.8046, allocations: 0 / 0.8387 GB, free: 11.45 MB / 0.6544 GB
Notification: Performance of FrontEnd: time 1.613e-06/0.8046, allocations: 4 kB / 0.8387 GB, free: 11.44 MB / 0.6544 GB
Notification: Performance of Transformations before backend: time 4.895e-05/0.8046, allocations: 0 / 0.8387 GB, free: 11.44 MB / 0.6544 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 391
 * Number of variables: 391
Notification: Performance of Generate backend data structure: time 0.005072/0.8097, allocations: 2.317 MB / 0.8409 GB, free: 9.062 MB / 0.6544 GB
Notification: Performance of prepare preOptimizeDAE: time 4.973e-05/0.8098, allocations: 8.031 kB / 0.8409 GB, free: 9.055 MB / 0.6544 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0003854/0.8102, allocations: 229 kB / 0.8412 GB, free: 8.82 MB / 0.6544 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.008387/0.8186, allocations: 1.211 MB / 0.8423 GB, free: 7.605 MB / 0.6544 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.003126/0.8217, allocations: 1.384 MB / 0.8437 GB, free: 6.168 MB / 0.6544 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001342/0.8219, allocations: 119 kB / 0.8438 GB, free: 6.051 MB / 0.6544 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003184/0.8222, allocations: 155.9 kB / 0.844 GB, free: 5.898 MB / 0.6544 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.004367/0.8266, allocations: 2.098 MB / 0.846 GB, free: 3.73 MB / 0.6544 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.747e-05/0.8267, allocations: 0 / 0.846 GB, free: 3.73 MB / 0.6544 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001688/0.8268, allocations: 71.92 kB / 0.8461 GB, free: 3.66 MB / 0.6544 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 9.533e-05/0.8269, allocations: 74.94 kB / 0.8461 GB, free: 3.586 MB / 0.6544 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.004338/0.8313, allocations: 1.951 MB / 0.848 GB, free: 1.629 MB / 0.6544 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.01158/0.8429, allocations: 7.09 MB / 0.855 GB, free: 10.21 MB / 0.67 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.003437/0.8463, allocations: 1.717 MB / 0.8566 GB, free: 8.465 MB / 0.67 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001613/0.848, allocations: 0.8184 MB / 0.8574 GB, free: 7.648 MB / 0.67 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0009282/0.8489, allocations: 0.5972 MB / 0.858 GB, free: 6.938 MB / 0.67 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.275e-05/0.849, allocations: 47.56 kB / 0.8581 GB, free: 6.883 MB / 0.67 GB
Notification: Performance of pre-optimization done (n=118): time 3.467e-06/0.849, allocations: 0 / 0.8581 GB, free: 6.883 MB / 0.67 GB
Notification: Performance of matching and sorting (n=122): time 0.01285/0.8618, allocations: 4.833 MB / 0.8628 GB, free: 1.957 MB / 0.67 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.102e-05/0.8619, allocations: 68.41 kB / 0.8629 GB, free: 1.875 MB / 0.67 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002183/0.8641, allocations: 1.43 MB / 0.8643 GB, free: 452 kB / 0.67 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001701/0.8643, allocations: 49.7 kB / 0.8643 GB, free: 396 kB / 0.67 GB
Notification: Performance of collectInitialEqns (initialization): time 0.4006/1.265, allocations: 0.7964 MB / 0.8651 GB, free: 216.4 MB / 0.67 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0007334/1.266, allocations: 420.8 kB / 0.8655 GB, free: 216.2 MB / 0.67 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001119/1.266, allocations: 22.06 kB / 0.8655 GB, free: 216.2 MB / 0.67 GB
Notification: Performance of setup shared object (initialization): time 0.0001222/1.266, allocations: 352 kB / 0.8658 GB, free: 215.9 MB / 0.67 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001634/1.268, allocations: 0.6611 MB / 0.8665 GB, free: 215.9 MB / 0.67 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001721/1.269, allocations: 0.8886 MB / 0.8674 GB, free: 215.7 MB / 0.67 GB
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: IEH.volTop.dynBal.medium.p = IEH.volTop.dynBal.p_start (bou2.p = IEH.volTop.dynBal.p_start)
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: IEH.volBot.dynBal.medium.p = IEH.volBot.dynBal.p_start (bui.p = IEH.volBot.dynBal.p_start)
Notification: Performance of analyzeInitialSystem (initialization): time 0.03608/1.305, allocations: 6.819 MB / 0.874 GB, free: 215.5 MB / 0.67 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.211e-06/1.306, allocations: 0 / 0.874 GB, free: 215.5 MB / 0.67 GB
Notification: Performance of matching and sorting (n=147) (initialization): time 0.005005/1.311, allocations: 1.959 MB / 0.8759 GB, free: 215.3 MB / 0.67 GB
Notification: Performance of prepare postOptimizeDAE: time 2.611e-05/1.311, allocations: 6.375 kB / 0.8759 GB, free: 215.3 MB / 0.67 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.386e-05/1.311, allocations: 7.312 kB / 0.8759 GB, free: 215.3 MB / 0.67 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0009702/1.312, allocations: 193.8 kB / 0.8761 GB, free: 215.3 MB / 0.67 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001602/1.313, allocations: 332.7 kB / 0.8764 GB, free: 215.2 MB / 0.67 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003633/1.317, allocations: 3.246 MB / 0.8796 GB, free: 212.4 MB / 0.67 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002515/1.319, allocations: 179.3 kB / 0.8798 GB, free: 212.3 MB / 0.67 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001728/1.32, allocations: 60.05 kB / 0.8798 GB, free: 212.3 MB / 0.67 GB
Warning: The initial conditions are over specified. The following 2 initial equations are redundant, so they are removed from the initialization sytem:
         IEH.volTop.dynBal.medium.p = IEH.volTop.dynBal.p_start
         IEH.volBot.dynBal.medium.p = IEH.volBot.dynBal.p_start.
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 18
 * 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 (143):
 * Single equations (assignments): 141
 * 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: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 2 {1 2,1 2}
Notification: Performance of prepare postOptimizeDAE: time 0.001114/1.321, allocations: 459.3 kB / 0.8803 GB, free: 212 MB / 0.67 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003783/1.321, allocations: 194.1 kB / 0.8805 GB, free: 211.9 MB / 0.67 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004828/1.326, allocations: 2.016 MB / 0.8824 GB, free: 211.1 MB / 0.67 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.31e-05/1.326, allocations: 10.44 kB / 0.8824 GB, free: 211.1 MB / 0.67 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 4.138e-06/1.326, allocations: 3.062 kB / 0.8824 GB, free: 211.1 MB / 0.67 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.003754/1.33, allocations: 1.795 MB / 0.8842 GB, free: 210.4 MB / 0.67 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01014/1.34, allocations: 5.213 MB / 0.8893 GB, free: 207.9 MB / 0.67 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.105e-05/1.34, allocations: 11.12 kB / 0.8893 GB, free: 207.9 MB / 0.67 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001689/1.342, allocations: 335.5 kB / 0.8896 GB, free: 207.9 MB / 0.67 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.001002/1.343, allocations: 205.8 kB / 0.8898 GB, free: 207.8 MB / 0.67 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001456/1.343, allocations: 55.61 kB / 0.8899 GB, free: 207.8 MB / 0.67 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.003719/1.347, allocations: 3.288 MB / 0.8931 GB, free: 204.8 MB / 0.67 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.84e-05/1.347, allocations: 24.58 kB / 0.8931 GB, free: 204.8 MB / 0.67 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.006789/1.353, allocations: 3.176 MB / 0.8962 GB, free: 203.2 MB / 0.67 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001233/1.355, allocations: 436.4 kB / 0.8966 GB, free: 202.9 MB / 0.67 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000318/1.355, allocations: 39 kB / 0.8967 GB, free: 202.9 MB / 0.67 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001843/1.357, allocations: 170.7 kB / 0.8968 GB, free: 202.9 MB / 0.67 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002623/1.357, allocations: 122.1 kB / 0.8969 GB, free: 202.9 MB / 0.67 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001734/1.357, allocations: 67.53 kB / 0.897 GB, free: 202.8 MB / 0.67 GB
Notification: Performance of sorting global known variables: time 0.001919/1.359, allocations: 0.979 MB / 0.898 GB, free: 202.5 MB / 0.67 GB
Notification: Performance of sort global known variables: time 1.5e-07/1.359, allocations: 3.844 kB / 0.898 GB, free: 202.5 MB / 0.67 GB
Notification: Performance of remove unused functions: time 0.002735/1.362, allocations: 0.5113 MB / 0.8985 GB, free: 202.4 MB / 0.67 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 48
 * Number of states: 4 (IEH.volBot.dynBal.U,IEH.volBot.dynBal.mXi[1],IEH.volTop.dynBal.U,IEH.volTop.dynBal.mXi[1])
 * 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 (122):
 * Single equations (assignments): 120
 * 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: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 2 {1 3,1 3}
Notification: Performance of Backend phase and start with SimCode phase: time 0.00801/1.37, allocations: 3.962 MB / 0.9023 GB, free: 200.2 MB / 0.67 GB
Notification: Performance of simCode: created initialization part: time 0.004483/1.375, allocations: 1.841 MB / 0.9041 GB, free: 199.5 MB / 0.67 GB
Notification: Performance of simCode: created event and clocks part: time 1.401e-05/1.375, allocations: 2.031 kB / 0.9041 GB, free: 199.5 MB / 0.67 GB
Notification: Performance of simCode: created simulation system equations: time 0.002402/1.377, allocations: 1.081 MB / 0.9052 GB, free: 199 MB / 0.67 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.005656/1.383, allocations: 1.012 MB / 0.9062 GB, free: 198.7 MB / 0.67 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.02848/1.411, allocations: 12.29 MB / 0.9182 GB, free: 191.9 MB / 0.67 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001578/1.413, allocations: 1.481 MB / 0.9196 GB, free: 191 MB / 0.67 GB
Notification: Performance of simCode: alias equations: time 0.003244/1.416, allocations: 495.1 kB / 0.9201 GB, free: 190.9 MB / 0.67 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001301/1.417, allocations: 0.7572 MB / 0.9208 GB, free: 190.3 MB / 0.67 GB
Notification: Performance of SimCode: time 1.413e-06/1.417, allocations: 0 / 0.9208 GB, free: 190.3 MB / 0.67 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.08747/1.505, allocations: 54.55 MB / 0.9741 GB, free: 150.9 MB / 0.67 GB
Notification: Performance of buildModelFMU: configured platform static using cached values: time 0.0001496/1.505, allocations: 237.3 kB / 0.9743 GB, free: 150.7 MB / 0.67 GB
Notification: Performance of buildModelFMU: Generate platform static: time 3.496/5.001, allocations: 1.969 kB / 0.9743 GB, free: 150.7 MB / 0.67 GB
(rm -f IDEAS_dev_IDEAS.Airflow.AHU.Validation.IehWinter.pipe ; mkfifo IDEAS_dev_IDEAS.Airflow.AHU.Validation.IehWinter.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Airflow.AHU.Validation.IehWinter.pipe >> ../files/IDEAS_dev_IDEAS.Airflow.AHU.Validation.IehWinter.sim & /home/hudson/saved_omc/OMSimulator/install/linux/bin/OMSimulator  --tempDir=temp_IDEAS_dev_IDEAS_Airflow_AHU_Validation_IehWinter_fmu --startTime=0 --stopTime=500 --timeout=50 --tolerance=1e-06 IDEAS_dev_IDEAS_Airflow_AHU_Validation_IehWinter.fmu > IDEAS_dev_IDEAS.Airflow.AHU.Validation.IehWinter.pipe 2>&1)
Environment - environmentSimulation: