Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr BuildingSystems_BuildingSystems.Fluid.Interfaces.Examples.ReverseFlowMassExchanger.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/NcDataReader2 2.5.1-master/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems 2.0.0-master/package.mo", uses=false)
Using package BuildingSystems with version 2.0.0-beta (/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems 2.0.0-master/package.mo)
Using package NcDataReader2 with version 2.5.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 2.5.1-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(BuildingSystems.Fluid.Interfaces.Examples.ReverseFlowMassExchanger,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="BuildingSystems_BuildingSystems.Fluid.Interfaces.Examples.ReverseFlowMassExchanger")
translateModel(BuildingSystems.Fluid.Interfaces.Examples.ReverseFlowMassExchanger,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="BuildingSystems_BuildingSystems.Fluid.Interfaces.Examples.ReverseFlowMassExchanger")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001298/0.001299, allocations: 110.7 kB / 16.42 MB, free: 6.465 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.001359/0.001359, allocations: 190.7 kB / 17.35 MB, free: 5.715 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.273/1.273, allocations: 222.9 MB / 241 MB, free: 15.09 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 2.5.1-master/package.mo): time 0.002063/0.002063, allocations: 299 kB / 291.5 MB, free: 14.43 MB / 238.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems 2.0.0-master/package.mo): time 0.9183/0.9183, allocations: 169.3 MB / 0.499 GB, free: 4.43 MB / 382.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001748/0.001748, allocations: 99.84 kB / 0.6821 GB, free: 6.977 MB / 494.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3701/0.3719, allocations: 86.98 MB / 0.7671 GB, free: 4.094 MB / 0.5294 GB
Notification: Performance of NFInst.instantiate(BuildingSystems.Fluid.Interfaces.Examples.ReverseFlowMassExchanger): time 0.6257/0.9976, allocations: 328.4 MB / 1.088 GB, free: 12.59 MB / 0.7325 GB
Notification: Performance of NFInst.instExpressions: time 0.03387/1.032, allocations: 30.06 MB / 1.117 GB, free: 2.039 MB / 0.7481 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003425/1.035, allocations: 96.19 kB / 1.117 GB, free: 1.98 MB / 0.7481 GB
Notification: Performance of NFTyping.typeComponents: time 0.004907/1.04, allocations: 2.094 MB / 1.119 GB, free: 448 kB / 0.7481 GB
Notification: Performance of NFTyping.typeBindings: time 0.01194/1.052, allocations: 4.988 MB / 1.124 GB, free: 11.43 MB / 0.7637 GB
Notification: Performance of NFTyping.typeClassSections: time 0.008089/1.06, allocations: 3.652 MB / 1.128 GB, free: 7.789 MB / 0.7637 GB
Notification: Performance of NFFlatten.flatten: time 0.00882/1.069, allocations: 6.938 MB / 1.134 GB, free: 0.8281 MB / 0.7637 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.003976/1.073, allocations: 2.867 MB / 1.137 GB, free: 13.9 MB / 0.7794 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01165/1.085, allocations: 5.341 MB / 1.142 GB, free: 8.57 MB / 0.7794 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.004358/1.089, allocations: 2.441 MB / 1.145 GB, free: 6.129 MB / 0.7794 GB
Notification: Performance of NFPackage.collectConstants: time 0.0007278/1.09, allocations: 292 kB / 1.145 GB, free: 5.844 MB / 0.7794 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.00844/1.098, allocations: 4.809 MB / 1.15 GB, free: 1.023 MB / 0.7794 GB
Notification: Performance of NFScalarize.scalarize: time 0.001191/1.099, allocations: 1.067 MB / 1.151 GB, free: 15.95 MB / 0.795 GB
Notification: Performance of NFVerifyModel.verify: time 0.002176/1.101, allocations: 1.73 MB / 1.153 GB, free: 14.21 MB / 0.795 GB
Notification: Performance of NFConvertDAE.convert: time 0.009051/1.111, allocations: 5.761 MB / 1.158 GB, free: 8.438 MB / 0.795 GB
Notification: Performance of FrontEnd - DAE generated: time 5.01e-06/1.111, allocations: 0 / 1.158 GB, free: 8.438 MB / 0.795 GB
Notification: Performance of FrontEnd: time 1.413e-06/1.111, allocations: 0 / 1.158 GB, free: 8.438 MB / 0.795 GB
Notification: Performance of Transformations before backend: time 5.208e-05/1.111, allocations: 0 / 1.158 GB, free: 8.438 MB / 0.795 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 536
 * Number of variables: 536
