Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.DHC.ETS.Heating.Examples.Direct.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/Buildings 12.0.0-master/package.mo", uses=false)
Using package Buildings with version 12.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.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(Buildings.DHC.ETS.Heating.Examples.Direct,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|heaETS.senTDisSup.T|heaETS.senTBuiSup.T|heaETS.senTBuiRet.T|heaETS.senTDisRet.T|heaETS.port_aSerHea.m_flow|heaETS.ports_aHeaWat.1..m_flow|heaETS.cheVal.m_flow|heaETS.conVal.y|heaETS.Q_flow|heaETS.Q",fileNamePrefix="Buildings_latest_Buildings.DHC.ETS.Heating.Examples.Direct")
translateModel(Buildings.DHC.ETS.Heating.Examples.Direct,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|heaETS.senTDisSup.T|heaETS.senTBuiSup.T|heaETS.senTBuiRet.T|heaETS.senTDisRet.T|heaETS.port_aSerHea.m_flow|heaETS.ports_aHeaWat.1..m_flow|heaETS.cheVal.m_flow|heaETS.conVal.y|heaETS.Q_flow|heaETS.Q",fileNamePrefix="Buildings_latest_Buildings.DHC.ETS.Heating.Examples.Direct")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001734/0.001734, allocations: 109.9 kB / 16.42 MB, free: 6.434 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.001997/0.001997, allocations: 187.9 kB / 17.35 MB, free: 5.688 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.519/1.519, allocations: 222.9 MB / 241.1 MB, free: 15.06 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-master/package.mo): time 2.774/2.774, allocations: 472.7 MB / 0.746 GB, free: 456 kB / 0.6075 GB
Notification: Performance of FrontEnd - loaded program: time 0.001589/0.001589, allocations: 63.89 kB / 1.07 GB, free: 9.566 MB / 0.8419 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.1/1.101, allocations: 159.9 MB / 1.226 GB, free: 13.49 MB / 0.9512 GB
Notification: Performance of NFInst.instantiate(Buildings.DHC.ETS.Heating.Examples.Direct): time 0.1659/1.267, allocations: 155.2 MB / 1.378 GB, free: 1.723 MB / 1.092 GB
Notification: Performance of NFInst.instExpressions: time 0.06047/1.328, allocations: 34.22 MB / 1.411 GB, free: 15.43 MB / 1.139 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01027/1.338, allocations: 167.1 kB / 1.412 GB, free: 15.26 MB / 1.139 GB
Notification: Performance of NFTyping.typeComponents: time 0.01093/1.349, allocations: 3.057 MB / 1.414 GB, free: 12.2 MB / 1.139 GB
Notification: Performance of NFTyping.typeBindings: time 0.02028/1.37, allocations: 5.708 MB / 1.42 GB, free: 6.465 MB / 1.139 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01355/1.383, allocations: 4.425 MB / 1.424 GB, free: 2.07 MB / 1.139 GB
Notification: Performance of NFFlatten.flatten: time 0.02515/1.408, allocations: 13.57 MB / 1.438 GB, free: 4.477 MB / 1.154 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.009389/1.418, allocations: 3.663 MB / 1.441 GB, free: 0.7461 MB / 1.154 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01529/1.433, allocations: 4.409 MB / 1.446 GB, free: 12.33 MB / 1.17 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.008122/1.441, allocations: 2.964 MB / 1.448 GB, free: 9.355 MB / 1.17 GB
Notification: Performance of NFPackage.collectConstants: time 0.002811/1.444, allocations: 408 kB / 1.449 GB, free: 8.957 MB / 1.17 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01107/1.455, allocations: 2.929 MB / 1.452 GB, free: 6.023 MB / 1.17 GB
Notification: Performance of NFScalarize.scalarize: time 0.003087/1.458, allocations: 1.172 MB / 1.453 GB, free: 4.848 MB / 1.17 GB
Notification: Performance of NFVerifyModel.verify: time 0.007395/1.466, allocations: 2.399 MB / 1.455 GB, free: 2.438 MB / 1.17 GB
Notification: Performance of NFConvertDAE.convert: time 0.0196/1.485, allocations: 7.482 MB / 1.462 GB, free: 10.93 MB / 1.186 GB
Notification: Performance of FrontEnd - DAE generated: time 1.054e-05/1.485, allocations: 0 / 1.462 GB, free: 10.93 MB / 1.186 GB
Notification: Performance of FrontEnd: time 1.953e-06/1.485, allocations: 3.938 kB / 1.462 GB, free: 10.92 MB / 1.186 GB
Notification: Performance of Transformations before backend: time 0.0003021/1.486, allocations: 0 / 1.462 GB, free: 10.92 MB / 1.186 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 567
 * Number of variables: 567
Notification: Performance of Generate backend data structure: time 0.01727/1.503, allocations: 5.134 MB / 1.467 GB, free: 5.691 MB / 1.186 GB
Notification: Performance of prepare preOptimizeDAE: time 6.359e-05/1.503, allocations: 12.02 kB / 1.467 GB, free: 5.68 MB / 1.186 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003267/1.506, allocations: 0.6023 MB / 1.468 GB, free: 5.074 MB / 1.186 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01191/1.518, allocations: 4.696 MB / 1.473 GB, free: 328 kB / 1.186 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002371/1.519, allocations: 176.4 kB / 1.473 GB, free: 148 kB / 1.186 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001059/1.52, allocations: 247.9 kB / 1.473 GB, free: 15.9 MB / 1.201 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.008046/1.528, allocations: 2.467 MB / 1.475 GB, free: 13.29 MB / 1.201 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001229/1.528, allocations: 7.938 kB / 1.475 GB, free: 13.29 MB / 1.201 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0005504/1.528, allocations: 92 kB / 1.476 GB, free: 13.2 MB / 1.201 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001116/1.529, allocations: 92.22 kB / 1.476 GB, free: 13.1 MB / 1.201 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.005144/1.534, allocations: 1.847 MB / 1.477 GB, free: 11.24 MB / 1.201 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.02373/1.558, allocations: 13.19 MB / 1.49 GB, free: 13.14 MB / 1.217 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002677/1.56, allocations: 1.217 MB / 1.492 GB, free: 11.9 MB / 1.217 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0014/1.562, allocations: 0.6717 MB / 1.492 GB, free: 11.23 MB / 1.217 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.01137/1.573, allocations: 4.234 MB / 1.496 GB, free: 6.602 MB / 1.217 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001957/1.575, allocations: 0.7232 MB / 1.497 GB, free: 5.855 MB / 1.217 GB
Notification: Performance of pre-optimization done (n=123): time 7.945e-06/1.575, allocations: 0 / 1.497 GB, free: 5.855 MB / 1.217 GB
Notification: Performance of matching and sorting (n=123): time 0.007326/1.582, allocations: 2.186 MB / 1.499 GB, free: 3.645 MB / 1.217 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 9.821e-05/1.583, allocations: 115.8 kB / 1.499 GB, free: 3.508 MB / 1.217 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.009268/1.592, allocations: 3.529 MB / 1.503 GB, free: 15.95 MB / 1.232 GB
Notification: Performance of collectPreVariables (initialization): time 0.0004862/1.592, allocations: 57.7 kB / 1.503 GB, free: 15.88 MB / 1.232 GB
Notification: Performance of collectInitialEqns (initialization): time 0.002442/1.595, allocations: 1.782 MB / 1.505 GB, free: 14.09 MB / 1.232 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0009822/1.596, allocations: 476 kB / 1.505 GB, free: 13.62 MB / 1.232 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001289/1.597, allocations: 467.8 kB / 1.505 GB, free: 13.16 MB / 1.232 GB
Notification: Performance of setup shared object (initialization): time 0.0001243/1.597, allocations: 308.9 kB / 1.506 GB, free: 12.86 MB / 1.232 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.00176/1.599, allocations: 0.7513 MB / 1.506 GB, free: 12.1 MB / 1.232 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002457/1.602, allocations: 1.389 MB / 1.508 GB, free: 10.45 MB / 1.232 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.00359/1.605, allocations: 2.018 MB / 1.51 GB, free: 8.227 MB / 1.232 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.448e-05/1.605, allocations: 4 kB / 1.51 GB, free: 8.223 MB / 1.232 GB
Notification: Performance of matching and sorting (n=287) (initialization): time 0.006305/1.612, allocations: 2.604 MB / 1.512 GB, free: 5.609 MB / 1.232 GB
Notification: Performance of prepare postOptimizeDAE: time 6.034e-05/1.612, allocations: 8 kB / 1.512 GB, free: 5.602 MB / 1.232 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.829e-05/1.612, allocations: 16 kB / 1.512 GB, free: 5.586 MB / 1.232 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0006311/1.612, allocations: 136.7 kB / 1.512 GB, free: 5.449 MB / 1.232 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001721/1.614, allocations: 451.3 kB / 1.513 GB, free: 5.008 MB / 1.232 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0007431/1.615, allocations: 0.6577 MB / 1.514 GB, free: 4.324 MB / 1.232 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003397/1.618, allocations: 262.3 kB / 1.514 GB, free: 4.066 MB / 1.232 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002947/1.619, allocations: 95.97 kB / 1.514 GB, free: 3.973 MB / 1.232 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.003711/1.622, allocations: 1.449 MB / 1.515 GB, free: 2.516 MB / 1.232 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.002207/1.625, allocations: 1.366 MB / 1.517 GB, free: 0.8906 MB / 1.232 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.003433/1.628, allocations: 1.986 MB / 1.519 GB, free: 14.7 MB / 1.248 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 2.393e-05/1.628, allocations: 4 kB / 1.519 GB, free: 14.7 MB / 1.248 GB
Notification: Performance of matching and sorting (n=287) (initialization_lambda0): time 0.006098/1.634, allocations: 2.537 MB / 1.521 GB, free: 12.14 MB / 1.248 GB
Notification: Performance of prepare postOptimizeDAE: time 2.753e-05/1.634, allocations: 12 kB / 1.521 GB, free: 12.13 MB / 1.248 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.18e-05/1.634, allocations: 16 kB / 1.521 GB, free: 12.12 MB / 1.248 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0002599/1.635, allocations: 64.83 kB / 1.521 GB, free: 12.05 MB / 1.248 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001741/1.636, allocations: 459.3 kB / 1.522 GB, free: 11.6 MB / 1.248 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.00179/1.638, allocations: 1.736 MB / 1.523 GB, free: 9.727 MB / 1.248 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003321/1.641, allocations: 223.2 kB / 1.523 GB, free: 9.508 MB / 1.248 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000323/1.642, allocations: 99.91 kB / 1.524 GB, free: 9.41 MB / 1.248 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 67
 * Number of states: 0 ()
 * Number of discrete variables: 7 ($PRE.QHea.nextTimeEvent,$whenCondition1,heaETS.con.con1.y,heaETS.int.local_reset,QHea.nextTimeEventScaled,$PRE.QHea.nextTimeEventScaled,QHea.nextTimeEvent)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (247):
 * Single equations (assignments): 244
 * Array equations: 1
 * Algorithm blocks: 0
 * Record equations: 1
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,7)}
Notification: Performance of prepare postOptimizeDAE: time 0.0007776/1.643, allocations: 309.1 kB / 1.524 GB, free: 9.102 MB / 1.248 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001593/1.644, allocations: 377.5 kB / 1.524 GB, free: 8.73 MB / 1.248 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004944/1.649, allocations: 1.865 MB / 1.526 GB, free: 6.852 MB / 1.248 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.002479/1.652, allocations: 1.241 MB / 1.527 GB, free: 5.598 MB / 1.248 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 9.999e-06/1.652, allocations: 4 kB / 1.527 GB, free: 5.594 MB / 1.248 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0023/1.654, allocations: 0.6465 MB / 1.528 GB, free: 4.926 MB / 1.248 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001288/1.655, allocations: 28 kB / 1.528 GB, free: 4.898 MB / 1.248 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002449/1.658, allocations: 83.8 kB / 1.528 GB, free: 4.816 MB / 1.248 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002044/1.658, allocations: 81.2 kB / 1.528 GB, free: 4.734 MB / 1.248 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.004449/1.662, allocations: 1.751 MB / 1.53 GB, free: 2.973 MB / 1.248 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.00551/1.668, allocations: 2.712 MB / 1.532 GB, free: 248 kB / 1.248 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.001215/1.669, allocations: 0.6622 MB / 1.533 GB, free: 15.58 MB / 1.264 GB
Notification: Performance of sorting global known variables: time 0.005991/1.675, allocations: 2.349 MB / 1.535 GB, free: 13.22 MB / 1.264 GB
Notification: Performance of Backend: time 1.333e-06/1.675, allocations: 0 / 1.535 GB, free: 13.22 MB / 1.264 GB
Notification: Performance of simCode: created initialization part: time 0.01385/1.689, allocations: 3.93 MB / 1.539 GB, free: 9.473 MB / 1.264 GB
Notification: Performance of SimCode: time 0.02287/1.712, allocations: 8.29 MB / 1.547 GB, free: 1.18 MB / 1.264 GB
Notification: Performance of Templates: time 0.9828/2.695, allocations: 77.05 MB / 1.623 GB, free: 287.1 MB / 1.279 GB
make -j1 -f Buildings_latest_Buildings.DHC.ETS.Heating.Examples.Direct.makefile
(rm -f Buildings_latest_Buildings.DHC.ETS.Heating.Examples.Direct.pipe ; mkfifo Buildings_latest_Buildings.DHC.ETS.Heating.Examples.Direct.pipe ; head -c 1048576 < Buildings_latest_Buildings.DHC.ETS.Heating.Examples.Direct.pipe >> ../files/Buildings_latest_Buildings.DHC.ETS.Heating.Examples.Direct.sim & ./Buildings_latest_Buildings.DHC.ETS.Heating.Examples.Direct  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.DHC.ETS.Heating.Examples.Direct.pipe 2>&1)