Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Fluid.HeatExchangers.BaseClasses.Examples.HexElementLatent.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 11.0.1-master/package.mo", uses=false)
Using package Buildings with version 11.0.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.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(Buildings.Fluid.HeatExchangers.BaseClasses.Examples.HexElementLatent,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|hex.vol1.T|hex.vol2.T|hex.port_a1.m_flow|hex.port_a2.m_flow|netEne.y|hex.Q1_flow|hex.Q2_flow",fileNamePrefix="Buildings_latest_Buildings.Fluid.HeatExchangers.BaseClasses.Examples.HexElementLatent")
translateModel(Buildings.Fluid.HeatExchangers.BaseClasses.Examples.HexElementLatent,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|hex.vol1.T|hex.vol2.T|hex.port_a1.m_flow|hex.port_a2.m_flow|netEne.y|hex.Q1_flow|hex.Q2_flow",fileNamePrefix="Buildings_latest_Buildings.Fluid.HeatExchangers.BaseClasses.Examples.HexElementLatent")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001224/0.001224, allocations: 115.7 kB / 16.42 MB, free: 6.516 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.001212/0.001212, allocations: 190.6 kB / 17.35 MB, free: 5.738 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.369/1.369, allocations: 222.9 MB / 241.1 MB, free: 15.13 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-master/package.mo): time 2.606/2.606, allocations: 461.9 MB / 0.7355 GB, free: 11.03 MB / 0.6075 GB
Notification: Performance of FrontEnd - loaded program: time 0.001503/0.001503, allocations: 71.88 kB / 1.055 GB, free: 7.613 MB / 0.8262 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.8273/0.8288, allocations: 157.4 MB / 1.208 GB, free: 13.57 MB / 0.9356 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.HeatExchangers.BaseClasses.Examples.HexElementLatent): time 0.2598/1.089, allocations: 254 MB / 1.456 GB, free: 14.69 MB / 1.186 GB
Notification: Performance of NFInst.instExpressions: time 0.02554/1.114, allocations: 18.08 MB / 1.474 GB, free: 12.56 MB / 1.201 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003072/1.117, allocations: 79.56 kB / 1.474 GB, free: 12.48 MB / 1.201 GB
Notification: Performance of NFTyping.typeComponents: time 0.003548/1.121, allocations: 1.087 MB / 1.475 GB, free: 11.39 MB / 1.201 GB
Notification: Performance of NFTyping.typeBindings: time 0.01051/1.132, allocations: 3.838 MB / 1.479 GB, free: 7.531 MB / 1.201 GB
Notification: Performance of NFTyping.typeClassSections: time 0.005053/1.137, allocations: 1.81 MB / 1.481 GB, free: 5.734 MB / 1.201 GB
Notification: Performance of NFFlatten.flatten: time 0.007517/1.144, allocations: 5.069 MB / 1.486 GB, free: 0.6523 MB / 1.201 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.003135/1.147, allocations: 1.825 MB / 1.488 GB, free: 14.77 MB / 1.217 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.005178/1.152, allocations: 2.21 MB / 1.49 GB, free: 12.56 MB / 1.217 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.002992/1.156, allocations: 1.514 MB / 1.491 GB, free: 11.04 MB / 1.217 GB
Notification: Performance of NFPackage.collectConstants: time 0.0005596/1.156, allocations: 187.9 kB / 1.491 GB, free: 10.86 MB / 1.217 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.005498/1.162, allocations: 2.534 MB / 1.494 GB, free: 8.32 MB / 1.217 GB
Notification: Performance of NFScalarize.scalarize: time 0.0008835/1.162, allocations: 0.6036 MB / 1.494 GB, free: 7.715 MB / 1.217 GB
Notification: Performance of NFVerifyModel.verify: time 0.001979/1.164, allocations: 1.108 MB / 1.495 GB, free: 6.602 MB / 1.217 GB
Notification: Performance of NFConvertDAE.convert: time 0.006341/1.171, allocations: 3.696 MB / 1.499 GB, free: 2.895 MB / 1.217 GB
Notification: Performance of FrontEnd - DAE generated: time 5.41e-06/1.171, allocations: 0 / 1.499 GB, free: 2.895 MB / 1.217 GB
Notification: Performance of FrontEnd: time 1.943e-06/1.171, allocations: 0 / 1.499 GB, free: 2.895 MB / 1.217 GB
Notification: Performance of Transformations before backend: time 9.316e-05/1.171, allocations: 4 kB / 1.499 GB, free: 2.891 MB / 1.217 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 348
 * Number of variables: 348
Notification: Performance of Generate backend data structure: time 0.005134/1.176, allocations: 2.479 MB / 1.502 GB, free: 364 kB / 1.217 GB
Notification: Performance of prepare preOptimizeDAE: time 4.573e-05/1.176, allocations: 16.03 kB / 1.502 GB, free: 348 kB / 1.217 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001849/1.178, allocations: 373.1 kB / 1.502 GB, free: 15.97 MB / 1.232 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002758/1.181, allocations: 1.486 MB / 1.503 GB, free: 14.43 MB / 1.232 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001023/1.181, allocations: 110.7 kB / 1.503 GB, free: 14.32 MB / 1.232 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001925/1.181, allocations: 139.9 kB / 1.504 GB, free: 14.19 MB / 1.232 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002818/1.184, allocations: 1.507 MB / 1.505 GB, free: 12.61 MB / 1.232 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.205e-05/1.184, allocations: 0 / 1.505 GB, free: 12.61 MB / 1.232 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001349/1.184, allocations: 59.98 kB / 1.505 GB, free: 12.55 MB / 1.232 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 6.442e-05/1.184, allocations: 54.64 kB / 1.505 GB, free: 12.5 MB / 1.232 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.00231/1.187, allocations: 1.138 MB / 1.506 GB, free: 11.36 MB / 1.232 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.008533/1.195, allocations: 7.204 MB / 1.513 GB, free: 3.582 MB / 1.232 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.001396/1.196, allocations: 0.8161 MB / 1.514 GB, free: 2.742 MB / 1.232 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0007523/1.197, allocations: 439.1 kB / 1.515 GB, free: 2.309 MB / 1.232 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.00087/1.198, allocations: 0.7201 MB / 1.515 GB, free: 1.441 MB / 1.232 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.794e-05/1.198, allocations: 47.16 kB / 1.515 GB, free: 1.387 MB / 1.232 GB
Notification: Performance of pre-optimization done (n=74): time 2.915e-06/1.198, allocations: 0 / 1.515 GB, free: 1.387 MB / 1.232 GB
Notification: Performance of matching and sorting (n=74): time 0.006466/1.205, allocations: 2.067 MB / 1.517 GB, free: 15.25 MB / 1.248 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.042e-05/1.205, allocations: 60.06 kB / 1.517 GB, free: 15.18 MB / 1.248 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001773/1.206, allocations: 1.314 MB / 1.519 GB, free: 13.85 MB / 1.248 GB
Notification: Performance of collectPreVariables (initialization): time 8.679e-05/1.207, allocations: 53.62 kB / 1.519 GB, free: 13.79 MB / 1.248 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0006124/1.207, allocations: 0.7978 MB / 1.519 GB, free: 12.98 MB / 1.248 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002678/1.207, allocations: 264.2 kB / 1.52 GB, free: 12.72 MB / 1.248 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.000274/1.208, allocations: 170.5 kB / 1.52 GB, free: 12.55 MB / 1.248 GB
Notification: Performance of setup shared object (initialization): time 0.0001145/1.208, allocations: 345.9 kB / 1.52 GB, free: 12.21 MB / 1.248 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0006269/1.209, allocations: 328.7 kB / 1.521 GB, free: 11.88 MB / 1.248 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0008055/1.209, allocations: 0.5669 MB / 1.521 GB, free: 11.23 MB / 1.248 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001404/1.211, allocations: 0.8673 MB / 1.522 GB, free: 10.3 MB / 1.248 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.731e-06/1.211, allocations: 0 / 1.522 GB, free: 10.3 MB / 1.248 GB
Notification: Performance of matching and sorting (n=108) (initialization): time 0.002665/1.213, allocations: 1.255 MB / 1.523 GB, free: 9.023 MB / 1.248 GB
Notification: Performance of prepare postOptimizeDAE: time 1.963e-05/1.213, allocations: 8 kB / 1.523 GB, free: 9.016 MB / 1.248 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.062e-05/1.213, allocations: 4 kB / 1.523 GB, free: 9.012 MB / 1.248 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001907/1.215, allocations: 424.8 kB / 1.524 GB, free: 8.59 MB / 1.248 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0006242/1.216, allocations: 155.8 kB / 1.524 GB, free: 8.438 MB / 1.248 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001696/1.218, allocations: 2.055 MB / 1.526 GB, free: 6.305 MB / 1.248 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001033/1.219, allocations: 111 kB / 1.526 GB, free: 6.195 MB / 1.248 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.141e-05/1.219, allocations: 39.98 kB / 1.526 GB, free: 6.156 MB / 1.248 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001133/1.22, allocations: 0.6385 MB / 1.526 GB, free: 5.512 MB / 1.248 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0007797/1.221, allocations: 0.5556 MB / 1.527 GB, free: 4.867 MB / 1.248 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.00135/1.222, allocations: 0.8555 MB / 1.528 GB, free: 3.949 MB / 1.248 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 3.928e-06/1.222, allocations: 0 / 1.528 GB, free: 3.949 MB / 1.248 GB
Notification: Performance of matching and sorting (n=108) (initialization_lambda0): time 0.002264/1.224, allocations: 1.205 MB / 1.529 GB, free: 2.727 MB / 1.248 GB
Notification: Performance of prepare postOptimizeDAE: time 1.473e-05/1.224, allocations: 14.09 kB / 1.529 GB, free: 2.715 MB / 1.248 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.104e-05/1.225, allocations: 4 kB / 1.529 GB, free: 2.711 MB / 1.248 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001545/1.226, allocations: 356.3 kB / 1.529 GB, free: 2.355 MB / 1.248 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0006077/1.227, allocations: 155.7 kB / 1.53 GB, free: 2.203 MB / 1.248 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003393/1.23, allocations: 4.192 MB / 1.534 GB, free: 13.71 MB / 1.264 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001031/1.231, allocations: 91.52 kB / 1.534 GB, free: 13.62 MB / 1.264 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 8.1e-05/1.231, allocations: 36 kB / 1.534 GB, free: 13.59 MB / 1.264 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 21
 * 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 (79):
 * Single equations (assignments): 75
 * Array equations: 1
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 3
 * 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): 3 systems
   {(2,21), (1,3), (1,3)}