Notification: Performance of Generate backend data structure: time 0.006873/1.118, allocations: 3.7 MB / 1.162 GB, free: 4.652 MB / 0.795 GB
Notification: Performance of prepare preOptimizeDAE: time 3.938e-05/1.118, allocations: 8.031 kB / 1.162 GB, free: 4.645 MB / 0.795 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.009847/1.127, allocations: 1.468 MB / 1.163 GB, free: 3.172 MB / 0.795 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.004004/1.131, allocations: 2.073 MB / 1.165 GB, free: 1.02 MB / 0.795 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001299/1.132, allocations: 172.1 kB / 1.165 GB, free: 0.8477 MB / 0.795 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.00034/1.132, allocations: 220 kB / 1.166 GB, free: 0.6328 MB / 0.795 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.005739/1.138, allocations: 3.041 MB / 1.169 GB, free: 13.46 MB / 0.8106 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.437e-05/1.138, allocations: 3.938 kB / 1.169 GB, free: 13.45 MB / 0.8106 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002421/1.138, allocations: 99.98 kB / 1.169 GB, free: 13.36 MB / 0.8106 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 7.859e-05/1.138, allocations: 84 kB / 1.169 GB, free: 13.27 MB / 0.8106 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.006494/1.145, allocations: 3.107 MB / 1.172 GB, free: 10.14 MB / 0.8106 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.01982/1.164, allocations: 14 MB / 1.186 GB, free: 11.04 MB / 0.8262 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.003856/1.168, allocations: 1.637 MB / 1.187 GB, free: 9.391 MB / 0.8262 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001652/1.17, allocations: 0.7773 MB / 1.188 GB, free: 8.613 MB / 0.8262 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.000571/1.171, allocations: 325.2 kB / 1.188 GB, free: 8.242 MB / 0.8262 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.567e-05/1.171, allocations: 51.5 kB / 1.188 GB, free: 8.18 MB / 0.8262 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.0009725/1.172, allocations: 202.1 kB / 1.188 GB, free: 7.98 MB / 0.8262 GB
Notification: Performance of pre-optimization done (n=110): time 3.156e-06/1.172, allocations: 0 / 1.188 GB, free: 7.98 MB / 0.8262 GB
Notification: Performance of matching and sorting (n=110): time 0.005561/1.177, allocations: 2.367 MB / 1.191 GB, free: 5.609 MB / 0.8262 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 2.941e-05/1.177, allocations: 64.41 kB / 1.191 GB, free: 5.535 MB / 0.8262 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003445/1.181, allocations: 2.509 MB / 1.193 GB, free: 3.008 MB / 0.8262 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001515/1.181, allocations: 61.7 kB / 1.193 GB, free: 2.941 MB / 0.8262 GB
Notification: Performance of collectInitialEqns (initialization): time 0.000887/1.182, allocations: 1.261 MB / 1.195 GB, free: 1.664 MB / 0.8262 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002798/1.182, allocations: 390.5 kB / 1.195 GB, free: 1.277 MB / 0.8262 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0005994/1.183, allocations: 379 kB / 1.195 GB, free: 0.8984 MB / 0.8262 GB
Notification: Performance of setup shared object (initialization): time 8.624e-05/1.183, allocations: 305.1 kB / 1.196 GB, free: 0.5977 MB / 0.8262 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002448/1.185, allocations: 0.9494 MB / 1.196 GB, free: 15.64 MB / 0.8419 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002839/1.188, allocations: 1.558 MB / 1.198 GB, free: 13.82 MB / 0.8419 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.004518/1.193, allocations: 2.236 MB / 1.2 GB, free: 11.39 MB / 0.8419 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.646e-06/1.193, allocations: 4 kB / 1.2 GB, free: 11.39 MB / 0.8419 GB
Notification: Performance of matching and sorting (n=210) (initialization): time 0.006334/1.199, allocations: 2.75 MB / 1.203 GB, free: 8.613 MB / 0.8419 GB
Notification: Performance of prepare postOptimizeDAE: time 6.026e-05/1.199, allocations: 77.83 kB / 1.203 GB, free: 8.527 MB / 0.8419 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.818e-05/1.199, allocations: 16 kB / 1.203 GB, free: 8.512 MB / 0.8419 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.793e-05/1.199, allocations: 24 kB / 1.203 GB, free: 8.488 MB / 0.8419 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002896/1.202, allocations: 0.5542 MB / 1.204 GB, free: 7.934 MB / 0.8419 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001216/1.203, allocations: 2.383 MB / 1.206 GB, free: 5.457 MB / 0.8419 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003133/1.206, allocations: 283.9 kB / 1.206 GB, free: 5.18 MB / 0.8419 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001725/1.206, allocations: 87.95 kB / 1.206 GB, free: 5.094 MB / 0.8419 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.003186/1.21, allocations: 1.382 MB / 1.208 GB, free: 3.707 MB / 0.8419 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.002777/1.212, allocations: 1.562 MB / 1.209 GB, free: 1.883 MB / 0.8419 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.004407/1.217, allocations: 2.221 MB / 1.211 GB, free: 15.47 MB / 0.8575 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 8.336e-06/1.217, allocations: 7.984 kB / 1.211 GB, free: 15.46 MB / 0.8575 GB
Notification: Performance of matching and sorting (n=210) (initialization_lambda0): time 0.006252/1.223, allocations: 2.742 MB / 1.214 GB, free: 12.7 MB / 0.8575 GB
Notification: Performance of prepare postOptimizeDAE: time 5.676e-05/1.223, allocations: 71.39 kB / 1.214 GB, free: 12.61 MB / 0.8575 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.539e-05/1.223, allocations: 12 kB / 1.214 GB, free: 12.6 MB / 0.8575 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.884e-05/1.223, allocations: 20.75 kB / 1.214 GB, free: 12.58 MB / 0.8575 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002381/1.226, allocations: 0.4993 MB / 1.215 GB, free: 12.08 MB / 0.8575 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.835e-05/1.226, allocations: 35.86 kB / 1.215 GB, free: 12.05 MB / 0.8575 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003184/1.229, allocations: 288.2 kB / 1.215 GB, free: 11.77 MB / 0.8575 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001585/1.229, allocations: 87.97 kB / 1.215 GB, free: 11.68 MB / 0.8575 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 59
 * Number of states: 0 ()
 * Number of discrete variables: 4 (masExcRev.i2_w,masExcRev.i1_w,masExcFor.i2_w,masExcFor.i1_w)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (208):
 * Single equations (assignments): 202
 * Array equations: 0
 * Algorithm blocks: 2
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 4
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 0 systems
 * Non-linear Jacobian (size): 4 systems
   {1, 1, 1, 1}
 * Without analytic Jacobian (size): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.0004756/1.23, allocations: 304.3 kB / 1.215 GB, free: 11.38 MB / 0.8575 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0004116/1.23, allocations: 256.8 kB / 1.215 GB, free: 11.12 MB / 0.8575 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004341/1.234, allocations: 1.847 MB / 1.217 GB, free: 9.262 MB / 0.8575 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.301e-05/1.234, allocations: 7.969 kB / 1.217 GB, free: 9.254 MB / 0.8575 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.466e-06/1.234, allocations: 0 / 1.217 GB, free: 9.254 MB / 0.8575 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0008628/1.235, allocations: 0.5172 MB / 1.218 GB, free: 8.715 MB / 0.8575 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003412/1.236, allocations: 20 kB / 1.218 GB, free: 8.695 MB / 0.8575 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002175/1.238, allocations: 178.9 kB / 1.218 GB, free: 8.523 MB / 0.8575 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001211/1.238, allocations: 64.84 kB / 1.218 GB, free: 8.457 MB / 0.8575 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.00454/1.242, allocations: 1.735 MB / 1.22 GB, free: 6.707 MB / 0.8575 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.005576/1.248, allocations: 2.798 MB / 1.222 GB, free: 3.887 MB / 0.8575 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.00156/1.25, allocations: 0.7144 MB / 1.223 GB, free: 3.176 MB / 0.8575 GB
