Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr BuildSysPro_BuildSysPro.IBPSA.Fluid.Interfaces.Examples.ReverseFlowHumidifier.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/BuildSysPro 3.6.0/package.mo", uses=false)
Using package BuildSysPro with version 3.5.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.6.0/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(BuildSysPro.IBPSA.Fluid.Interfaces.Examples.ReverseFlowHumidifier,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="BuildSysPro_BuildSysPro.IBPSA.Fluid.Interfaces.Examples.ReverseFlowHumidifier")
translateModel(BuildSysPro.IBPSA.Fluid.Interfaces.Examples.ReverseFlowHumidifier,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="BuildSysPro_BuildSysPro.IBPSA.Fluid.Interfaces.Examples.ReverseFlowHumidifier")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001077/0.001077, allocations: 97.64 kB / 15.36 MB, free: 0.7344 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.009302/0.009302, allocations: 170.1 kB / 16.27 MB, free: 6.652 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.374/1.374, allocations: 223.3 MB / 240.3 MB, free: 5.34 MB / 190.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.6.0/Building/BuildingEnvelope/HeatTransfer/package.mo:2:1-40:17:writable] Warning: Soil_case_nappe was referenced in the package.order file, but was not found in package.mo, Soil_case_nappe/package.mo or Soil_case_nappe.mo.
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.6.0/package.mo): time 1.023/1.023, allocations: 143.2 MB / 434.6 MB, free: 13.7 MB / 350.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.0005165/0.0005165, allocations: 12 kB / 0.5164 GB, free: 11.12 MB / 430.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2041/0.2046, allocations: 83.41 MB / 0.5978 GB, free: 7.684 MB / 0.4981 GB
Notification: Performance of NFInst.instantiate(BuildSysPro.IBPSA.Fluid.Interfaces.Examples.ReverseFlowHumidifier): time 1.043/1.248, allocations: 269 MB / 0.8606 GB, free: 16.99 MB / 0.67 GB
Notification: Performance of NFInst.instExpressions: time 0.0206/1.268, allocations: 17.29 MB / 0.8774 GB, free: 16.88 MB / 0.67 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.00275/1.271, allocations: 56.84 kB / 0.8775 GB, free: 16.88 MB / 0.67 GB
Notification: Performance of NFTyping.typeComponents: time 0.00299/1.274, allocations: 0.9932 MB / 0.8785 GB, free: 16.86 MB / 0.67 GB
Notification: Performance of NFTyping.typeBindings: time 0.008472/1.283, allocations: 2.933 MB / 0.8813 GB, free: 16.72 MB / 0.67 GB
Notification: Performance of NFTyping.typeClassSections: time 0.005656/1.288, allocations: 2.02 MB / 0.8833 GB, free: 16.65 MB / 0.67 GB
Notification: Performance of NFFlatten.flatten: time 0.008119/1.296, allocations: 6.75 MB / 0.8899 GB, free: 16.65 MB / 0.67 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.002695/1.299, allocations: 1.432 MB / 0.8913 GB, free: 16.48 MB / 0.67 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.006463/1.306, allocations: 2.067 MB / 0.8933 GB, free: 16.45 MB / 0.67 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.004261/1.31, allocations: 1.522 MB / 0.8948 GB, free: 16.45 MB / 0.67 GB
Notification: Performance of NFPackage.collectConstants: time 0.0006164/1.311, allocations: 74.25 kB / 0.8949 GB, free: 16.45 MB / 0.67 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.008918/1.319, allocations: 3.401 MB / 0.8982 GB, free: 16.41 MB / 0.67 GB
Notification: Performance of NFScalarize.scalarize: time 0.001591/1.321, allocations: 0.606 MB / 0.8988 GB, free: 16.41 MB / 0.67 GB
Notification: Performance of NFVerifyModel.verify: time 0.002455/1.324, allocations: 0.9952 MB / 0.8998 GB, free: 16.38 MB / 0.67 GB
Notification: Performance of NFConvertDAE.convert: time 0.009147/1.333, allocations: 3.989 MB / 0.9037 GB, free: 16.18 MB / 0.67 GB
Notification: Performance of FrontEnd - DAE generated: time 6.432e-06/1.333, allocations: 0 / 0.9037 GB, free: 16.18 MB / 0.67 GB
Notification: Performance of FrontEnd: time 3.086e-06/1.333, allocations: 1.094 kB / 0.9037 GB, free: 16.18 MB / 0.67 GB
Notification: Performance of Transformations before backend: time 8.294e-05/1.333, allocations: 4 kB / 0.9037 GB, free: 16.18 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: 324
 * Number of variables: 324