Notification: Performance of prepare postOptimizeDAE: time 0.0002435/1.231, allocations: 232 kB / 1.534 GB, free: 13.36 MB / 1.264 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003052/1.232, allocations: 150.1 kB / 1.534 GB, free: 13.21 MB / 1.264 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002892/1.235, allocations: 1.209 MB / 1.535 GB, free: 11.98 MB / 1.264 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.002355/1.237, allocations: 1.275 MB / 1.537 GB, free: 10.61 MB / 1.264 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.418e-06/1.237, allocations: 0 / 1.537 GB, free: 10.61 MB / 1.264 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0005506/1.238, allocations: 323 kB / 1.537 GB, free: 10.27 MB / 1.264 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001996/1.238, allocations: 16 kB / 1.537 GB, free: 10.25 MB / 1.264 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0008225/1.239, allocations: 35.95 kB / 1.537 GB, free: 10.22 MB / 1.264 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000133/1.239, allocations: 52.58 kB / 1.537 GB, free: 10.16 MB / 1.264 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.002677/1.242, allocations: 1.154 MB / 1.538 GB, free: 8.996 MB / 1.264 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.002211/1.244, allocations: 1.445 MB / 1.539 GB, free: 7.527 MB / 1.264 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.000584/1.244, allocations: 341 kB / 1.54 GB, free: 7.199 MB / 1.264 GB
Notification: Performance of sorting global known variables: time 0.001253/1.246, allocations: 0.9016 MB / 1.541 GB, free: 6.301 MB / 1.264 GB
Notification: Performance of Backend: time 7.92e-07/1.246, allocations: 0 / 1.541 GB, free: 6.301 MB / 1.264 GB
Notification: Performance of simCode: created initialization part: time 0.004967/1.251, allocations: 2.056 MB / 1.543 GB, free: 4.223 MB / 1.264 GB
Notification: Performance of SimCode: time 0.006602/1.257, allocations: 3.778 MB / 1.546 GB, free: 416 kB / 1.264 GB
Notification: Performance of Templates: time 0.6797/1.937, allocations: 39.02 MB / 1.584 GB, free: 343.1 MB / 1.279 GB
make -j1 -f Buildings_latest_Buildings.Fluid.HeatExchangers.BaseClasses.Examples.HexElementLatent.makefile
(rm -f Buildings_latest_Buildings.Fluid.HeatExchangers.BaseClasses.Examples.HexElementLatent.pipe ; mkfifo Buildings_latest_Buildings.Fluid.HeatExchangers.BaseClasses.Examples.HexElementLatent.pipe ; head -c 1048576 < Buildings_latest_Buildings.Fluid.HeatExchangers.BaseClasses.Examples.HexElementLatent.pipe >> ../files/Buildings_latest_Buildings.Fluid.HeatExchangers.BaseClasses.Examples.HexElementLatent.sim & ./Buildings_latest_Buildings.Fluid.HeatExchangers.BaseClasses.Examples.HexElementLatent  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Fluid.HeatExchangers.BaseClasses.Examples.HexElementLatent.pipe 2>&1)