Notification: Performance of sorting global known variables: time 0.002646/1.252, allocations: 1.735 MB / 1.225 GB, free: 1.438 MB / 0.8575 GB
Notification: Performance of Backend: time 3.3e-07/1.252, allocations: 0 / 1.225 GB, free: 1.438 MB / 0.8575 GB
Notification: Performance of simCode: created initialization part: time 0.009639/1.262, allocations: 3.905 MB / 1.229 GB, free: 13.51 MB / 0.8731 GB
Notification: Performance of SimCode: time 0.008352/1.27, allocations: 5.037 MB / 1.234 GB, free: 8.426 MB / 0.8731 GB
Notification: Performance of Templates: time 0.0973/1.368, allocations: 66.05 MB / 1.298 GB, free: 6.984 MB / 0.9356 GB
make -j1 -f BuildingSystems_BuildingSystems.Fluid.Interfaces.Examples.ReverseFlowMassExchanger.makefile
(rm -f BuildingSystems_BuildingSystems.Fluid.Interfaces.Examples.ReverseFlowMassExchanger.pipe ; mkfifo BuildingSystems_BuildingSystems.Fluid.Interfaces.Examples.ReverseFlowMassExchanger.pipe ; head -c 1048576 < BuildingSystems_BuildingSystems.Fluid.Interfaces.Examples.ReverseFlowMassExchanger.pipe >> ../files/BuildingSystems_BuildingSystems.Fluid.Interfaces.Examples.ReverseFlowMassExchanger.sim & ./BuildingSystems_BuildingSystems.Fluid.Interfaces.Examples.ReverseFlowMassExchanger  -abortSlowSimulation -alarm=480 -lv LOG_STATS > BuildingSystems_BuildingSystems.Fluid.Interfaces.Examples.ReverseFlowMassExchanger.pipe 2>&1)