Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Buildings_8.0.0_Buildings.Fluid.FMI.Validation.HeaterFan_noReverseFlow.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.0.0/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo", uses=false)
Using package ModelicaServices with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo)
Using package Modelica with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo)
Using package Complex with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo)
Using package Buildings with version 8.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.0.0/package.mo)
Running command: translateModel(Buildings.Fluid.FMI.Validation.HeaterFan_noReverseFlow,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_8.0.0_Buildings.Fluid.FMI.Validation.HeaterFan_noReverseFlow")
translateModel(Buildings.Fluid.FMI.Validation.HeaterFan_noReverseFlow,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_8.0.0_Buildings.Fluid.FMI.Validation.HeaterFan_noReverseFlow")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.0.0/package.mo): time 2.807/2.807, allocations: 287.3 MB / 302.3 MB, free: 8.266 MB / 234.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.00223/0.00223, allocations: 178.9 kB / 370.8 MB, free: 10.86 MB / 298.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 2.329/2.329, allocations: 205.4 MB / 0.6295 GB, free: 10.62 MB / 458.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.00169/0.00169, allocations: 97.91 kB / 0.7428 GB, free: 6.637 MB / 0.5573 GB
Notification: Performance of FrontEnd - loaded program: time 0.0007016/0.0007021, allocations: 15.73 kB / 0.8656 GB, free: 140.6 MB / 0.6198 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2701/0.2708, allocations: 115.3 MB / 0.9782 GB, free: 28.41 MB / 0.6198 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.FMI.Validation.HeaterFan_noReverseFlow): time 1.172/1.443, allocations: 247.2 MB / 1.22 GB, free: 1.605 MB / 0.7448 GB
Notification: Performance of NFInst.instExpressions: time 0.05566/1.498, allocations: 25.01 MB / 1.244 GB, free: 9.246 MB / 0.7761 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003481/1.502, allocations: 59.56 kB / 1.244 GB, free: 9.188 MB / 0.7761 GB
Notification: Performance of NFTyping.typeComponents: time 0.005825/1.508, allocations: 1.034 MB / 1.245 GB, free: 8.148 MB / 0.7761 GB
Notification: Performance of NFTyping.typeBindings: time 0.02081/1.529, allocations: 2.867 MB / 1.248 GB, free: 5.277 MB / 0.7761 GB
Notification: Performance of NFTyping.typeClassSections: time 0.02128/1.55, allocations: 2.861 MB / 1.251 GB, free: 2.441 MB / 0.7761 GB
Notification: Performance of NFFlatten.flatten: time 0.01178/1.562, allocations: 2.559 MB / 1.253 GB, free: 15.88 MB / 0.7917 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.005453/1.567, allocations: 1.206 MB / 1.254 GB, free: 14.64 MB / 0.7917 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0088/1.576, allocations: 1.522 MB / 1.256 GB, free: 13.12 MB / 0.7917 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.003303/1.58, allocations: 0.77 MB / 1.257 GB, free: 12.34 MB / 0.7917 GB
Notification: Performance of NFPackage.collectConstants: time 0.0007243/1.58, allocations: 64 kB / 1.257 GB, free: 12.28 MB / 0.7917 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.00874/1.589, allocations: 1.447 MB / 1.258 GB, free: 10.83 MB / 0.7917 GB
Notification: Performance of NFScalarize.scalarize: time 0.001636/1.591, allocations: 430.6 kB / 1.258 GB, free: 10.41 MB / 0.7917 GB
Notification: Performance of NFVerifyModel.verify: time 0.001569/1.592, allocations: 424.8 kB / 1.259 GB, free: 9.988 MB / 0.7917 GB
Notification: Performance of NFConvertDAE.convert: time 0.009134/1.602, allocations: 2.872 MB / 1.262 GB, free: 7.109 MB / 0.7917 GB
Notification: Performance of FrontEnd - DAE generated: time 6.332e-06/1.602, allocations: 0 / 1.262 GB, free: 7.109 MB / 0.7917 GB
Notification: Performance of FrontEnd: time 3.928e-06/1.602, allocations: 0 / 1.262 GB, free: 7.109 MB / 0.7917 GB
Notification: Performance of Transformations before backend: time 0.0001097/1.602, allocations: 0 / 1.262 GB, free: 7.109 MB / 0.7917 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 273
 * Number of variables: 273
Notification: Performance of Generate backend data structure: time 0.008706/1.611, allocations: 1.913 MB / 1.264 GB, free: 5.137 MB / 0.7917 GB
Notification: Performance of prepare preOptimizeDAE: time 6.527e-05/1.611, allocations: 16.02 kB / 1.264 GB, free: 5.121 MB / 0.7917 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.009736/1.62, allocations: 0.6338 MB / 1.264 GB, free: 4.484 MB / 0.7917 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.009015/1.63, allocations: 1.84 MB / 1.266 GB, free: 2.59 MB / 0.7917 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0019/1.632, allocations: 218 kB / 1.266 GB, free: 2.375 MB / 0.7917 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0005961/1.632, allocations: 112 kB / 1.266 GB, free: 2.266 MB / 0.7917 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.007645/1.64, allocations: 1.387 MB / 1.268 GB, free: 0.7656 MB / 0.7917 GB
Notification: Performance of preOpt findStateOrder (simulation): time 6.658e-05/1.64, allocations: 3.938 kB / 1.268 GB, free: 0.7617 MB / 0.7917 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003175/1.64, allocations: 44 kB / 1.268 GB, free: 0.7188 MB / 0.7917 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001205/1.64, allocations: 42 kB / 1.268 GB, free: 0.6797 MB / 0.7917 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.007807/1.648, allocations: 1.062 MB / 1.269 GB, free: 15.61 MB / 0.8073 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.01557/1.664, allocations: 6.903 MB / 1.275 GB, free: 8.348 MB / 0.8073 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002949/1.667, allocations: 366.5 kB / 1.276 GB, free: 7.98 MB / 0.8073 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001166/1.667, allocations: 8 kB / 1.276 GB, free: 7.973 MB / 0.8073 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 5.029e-05/1.667, allocations: 42.86 kB / 1.276 GB, free: 7.922 MB / 0.8073 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.001023/1.668, allocations: 78.95 kB / 1.276 GB, free: 7.844 MB / 0.8073 GB
Notification: Performance of pre-optimization done (n=20): time 5.901e-06/1.668, allocations: 0 / 1.276 GB, free: 7.844 MB / 0.8073 GB
Notification: Performance of matching and sorting (n=20): time 0.00328/1.672, allocations: 0.5347 MB / 1.276 GB, free: 7.301 MB / 0.8073 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.458e-05/1.672, allocations: 51.41 kB / 1.277 GB, free: 7.238 MB / 0.8073 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.00496/1.677, allocations: 1.718 MB / 1.278 GB, free: 5.523 MB / 0.8073 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001434/1.677, allocations: 37.64 kB / 1.278 GB, free: 5.48 MB / 0.8073 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001115/1.678, allocations: 0.825 MB / 1.279 GB, free: 4.648 MB / 0.8073 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001232/1.678, allocations: 82.97 kB / 1.279 GB, free: 4.566 MB / 0.8073 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 6.591e-05/1.678, allocations: 16 kB / 1.279 GB, free: 4.551 MB / 0.8073 GB
Notification: Performance of setup shared object (initialization): time 0.0001733/1.678, allocations: 334 kB / 1.279 GB, free: 4.219 MB / 0.8073 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001559/1.68, allocations: 285.8 kB / 1.28 GB, free: 3.941 MB / 0.8073 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001862/1.682, allocations: 0.6739 MB / 1.28 GB, free: 3.074 MB / 0.8073 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001751/1.684, allocations: 369 kB / 1.281 GB, free: 2.715 MB / 0.8073 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.313e-05/1.684, allocations: 4 kB / 1.281 GB, free: 2.711 MB / 0.8073 GB
Notification: Performance of matching and sorting (n=85) (initialization): time 0.004377/1.688, allocations: 1.046 MB / 1.282 GB, free: 1.656 MB / 0.8073 GB
Notification: Performance of prepare postOptimizeDAE: time 0.00259/1.691, allocations: 4.967 MB / 1.287 GB, free: 12.27 MB / 0.823 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.571e-05/1.691, allocations: 16 kB / 1.287 GB, free: 12.26 MB / 0.823 GB
Notification: Performance of postOpt tearingSystem (initialization): time 4.372e-05/1.691, allocations: 16 kB / 1.287 GB, free: 12.24 MB / 0.823 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001705/1.693, allocations: 203.7 kB / 1.287 GB, free: 12.04 MB / 0.823 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 4.317e-05/1.693, allocations: 27.86 kB / 1.287 GB, free: 12.02 MB / 0.823 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002758/1.695, allocations: 180.3 kB / 1.287 GB, free: 11.84 MB / 0.823 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001824/1.696, allocations: 47.95 kB / 1.287 GB, free: 11.79 MB / 0.823 GB
Notification: Performance of prepare postOptimizeDAE: time 1.742e-05/1.696, allocations: 6.188 kB / 1.287 GB, free: 11.79 MB / 0.823 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.003256/1.699, allocations: 0.8048 MB / 1.288 GB, free: 10.98 MB / 0.823 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.927e-05/1.699, allocations: 15.98 kB / 1.288 GB, free: 10.97 MB / 0.823 GB
Notification: Performance of postOpt tearingSystem (initialization): time 3.939e-05/1.699, allocations: 20.03 kB / 1.288 GB, free: 10.95 MB / 0.823 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001325/1.7, allocations: 191.6 kB / 1.288 GB, free: 10.76 MB / 0.823 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 3.707e-05/1.7, allocations: 23.92 kB / 1.288 GB, free: 10.74 MB / 0.823 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002085/1.703, allocations: 128.5 kB / 1.288 GB, free: 10.61 MB / 0.823 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001311/1.703, allocations: 43.98 kB / 1.288 GB, free: 10.57 MB / 0.823 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 55
 * 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 (84):
 * Single equations (assignments): 83
 * Array equations: 1
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.001307/1.704, allocations: 0.5124 MB / 1.289 GB, free: 10.04 MB / 0.823 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0004522/1.705, allocations: 158 kB / 1.289 GB, free: 9.887 MB / 0.823 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001923/1.706, allocations: 445.9 kB / 1.289 GB, free: 9.441 MB / 0.823 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.314e-05/1.706, allocations: 7.953 kB / 1.289 GB, free: 9.434 MB / 0.823 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.132e-06/1.707, allocations: 0 / 1.289 GB, free: 9.434 MB / 0.823 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 7.644e-06/1.707, allocations: 7.984 kB / 1.289 GB, free: 9.426 MB / 0.823 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.004613/1.711, allocations: 1.584 MB / 1.291 GB, free: 7.746 MB / 0.823 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 9.238e-06/1.711, allocations: 4 kB / 1.291 GB, free: 7.742 MB / 0.823 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0005924/1.712, allocations: 55.89 kB / 1.291 GB, free: 7.688 MB / 0.823 GB
Notification: Performance of postOpt tearingSystem (simulation): time 1.255e-05/1.712, allocations: 7.938 kB / 1.291 GB, free: 7.68 MB / 0.823 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 3.656e-05/1.712, allocations: 4 kB / 1.291 GB, free: 7.676 MB / 0.823 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 8.536e-06/1.712, allocations: 4 kB / 1.291 GB, free: 7.672 MB / 0.823 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.731e-06/1.712, allocations: 3.938 kB / 1.291 GB, free: 7.668 MB / 0.823 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.002031/1.714, allocations: 0.6988 MB / 1.292 GB, free: 6.887 MB / 0.823 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0008398/1.715, allocations: 294.9 kB / 1.292 GB, free: 6.578 MB / 0.823 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002808/1.715, allocations: 8 kB / 1.292 GB, free: 6.57 MB / 0.823 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001669/1.717, allocations: 83.92 kB / 1.292 GB, free: 6.488 MB / 0.823 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 8.471e-05/1.717, allocations: 15.94 kB / 1.292 GB, free: 6.473 MB / 0.823 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 7.833e-05/1.717, allocations: 19.98 kB / 1.292 GB, free: 6.453 MB / 0.823 GB
Notification: Performance of sorting global known variables: time 0.0039/1.721, allocations: 1.19 MB / 1.293 GB, free: 5.273 MB / 0.823 GB
Notification: Performance of sort global known variables: time 7.21e-07/1.721, allocations: 0 / 1.293 GB, free: 5.273 MB / 0.823 GB
Notification: Performance of remove unused functions: time 0.003254/1.724, allocations: 0.6589 MB / 1.294 GB, free: 4.613 MB / 0.823 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 9
 * 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 simulation (20):
 * Single equations (assignments): 20
 * 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: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.0009267/1.725, allocations: 284.6 kB / 1.294 GB, free: 4.324 MB / 0.823 GB
Notification: Performance of simCode: created initialization part: time 0.004317/1.73, allocations: 0.9468 MB / 1.295 GB, free: 3.383 MB / 0.823 GB
Notification: Performance of simCode: created event and clocks part: time 1.261e-05/1.73, allocations: 4.375 kB / 1.295 GB, free: 3.379 MB / 0.823 GB
Notification: Performance of simCode: created simulation system equations: time 0.0006967/1.73, allocations: 131.8 kB / 1.295 GB, free: 3.25 MB / 0.823 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.006618/1.737, allocations: 0.8103 MB / 1.296 GB, free: 2.445 MB / 0.823 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.006934/1.744, allocations: 2.766 MB / 1.299 GB, free: 15.62 MB / 0.8386 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001384/1.745, allocations: 1.318 MB / 1.3 GB, free: 14.28 MB / 0.8386 GB
Notification: Performance of simCode: alias equations: time 0.002804/1.748, allocations: 350.1 kB / 1.3 GB, free: 13.93 MB / 0.8386 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0005081/1.749, allocations: 115.4 kB / 1.3 GB, free: 13.82 MB / 0.8386 GB
Notification: Performance of SimCode: time 1.202e-06/1.749, allocations: 0 / 1.3 GB, free: 13.82 MB / 0.8386 GB
Notification: Performance of Templates: time 0.07897/1.828, allocations: 27.25 MB / 1.327 GB, free: 2.793 MB / 0.8542 GB
make -j1 -f Buildings_8.0.0_Buildings.Fluid.FMI.Validation.HeaterFan_noReverseFlow.makefile
(rm -f Buildings_8.0.0_Buildings.Fluid.FMI.Validation.HeaterFan_noReverseFlow.pipe ; mkfifo Buildings_8.0.0_Buildings.Fluid.FMI.Validation.HeaterFan_noReverseFlow.pipe ; head -c 1048576 < Buildings_8.0.0_Buildings.Fluid.FMI.Validation.HeaterFan_noReverseFlow.pipe >> ../files/Buildings_8.0.0_Buildings.Fluid.FMI.Validation.HeaterFan_noReverseFlow.sim & ./Buildings_8.0.0_Buildings.Fluid.FMI.Validation.HeaterFan_noReverseFlow -abortSlowSimulation -alarm=480 -lv LOG_STATS > Buildings_8.0.0_Buildings.Fluid.FMI.Validation.HeaterFan_noReverseFlow.pipe 2>&1)