Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Buildings_7.0.0_Buildings.Fluid.Examples.Performance.Example4.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 7.0.1/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 7.0.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 7.0.1/package.mo)
Running command: translateModel(Buildings.Fluid.Examples.Performance.Example4,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_7.0.0_Buildings.Fluid.Examples.Performance.Example4")
translateModel(Buildings.Fluid.Examples.Performance.Example4,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_7.0.0_Buildings.Fluid.Examples.Performance.Example4")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 7.0.1/package.mo): time 2.113/2.113, allocations: 251.1 MB / 266.7 MB, free: 11.59 MB / 218.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.001352/0.001352, allocations: 180.2 kB / 326.2 MB, free: 2.879 MB / 250.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 2.252/2.252, allocations: 205.4 MB / 0.5772 GB, free: 20.79 MB / 426.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.000913/0.0009127, allocations: 96.41 kB / 0.6817 GB, free: 13.64 MB / 0.5105 GB
Notification: Performance of FrontEnd - loaded program: time 0.000693/0.0006936, allocations: 11.84 kB / 0.7957 GB, free: 135.6 MB / 0.6042 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2203/0.221, allocations: 106.3 MB / 0.8995 GB, free: 65.57 MB / 0.6042 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Examples.Performance.Example4): time 0.9489/1.17, allocations: 217 MB / 1.111 GB, free: 3.684 MB / 0.698 GB
Notification: Performance of NFInst.instExpressions: time 0.02555/1.196, allocations: 14.73 MB / 1.126 GB, free: 3.355 MB / 0.698 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002709/1.198, allocations: 55.75 kB / 1.126 GB, free: 3.352 MB / 0.698 GB
Notification: Performance of NFTyping.typeComponents: time 0.003229/1.202, allocations: 0.6519 MB / 1.127 GB, free: 3.344 MB / 0.698 GB
Notification: Performance of NFTyping.typeBindings: time 0.009106/1.211, allocations: 2.253 MB / 1.129 GB, free: 3.242 MB / 0.698 GB
Notification: Performance of NFTyping.typeClassSections: time 0.005444/1.216, allocations: 1.258 MB / 1.13 GB, free: 3.188 MB / 0.698 GB
Notification: Performance of NFFlatten.flatten: time 0.006639/1.223, allocations: 4.001 MB / 1.134 GB, free: 3.176 MB / 0.698 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.00378/1.227, allocations: 0.9975 MB / 1.135 GB, free: 3.035 MB / 0.698 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.008663/1.235, allocations: 1.793 MB / 1.137 GB, free: 3.012 MB / 0.698 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.003086/1.239, allocations: 1.067 MB / 1.138 GB, free: 3.012 MB / 0.698 GB
Notification: Performance of NFPackage.collectConstants: time 0.0004561/1.239, allocations: 52.97 kB / 1.138 GB, free: 3.008 MB / 0.698 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.006846/1.246, allocations: 1.909 MB / 1.14 GB, free: 2.973 MB / 0.698 GB
Notification: Performance of NFScalarize.scalarize: time 0.001196/1.247, allocations: 395.7 kB / 1.14 GB, free: 2.973 MB / 0.698 GB
Notification: Performance of NFVerifyModel.verify: time 0.001243/1.249, allocations: 327.9 kB / 1.14 GB, free: 18.94 MB / 0.7136 GB
Notification: Performance of NFConvertDAE.convert: time 0.005294/1.254, allocations: 2.028 MB / 1.142 GB, free: 18.71 MB / 0.7136 GB
Notification: Performance of FrontEnd - DAE generated: time 8.536e-06/1.254, allocations: 0.5938 kB / 1.142 GB, free: 18.71 MB / 0.7136 GB
Notification: Performance of FrontEnd: time 2.946e-06/1.254, allocations: 0 / 1.142 GB, free: 18.71 MB / 0.7136 GB
Notification: Performance of Transformations before backend: time 6.322e-05/1.254, allocations: 0.7812 kB / 1.142 GB, free: 18.71 MB / 0.7136 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 251
 * Number of variables: 251
Notification: Performance of Generate backend data structure: time 0.005898/1.26, allocations: 1.73 MB / 1.144 GB, free: 17.54 MB / 0.7136 GB
Notification: Performance of prepare preOptimizeDAE: time 5.617e-05/1.26, allocations: 8.844 kB / 1.144 GB, free: 17.54 MB / 0.7136 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004747/1.265, allocations: 0.5208 MB / 1.144 GB, free: 17.33 MB / 0.7136 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.003973/1.269, allocations: 1.074 MB / 1.145 GB, free: 16.78 MB / 0.7136 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001701/1.271, allocations: 277.9 kB / 1.146 GB, free: 16.7 MB / 0.7136 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003388/1.271, allocations: 102.9 kB / 1.146 GB, free: 16.7 MB / 0.7136 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003777/1.275, allocations: 1.329 MB / 1.147 GB, free: 16.18 MB / 0.7136 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.975e-05/1.275, allocations: 6.25 kB / 1.147 GB, free: 16.18 MB / 0.7136 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001577/1.275, allocations: 42.59 kB / 1.147 GB, free: 16.18 MB / 0.7136 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 7.568e-05/1.275, allocations: 45.67 kB / 1.147 GB, free: 16.18 MB / 0.7136 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.004307/1.279, allocations: 1.115 MB / 1.148 GB, free: 15.96 MB / 0.7136 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.01261/1.292, allocations: 6.723 MB / 1.155 GB, free: 10.91 MB / 0.7136 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002953/1.295, allocations: 0.6019 MB / 1.155 GB, free: 10.76 MB / 0.7136 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001178/1.296, allocations: 282.3 kB / 1.156 GB, free: 10.69 MB / 0.7136 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0005594/1.297, allocations: 292.5 kB / 1.156 GB, free: 10.39 MB / 0.7136 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.158e-05/1.297, allocations: 38.12 kB / 1.156 GB, free: 10.36 MB / 0.7136 GB
Notification: Performance of pre-optimization done (n=33): time 3.176e-06/1.297, allocations: 0 / 1.156 GB, free: 10.36 MB / 0.7136 GB
Notification: Performance of matching and sorting (n=33): time 0.004291/1.301, allocations: 0.9006 MB / 1.157 GB, free: 10.09 MB / 0.7136 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.715e-05/1.301, allocations: 58.78 kB / 1.157 GB, free: 10.02 MB / 0.7136 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003007/1.304, allocations: 1.35 MB / 1.158 GB, free: 9.637 MB / 0.7136 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001873/1.305, allocations: 35.17 kB / 1.158 GB, free: 9.605 MB / 0.7136 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0007361/1.305, allocations: 0.6819 MB / 1.159 GB, free: 9.289 MB / 0.7136 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002208/1.305, allocations: 118.6 kB / 1.159 GB, free: 9.207 MB / 0.7136 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 6.534e-05/1.306, allocations: 13.94 kB / 1.159 GB, free: 9.207 MB / 0.7136 GB
Notification: Performance of setup shared object (initialization): time 0.000168/1.306, allocations: 334.3 kB / 1.159 GB, free: 8.891 MB / 0.7136 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001618/1.307, allocations: 329 kB / 1.16 GB, free: 8.816 MB / 0.7136 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001848/1.309, allocations: 0.6617 MB / 1.16 GB, free: 8.32 MB / 0.7136 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001673/1.311, allocations: 399.3 kB / 1.161 GB, free: 8.242 MB / 0.7136 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.064e-05/1.311, allocations: 2.344 kB / 1.161 GB, free: 8.242 MB / 0.7136 GB
Notification: Performance of matching and sorting (n=81) (initialization): time 0.004141/1.315, allocations: 1.046 MB / 1.162 GB, free: 7.977 MB / 0.7136 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0003227/1.315, allocations: 388.2 kB / 1.162 GB, free: 7.52 MB / 0.7136 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.691e-05/1.316, allocations: 8.25 kB / 1.162 GB, free: 7.52 MB / 0.7136 GB
Notification: Performance of postOpt tearingSystem (initialization): time 3.096e-05/1.316, allocations: 14.44 kB / 1.162 GB, free: 7.52 MB / 0.7136 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001583/1.317, allocations: 202.1 kB / 1.162 GB, free: 7.484 MB / 0.7136 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 3.086e-05/1.317, allocations: 23.92 kB / 1.162 GB, free: 7.48 MB / 0.7136 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002655/1.32, allocations: 232.5 kB / 1.163 GB, free: 7.379 MB / 0.7136 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001206/1.32, allocations: 38.95 kB / 1.163 GB, free: 7.375 MB / 0.7136 GB
Notification: Performance of prepare postOptimizeDAE: time 1.279e-05/1.32, allocations: 5.844 kB / 1.163 GB, free: 7.375 MB / 0.7136 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.003597/1.324, allocations: 0.8972 MB / 1.164 GB, free: 7.207 MB / 0.7136 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.906e-05/1.324, allocations: 8.688 kB / 1.164 GB, free: 7.207 MB / 0.7136 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.865e-05/1.324, allocations: 14.47 kB / 1.164 GB, free: 7.207 MB / 0.7136 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001522/1.325, allocations: 206.7 kB / 1.164 GB, free: 7.168 MB / 0.7136 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.125e-05/1.325, allocations: 20.78 kB / 1.164 GB, free: 7.168 MB / 0.7136 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002427/1.328, allocations: 209.1 kB / 1.164 GB, free: 7.07 MB / 0.7136 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001109/1.328, allocations: 44 kB / 1.164 GB, free: 7.062 MB / 0.7136 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 43
 * 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 (81):
 * Single equations (assignments): 81
 * 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 prepare postOptimizeDAE: time 0.0009036/1.329, allocations: 420.3 kB / 1.164 GB, free: 6.848 MB / 0.7136 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003683/1.329, allocations: 140.2 kB / 1.165 GB, free: 6.773 MB / 0.7136 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002823/1.332, allocations: 0.6774 MB / 1.165 GB, free: 6.555 MB / 0.7136 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.225e-05/1.332, allocations: 3.984 kB / 1.165 GB, free: 6.551 MB / 0.7136 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.517e-06/1.332, allocations: 0 / 1.165 GB, free: 6.551 MB / 0.7136 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0009995/1.333, allocations: 285.5 kB / 1.166 GB, free: 6.344 MB / 0.7136 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003388/1.333, allocations: 8.531 kB / 1.166 GB, free: 6.344 MB / 0.7136 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001789/1.335, allocations: 114.8 kB / 1.166 GB, free: 6.297 MB / 0.7136 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001025/1.335, allocations: 23.31 kB / 1.166 GB, free: 6.289 MB / 0.7136 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.002972/1.338, allocations: 0.6609 MB / 1.166 GB, free: 6.039 MB / 0.7136 GB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.002851/1.341, allocations: 0.8086 MB / 1.167 GB, free: 5.648 MB / 0.7136 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.001097/1.342, allocations: 242.5 kB / 1.167 GB, free: 5.594 MB / 0.7136 GB
Notification: Performance of sorting global known variables: time 0.002224/1.345, allocations: 0.9218 MB / 1.168 GB, free: 5.34 MB / 0.7136 GB
Notification: Performance of Backend: time 1.302e-06/1.345, allocations: 4 kB / 1.168 GB, free: 5.336 MB / 0.7136 GB
Notification: Performance of simCode: created initialization part: time 0.007101/1.352, allocations: 1.565 MB / 1.17 GB, free: 4.891 MB / 0.7136 GB
Notification: Performance of SimCode: time 0.009291/1.361, allocations: 3.283 MB / 1.173 GB, free: 2.91 MB / 0.7136 GB
Notification: Performance of Templates: time 0.08374/1.445, allocations: 31.04 MB / 1.203 GB, free: 5.551 MB / 0.7449 GB
make -j1 -f Buildings_7.0.0_Buildings.Fluid.Examples.Performance.Example4.makefile
(rm -f Buildings_7.0.0_Buildings.Fluid.Examples.Performance.Example4.pipe ; mkfifo Buildings_7.0.0_Buildings.Fluid.Examples.Performance.Example4.pipe ; head -c 1048576 < Buildings_7.0.0_Buildings.Fluid.Examples.Performance.Example4.pipe >> ../files/Buildings_7.0.0_Buildings.Fluid.Examples.Performance.Example4.sim & ./Buildings_7.0.0_Buildings.Fluid.Examples.Performance.Example4 -abortSlowSimulation -alarm=480 -lv LOG_STATS > Buildings_7.0.0_Buildings.Fluid.Examples.Performance.Example4.pipe 2>&1)