Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_latest_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/IBPSA 4.0.0-master/package.mo", uses=false)
Using package IBPSA with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.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(IBPSA.Fluid.Interfaces.Examples.ReverseFlowHumidifier,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Fluid.Interfaces.Examples.ReverseFlowHumidifier")
translateModel(IBPSA.Fluid.Interfaces.Examples.ReverseFlowHumidifier,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_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.001007/0.001007, allocations: 112.6 kB / 17.03 MB, free: 5.656 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.001041/0.001041, allocations: 190.9 kB / 17.97 MB, free: 5.062 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.417/1.417, allocations: 222.9 MB / 241.7 MB, free: 15.14 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo): time 0.7047/0.7047, allocations: 115.1 MB / 406.9 MB, free: 6.398 MB / 318.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001197/0.001197, allocations: 63.91 kB / 494.8 MB, free: 15.88 MB / 414.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3354/0.3366, allocations: 76.15 MB / 0.5576 GB, free: 36.66 MB / 446.1 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.Interfaces.Examples.ReverseFlowHumidifier): time 0.5636/0.9003, allocations: 274.6 MB / 0.8257 GB, free: 16.05 MB / 0.5762 GB
Notification: Performance of NFInst.instExpressions: time 0.01962/0.9199, allocations: 17.36 MB / 0.8427 GB, free: 15.09 MB / 0.5762 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003314/0.9233, allocations: 71.88 kB / 0.8427 GB, free: 15.08 MB / 0.5762 GB
Notification: Performance of NFTyping.typeComponents: time 0.002823/0.9261, allocations: 1.167 MB / 0.8439 GB, free: 14.56 MB / 0.5762 GB
Notification: Performance of NFTyping.typeBindings: time 0.007697/0.9339, allocations: 3.099 MB / 0.8469 GB, free: 13.19 MB / 0.5762 GB
Notification: Performance of NFTyping.typeClassSections: time 0.005197/0.9391, allocations: 2.206 MB / 0.8491 GB, free: 11.96 MB / 0.5762 GB
Notification: Performance of NFFlatten.flatten: time 0.006596/0.9457, allocations: 4.852 MB / 0.8538 GB, free: 10.06 MB / 0.5762 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.002094/0.9478, allocations: 1.764 MB / 0.8555 GB, free: 8.984 MB / 0.5762 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.005431/0.9532, allocations: 2.42 MB / 0.8579 GB, free: 7.949 MB / 0.5762 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.002822/0.9561, allocations: 1.54 MB / 0.8594 GB, free: 6.879 MB / 0.5762 GB
Notification: Performance of NFPackage.collectConstants: time 0.0002738/0.9563, allocations: 192 kB / 0.8596 GB, free: 6.691 MB / 0.5762 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.006273/0.9626, allocations: 3.008 MB / 0.8625 GB, free: 4.281 MB / 0.5762 GB
Notification: Performance of NFScalarize.scalarize: time 0.0005602/0.9632, allocations: 0.7296 MB / 0.8632 GB, free: 3.57 MB / 0.5762 GB
Notification: Performance of NFVerifyModel.verify: time 0.001177/0.9644, allocations: 1.12 MB / 0.8643 GB, free: 2.469 MB / 0.5762 GB
Notification: Performance of NFConvertDAE.convert: time 0.005051/0.9694, allocations: 3.831 MB / 0.868 GB, free: 14.84 MB / 0.5919 GB
Notification: Performance of FrontEnd - DAE generated: time 5.911e-06/0.9695, allocations: 0 / 0.868 GB, free: 14.84 MB / 0.5919 GB
Notification: Performance of FrontEnd: time 1.503e-06/0.9695, allocations: 0 / 0.868 GB, free: 14.84 MB / 0.5919 GB
Notification: Performance of Transformations before backend: time 2.385e-05/0.9695, allocations: 4 kB / 0.8681 GB, free: 14.84 MB / 0.5919 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.00404/0.9736, allocations: 2.424 MB / 0.8704 GB, free: 12.38 MB / 0.5919 GB
Notification: Performance of prepare preOptimizeDAE: time 4.083e-05/0.9736, allocations: 8.031 kB / 0.8704 GB, free: 12.37 MB / 0.5919 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004266/0.9779, allocations: 0.6453 MB / 0.8711 GB, free: 11.72 MB / 0.5919 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.00237/0.9803, allocations: 1.41 MB / 0.8724 GB, free: 10.32 MB / 0.5919 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 8.39e-05/0.9804, allocations: 105.7 kB / 0.8725 GB, free: 10.22 MB / 0.5919 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002004/0.9806, allocations: 132 kB / 0.8727 GB, free: 10.09 MB / 0.5919 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002447/0.983, allocations: 1.57 MB / 0.8742 GB, free: 8.457 MB / 0.5919 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.092e-05/0.9831, allocations: 0 / 0.8742 GB, free: 8.457 MB / 0.5919 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001247/0.9832, allocations: 65.81 kB / 0.8743 GB, free: 8.395 MB / 0.5919 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.793e-05/0.9833, allocations: 46.44 kB / 0.8743 GB, free: 8.348 MB / 0.5919 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002031/0.9853, allocations: 1.269 MB / 0.8755 GB, free: 7.082 MB / 0.5919 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.008414/0.9937, allocations: 7.205 MB / 0.8826 GB, free: 15.44 MB / 0.6075 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.001097/0.9948, allocations: 0.6493 MB / 0.8832 GB, free: 14.79 MB / 0.6075 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0005257/0.9954, allocations: 376 kB / 0.8836 GB, free: 14.42 MB / 0.6075 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0002041/0.9956, allocations: 101.7 kB / 0.8837 GB, free: 14.3 MB / 0.6075 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.593e-05/0.9956, allocations: 43.12 kB / 0.8837 GB, free: 14.25 MB / 0.6075 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.0005217/0.9962, allocations: 106.1 kB / 0.8838 GB, free: 14.15 MB / 0.6075 GB
Notification: Performance of pre-optimization done (n=67): time 2.565e-06/0.9962, allocations: 0 / 0.8838 GB, free: 14.15 MB / 0.6075 GB
Notification: Performance of matching and sorting (n=67): time 0.001838/0.998, allocations: 1.012 MB / 0.8848 GB, free: 13.14 MB / 0.6075 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.77e-05/0.9981, allocations: 59.97 kB / 0.8849 GB, free: 13.07 MB / 0.6075 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001542/0.9996, allocations: 1.343 MB / 0.8862 GB, free: 11.71 MB / 0.6075 GB
Notification: Performance of collectPreVariables (initialization): time 7.319e-05/0.9997, allocations: 45.7 kB / 0.8862 GB, free: 11.66 MB / 0.6075 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0005471/1, allocations: 0.7773 MB / 0.887 GB, free: 10.88 MB / 0.6075 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002083/1, allocations: 242.5 kB / 0.8872 GB, free: 10.65 MB / 0.6075 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002964/1.001, allocations: 198.5 kB / 0.8874 GB, free: 10.45 MB / 0.6075 GB
Notification: Performance of setup shared object (initialization): time 0.0001224/1.001, allocations: 345.9 kB / 0.8877 GB, free: 10.11 MB / 0.6075 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.000546/1.001, allocations: 356.6 kB / 0.8881 GB, free: 9.754 MB / 0.6075 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0007731/1.002, allocations: 0.689 MB / 0.8887 GB, free: 8.93 MB / 0.6075 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001216/1.003, allocations: 0.9537 MB / 0.8897 GB, free: 7.906 MB / 0.6075 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.669e-06/1.003, allocations: 3.938 kB / 0.8897 GB, free: 7.902 MB / 0.6075 GB
Notification: Performance of matching and sorting (n=123) (initialization): time 0.001763/1.005, allocations: 1.16 MB / 0.8908 GB, free: 6.781 MB / 0.6075 GB
Notification: Performance of prepare postOptimizeDAE: time 1.997e-05/1.005, allocations: 8 kB / 0.8908 GB, free: 6.773 MB / 0.6075 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.245e-05/1.005, allocations: 8 kB / 0.8908 GB, free: 6.766 MB / 0.6075 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.348e-05/1.005, allocations: 12 kB / 0.8908 GB, free: 6.754 MB / 0.6075 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00087/1.006, allocations: 204.9 kB / 0.891 GB, free: 6.566 MB / 0.6075 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.891e-05/1.006, allocations: 18.98 kB / 0.891 GB, free: 6.551 MB / 0.6075 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001171/1.007, allocations: 45.02 kB / 0.8911 GB, free: 6.508 MB / 0.6075 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.034e-05/1.008, allocations: 52.11 kB / 0.8911 GB, free: 6.457 MB / 0.6075 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001036/1.009, allocations: 0.6854 MB / 0.8918 GB, free: 5.766 MB / 0.6075 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0007934/1.009, allocations: 0.6737 MB / 0.8925 GB, free: 4.957 MB / 0.6075 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001234/1.011, allocations: 0.9539 MB / 0.8934 GB, free: 3.938 MB / 0.6075 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 3.948e-06/1.011, allocations: 0 / 0.8934 GB, free: 3.938 MB / 0.6075 GB
Notification: Performance of matching and sorting (n=123) (initialization_lambda0): time 0.001728/1.012, allocations: 1.147 MB / 0.8945 GB, free: 2.824 MB / 0.6075 GB
Notification: Performance of prepare postOptimizeDAE: time 1.343e-05/1.012, allocations: 8 kB / 0.8945 GB, free: 2.816 MB / 0.6075 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.656e-06/1.012, allocations: 8 kB / 0.8945 GB, free: 2.809 MB / 0.6075 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.699e-05/1.012, allocations: 12 kB / 0.8945 GB, free: 2.797 MB / 0.6075 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0008315/1.013, allocations: 206.5 kB / 0.8947 GB, free: 2.609 MB / 0.6075 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.458e-05/1.013, allocations: 14.62 kB / 0.8947 GB, free: 2.598 MB / 0.6075 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001166/1.014, allocations: 62.14 kB / 0.8948 GB, free: 2.539 MB / 0.6075 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.955e-05/1.015, allocations: 36 kB / 0.8948 GB, free: 2.504 MB / 0.6075 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.0002576/1.015, allocations: 252 kB / 0.8951 GB, free: 2.266 MB / 0.6075 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002202/1.015, allocations: 150.1 kB / 0.8952 GB, free: 2.117 MB / 0.6075 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001386/1.016, allocations: 0.8342 MB / 0.896 GB, free: 1.273 MB / 0.6075 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 7.333e-06/1.016, allocations: 4 kB / 0.896 GB, free: 1.27 MB / 0.6075 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 5.731e-06/1.016, allocations: 4 kB / 0.896 GB, free: 1.266 MB / 0.6075 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0009697/1.017, allocations: 0.7887 MB / 0.8968 GB, free: 440 kB / 0.6075 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.003354/1.021, allocations: 2.308 MB / 0.8991 GB, free: 14.07 MB / 0.6231 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.26e-06/1.021, allocations: 3.938 kB / 0.8991 GB, free: 14.07 MB / 0.6231 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0008184/1.022, allocations: 162.3 kB / 0.8992 GB, free: 13.92 MB / 0.6231 GB
Notification: Performance of postOpt tearingSystem (simulation): time 1.041e-05/1.022, allocations: 4 kB / 0.8992 GB, free: 13.91 MB / 0.6231 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 5.634e-05/1.022, allocations: 23.98 kB / 0.8993 GB, free: 13.89 MB / 0.6231 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 5.901e-06/1.022, allocations: 4.188 kB / 0.8993 GB, free: 13.89 MB / 0.6231 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.876e-06/1.022, allocations: 7 kB / 0.8993 GB, free: 13.88 MB / 0.6231 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.001701/1.023, allocations: 1.253 MB / 0.9005 GB, free: 12.6 MB / 0.6231 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.000606/1.024, allocations: 327.1 kB / 0.9008 GB, free: 12.26 MB / 0.6231 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001855/1.024, allocations: 16 kB / 0.9008 GB, free: 12.24 MB / 0.6231 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0008503/1.025, allocations: 38.41 kB / 0.9009 GB, free: 12.21 MB / 0.6231 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 7.7e-05/1.025, allocations: 36.52 kB / 0.9009 GB, free: 12.17 MB / 0.6231 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 7.38e-05/1.025, allocations: 35.97 kB / 0.9009 GB, free: 12.14 MB / 0.6231 GB
Notification: Performance of sorting global known variables: time 0.001147/1.026, allocations: 0.9083 MB / 0.9018 GB, free: 11.23 MB / 0.6231 GB
Notification: Performance of sort global known variables: time 1.51e-07/1.026, allocations: 0 / 0.9018 GB, free: 11.23 MB / 0.6231 GB
Notification: Performance of remove unused functions: time 0.001731/1.028, allocations: 0.834 MB / 0.9026 GB, free: 10.39 MB / 0.6231 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.0005059/1.029, allocations: 267.5 kB / 0.9029 GB, free: 10.16 MB / 0.6231 GB
Notification: Performance of simCode: created initialization part: time 0.002045/1.031, allocations: 1.342 MB / 0.9042 GB, free: 8.871 MB / 0.6231 GB
Notification: Performance of simCode: created event and clocks part: time 3.987e-06/1.031, allocations: 0 / 0.9042 GB, free: 8.871 MB / 0.6231 GB
Notification: Performance of simCode: created simulation system equations: time 0.0004606/1.031, allocations: 346.8 kB / 0.9045 GB, free: 8.543 MB / 0.6231 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.00315/1.034, allocations: 0.8382 MB / 0.9053 GB, free: 7.746 MB / 0.6231 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.004306/1.039, allocations: 2.894 MB / 0.9082 GB, free: 4.816 MB / 0.6231 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001023/1.04, allocations: 1.344 MB / 0.9095 GB, free: 3.441 MB / 0.6231 GB
Notification: Performance of simCode: alias equations: time 0.001399/1.041, allocations: 420.3 kB / 0.9099 GB, free: 3.027 MB / 0.6231 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.000293/1.041, allocations: 115.4 kB / 0.91 GB, free: 2.914 MB / 0.6231 GB
Notification: Performance of SimCode: time 3.6e-07/1.041, allocations: 0 / 0.91 GB, free: 2.914 MB / 0.6231 GB
Notification: Performance of Templates: time 0.05138/1.093, allocations: 29.03 MB / 0.9383 GB, free: 6.32 MB / 0.6544 GB
make -j1 -f IBPSA_latest_IBPSA.Fluid.Interfaces.Examples.ReverseFlowHumidifier.makefile
(rm -f IBPSA_latest_IBPSA.Fluid.Interfaces.Examples.ReverseFlowHumidifier.pipe ; mkfifo IBPSA_latest_IBPSA.Fluid.Interfaces.Examples.ReverseFlowHumidifier.pipe ; head -c 1048576 < IBPSA_latest_IBPSA.Fluid.Interfaces.Examples.ReverseFlowHumidifier.pipe >> ../files/IBPSA_latest_IBPSA.Fluid.Interfaces.Examples.ReverseFlowHumidifier.sim & ./IBPSA_latest_IBPSA.Fluid.Interfaces.Examples.ReverseFlowHumidifier  -abortSlowSimulation -alarm=480 -s gbode -lv LOG_STATS > IBPSA_latest_IBPSA.Fluid.Interfaces.Examples.ReverseFlowHumidifier.pipe 2>&1)