Notification: Performance of Generate backend data structure: time 0.005607/1.339, allocations: 2.035 MB / 0.9056 GB, free: 15.04 MB / 0.67 GB
Notification: Performance of prepare preOptimizeDAE: time 4.707e-05/1.339, allocations: 13.69 kB / 0.9057 GB, free: 15.04 MB / 0.67 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004813/1.343, allocations: 0.6525 MB / 0.9063 GB, free: 14.92 MB / 0.67 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002812/1.346, allocations: 1.337 MB / 0.9076 GB, free: 14.49 MB / 0.67 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001375/1.346, allocations: 102.5 kB / 0.9077 GB, free: 14.49 MB / 0.67 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002666/1.347, allocations: 140.7 kB / 0.9078 GB, free: 14.48 MB / 0.67 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002841/1.35, allocations: 1.569 MB / 0.9094 GB, free: 14.29 MB / 0.67 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.63e-05/1.35, allocations: 7.953 kB / 0.9094 GB, free: 14.29 MB / 0.67 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001522/1.35, allocations: 61.12 kB / 0.9094 GB, free: 14.29 MB / 0.67 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 6.424e-05/1.35, allocations: 46.83 kB / 0.9095 GB, free: 14.28 MB / 0.67 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002183/1.352, allocations: 1.268 MB / 0.9107 GB, free: 14.27 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.009003/1.361, allocations: 7.232 MB / 0.9178 GB, free: 10.38 MB / 0.67 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.001194/1.362, allocations: 0.6497 MB / 0.9184 GB, free: 10.35 MB / 0.67 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.000501/1.363, allocations: 372 kB / 0.9188 GB, free: 10.34 MB / 0.67 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001953/1.363, allocations: 110.5 kB / 0.9189 GB, free: 10.24 MB / 0.67 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.104e-05/1.363, allocations: 48.41 kB / 0.9189 GB, free: 10.2 MB / 0.67 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.001118/1.364, allocations: 144.5 kB / 0.9191 GB, free: 10.15 MB / 0.67 GB
Notification: Performance of pre-optimization done (n=67): time 2.746e-06/1.364, allocations: 0 / 0.9191 GB, free: 10.15 MB / 0.67 GB
Notification: Performance of matching and sorting (n=67): time 0.00193/1.366, allocations: 1.015 MB / 0.92 GB, free: 10.03 MB / 0.67 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 2.966e-05/1.366, allocations: 61.19 kB / 0.9201 GB, free: 9.965 MB / 0.67 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001601/1.368, allocations: 1.346 MB / 0.9214 GB, free: 9.641 MB / 0.67 GB
Notification: Performance of collectPreVariables (initialization): time 9.281e-05/1.368, allocations: 42.61 kB / 0.9215 GB, free: 9.609 MB / 0.67 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0004201/1.368, allocations: 0.7753 MB / 0.9222 GB, free: 9.234 MB / 0.67 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001699/1.368, allocations: 240 kB / 0.9224 GB, free: 9.062 MB / 0.67 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 9.89e-05/1.369, allocations: 96.39 kB / 0.9225 GB, free: 9.031 MB / 0.67 GB
Notification: Performance of setup shared object (initialization): time 6.148e-05/1.369, allocations: 340.6 kB / 0.9229 GB, free: 8.715 MB / 0.67 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0004618/1.369, allocations: 353.1 kB / 0.9232 GB, free: 8.668 MB / 0.67 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.000616/1.37, allocations: 0.6741 MB / 0.9239 GB, free: 8.23 MB / 0.67 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001056/1.371, allocations: 0.9558 MB / 0.9248 GB, free: 7.918 MB / 0.67 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.49e-06/1.371, allocations: 0 / 0.9248 GB, free: 7.918 MB / 0.67 GB
Notification: Performance of matching and sorting (n=123) (initialization): time 0.001594/1.372, allocations: 1.157 MB / 0.9259 GB, free: 7.707 MB / 0.67 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001135/1.372, allocations: 293.7 kB / 0.9262 GB, free: 7.375 MB / 0.67 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.426e-05/1.373, allocations: 8.781 kB / 0.9262 GB, free: 7.375 MB / 0.67 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.725e-05/1.373, allocations: 16.12 kB / 0.9262 GB, free: 7.371 MB / 0.67 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0008079/1.373, allocations: 205.3 kB / 0.9264 GB, free: 7.348 MB / 0.67 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.553e-05/1.373, allocations: 14.19 kB / 0.9264 GB, free: 7.348 MB / 0.67 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001806/1.375, allocations: 141.6 kB / 0.9266 GB, free: 7.297 MB / 0.67 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 7.858e-05/1.375, allocations: 39.03 kB / 0.9266 GB, free: 7.297 MB / 0.67 GB
Notification: Performance of prepare postOptimizeDAE: time 9.298e-06/1.375, allocations: 8.75 kB / 0.9266 GB, free: 7.293 MB / 0.67 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.001285/1.377, allocations: 0.9855 MB / 0.9276 GB, free: 7.188 MB / 0.67 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.817e-06/1.377, allocations: 5.906 kB / 0.9276 GB, free: 7.188 MB / 0.67 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.162e-05/1.377, allocations: 20 kB / 0.9276 GB, free: 7.18 MB / 0.67 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0007383/1.377, allocations: 209.1 kB / 0.9278 GB, free: 7.156 MB / 0.67 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.305e-05/1.377, allocations: 15.66 kB / 0.9278 GB, free: 7.156 MB / 0.67 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001668/1.379, allocations: 146 kB / 0.928 GB, free: 7.102 MB / 0.67 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.831e-05/1.379, allocations: 38.16 kB / 0.928 GB, free: 7.102 MB / 0.67 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 30
 * 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 (121):
 * Single equations (assignments): 119
 * Array equations: 2
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.0007631/1.38, allocations: 0.4895 MB / 0.9285 GB, free: 6.879 MB / 0.67 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002159/1.38, allocations: 147.3 kB / 0.9286 GB, free: 6.805 MB / 0.67 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001245/1.381, allocations: 0.8276 MB / 0.9294 GB, free: 6.629 MB / 0.67 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 6.773e-06/1.381, allocations: 8.906 kB / 0.9294 GB, free: 6.629 MB / 0.67 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 7.694e-06/1.381, allocations: 5.297 kB / 0.9294 GB, free: 6.625 MB / 0.67 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0007975/1.382, allocations: 0.7894 MB / 0.9302 GB, free: 6.312 MB / 0.67 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.003247/1.385, allocations: 2.302 MB / 0.9324 GB, free: 5.488 MB / 0.67 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.561e-06/1.386, allocations: 3.344 kB / 0.9325 GB, free: 5.488 MB / 0.67 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.000791/1.386, allocations: 159.3 kB / 0.9326 GB, free: 5.469 MB / 0.67 GB
Notification: Performance of postOpt tearingSystem (simulation): time 9.147e-06/1.386, allocations: 3.312 kB / 0.9326 GB, free: 5.469 MB / 0.67 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 5.131e-05/1.386, allocations: 24.48 kB / 0.9326 GB, free: 5.465 MB / 0.67 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 7.383e-06/1.386, allocations: 10.56 kB / 0.9326 GB, free: 5.461 MB / 0.67 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.346e-06/1.386, allocations: 2.781 kB / 0.9326 GB, free: 5.461 MB / 0.67 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.001595/1.388, allocations: 1.253 MB / 0.9339 GB, free: 5.078 MB / 0.67 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.000669/1.389, allocations: 326.8 kB / 0.9342 GB, free: 4.871 MB / 0.67 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001973/1.389, allocations: 16.25 kB / 0.9342 GB, free: 4.871 MB / 0.67 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001072/1.39, allocations: 98.81 kB / 0.9343 GB, free: 4.832 MB / 0.67 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 8.675e-05/1.39, allocations: 52.41 kB / 0.9343 GB, free: 4.812 MB / 0.67 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 6.944e-05/1.39, allocations: 29.73 kB / 0.9344 GB, free: 4.809 MB / 0.67 GB
Notification: Performance of sorting global known variables: time 0.001112/1.391, allocations: 0.9099 MB / 0.9353 GB, free: 4.555 MB / 0.67 GB
Notification: Performance of sort global known variables: time 1.9e-07/1.391, allocations: 0 / 0.9353 GB, free: 4.555 MB / 0.67 GB
Notification: Performance of remove unused functions: time 0.002172/1.393, allocations: 0.8401 MB / 0.9361 GB, free: 4.453 MB / 0.67 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 7
 * Number of states: 6 (humBac.vol.dynBal.medium.Xi[1],humBac.vol.dynBal.U,humBac.vol.dynBal.m,humFor.vol.dynBal.medium.Xi[1],humFor.vol.dynBal.U,humFor.vol.dynBal.m)
 * 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 (71):
 * Single equations (assignments): 71
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.000512/1.394, allocations: 265.2 kB / 0.9363 GB, free: 4.312 MB / 0.67 GB
Notification: Performance of simCode: created initialization part: time 0.001853/1.396, allocations: 1.333 MB / 0.9376 GB, free: 4.156 MB / 0.67 GB
Notification: Performance of simCode: created event and clocks part: time 5.13e-06/1.396, allocations: 3.594 kB / 0.9376 GB, free: 4.156 MB / 0.67 GB
Notification: Performance of simCode: created simulation system equations: time 0.0004031/1.396, allocations: 347.6 kB / 0.938 GB, free: 4.117 MB / 0.67 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.004253/1.401, allocations: 0.8357 MB / 0.9388 GB, free: 3.848 MB / 0.67 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.004617/1.405, allocations: 3.641 MB / 0.9423 GB, free: 1.609 MB / 0.67 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0007045/1.406, allocations: 1.345 MB / 0.9437 GB, free: 0.6562 MB / 0.67 GB
Notification: Performance of simCode: alias equations: time 0.001929/1.408, allocations: 422.5 kB / 0.9441 GB, free: 468 kB / 0.67 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.000332/1.408, allocations: 113.2 kB / 0.9442 GB, free: 456 kB / 0.67 GB
Notification: Performance of SimCode: time 1.193e-06/1.408, allocations: 2.531 kB / 0.9442 GB, free: 456 kB / 0.67 GB
Notification: Performance of Templates: time 0.04675/1.455, allocations: 28.21 MB / 0.9717 GB, free: 7.797 MB / 0.7012 GB
make -j1 -f BuildSysPro_BuildSysPro.IBPSA.Fluid.Interfaces.Examples.ReverseFlowHumidifier.makefile
(rm -f BuildSysPro_BuildSysPro.IBPSA.Fluid.Interfaces.Examples.ReverseFlowHumidifier.pipe ; mkfifo BuildSysPro_BuildSysPro.IBPSA.Fluid.Interfaces.Examples.ReverseFlowHumidifier.pipe ; head -c 1048576 < BuildSysPro_BuildSysPro.IBPSA.Fluid.Interfaces.Examples.ReverseFlowHumidifier.pipe >> ../files/BuildSysPro_BuildSysPro.IBPSA.Fluid.Interfaces.Examples.ReverseFlowHumidifier.sim & ./BuildSysPro_BuildSysPro.IBPSA.Fluid.Interfaces.Examples.ReverseFlowHumidifier  -abortSlowSimulation -alarm=480 -lv LOG_STATS > BuildSysPro_BuildSysPro.IBPSA.Fluid.Interfaces.Examples.ReverseFlowHumidifier.pipe 2>&1)