Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.001834/0.001834, allocations: 104 kB / 16.45 MB, free: 6.449 MB / 14.72 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.002127/0.002127, allocations: 210.4 kB / 19.43 MB, free: 3.637 MB / 14.72 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 1.467/1.467, allocations: 230.6 MB / 252.8 MB, free: 9.137 MB / 206.1 MB " [Timeout remaining time 178] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.1-maint.11.x/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.1-maint.11.x/package.mo): time 2.897/2.897, allocations: 476.7 MB / 0.7672 GB, free: 5.266 MB / 0.6231 GB " [Timeout remaining time 176] Using package Buildings with version 11.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.1-maint.11.x/package.mo) Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo) Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo) Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo) Running command: "" <> buildModelFMU(Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer,fileNamePrefix="Buildings_11_Buildings_DHC_ETS_Combined_Subsystems_Validation_WatersideEconomizer",fmuType="me",version="2.0",platforms={"static"}) "" <> buildModelFMU(Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer,fileNamePrefix="Buildings_11_Buildings_DHC_ETS_Combined_Subsystems_Validation_WatersideEconomizer",fmuType="me",version="2.0",platforms={"static"}) [Timeout 300] "Notification: Buildings requested package Modelica of version 4.0.0. Modelica 4.1.0 is used instead which states that it is fully compatible without conversion script needed. Notification: Performance of FrontEnd - loaded program: time 0.002101/0.002101, allocations: 75.88 kB / 1.112 GB, free: 1.566 MB / 0.9044 GB Notification: Performance of FrontEnd - Absyn->SCode: time 0.9545/0.9566, allocations: 169.9 MB / 1.278 GB, free: 13.42 MB / 0.9825 GB Notification: Performance of NFInst.instantiate(Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer): time 0.3666/1.323, allocations: 304.4 MB / 1.576 GB, free: 11.98 MB / 1.279 GB Notification: Performance of NFInst.instExpressions: time 1.17/2.493, allocations: 74.22 MB / 1.648 GB, free: 23.41 MB / 1.295 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.0166/2.51, allocations: 0.4997 MB / 1.649 GB, free: 23.41 MB / 1.295 GB Notification: Performance of NFTyping.typeComponents: time 0.01412/2.524, allocations: 4.94 MB / 1.653 GB, free: 23.32 MB / 1.295 GB Notification: Performance of NFTyping.typeBindings: time 0.03043/2.554, allocations: 10.61 MB / 1.664 GB, free: 22.93 MB / 1.295 GB Notification: Performance of NFTyping.typeClassSections: time 0.02861/2.583, allocations: 9.534 MB / 1.673 GB, free: 22.68 MB / 1.295 GB Notification: Performance of NFFlatten.flatten: time 0.05583/2.639, allocations: 32.9 MB / 1.705 GB, free: 22.46 MB / 1.295 GB Notification: Performance of NFFlatten.resolveConnections: time 0.01443/2.653, allocations: 6.548 MB / 1.712 GB, free: 22.01 MB / 1.295 GB Notification: Performance of NFEvalConstants.evaluate: time 0.02379/2.677, allocations: 9.452 MB / 1.721 GB, free: 21.27 MB / 1.295 GB Notification: Performance of NFSimplifyModel.simplify: time 0.01297/2.69, allocations: 6.651 MB / 1.727 GB, free: 18.6 MB / 1.295 GB Notification: Performance of NFPackage.collectConstants: time 0.004049/2.694, allocations: 0.9954 MB / 1.728 GB, free: 18.6 MB / 1.295 GB Notification: Performance of NFFlatten.collectFunctions: time 0.02163/2.716, allocations: 6.322 MB / 1.734 GB, free: 15.98 MB / 1.295 GB Notification: Performance of NFScalarize.scalarize: time 0.006406/2.722, allocations: 2.878 MB / 1.737 GB, free: 13.86 MB / 1.295 GB Notification: Performance of NFVerifyModel.verify: time 0.01325/2.735, allocations: 5.445 MB / 1.743 GB, free: 10.13 MB / 1.295 GB Notification: Performance of NFConvertDAE.convert: time 0.03529/2.771, allocations: 17.58 MB / 1.76 GB, free: 12.93 MB / 1.311 GB Notification: Performance of FrontEnd - DAE generated: time 8.727e-06/2.771, allocations: 0 / 1.76 GB, free: 12.93 MB / 1.311 GB Notification: Performance of FrontEnd: time 1.943e-06/2.771, allocations: 0 / 1.76 GB, free: 12.93 MB / 1.311 GB Notification: Performance of Transformations before backend: time 0.0006995/2.771, allocations: 0 / 1.76 GB, free: 12.93 MB / 1.311 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 1327 * Number of variables: 1327 Notification: Performance of Generate backend data structure: time 0.03534/2.807, allocations: 11.13 MB / 1.771 GB, free: 1.848 MB / 1.311 GB Notification: Performance of prepare preOptimizeDAE: time 5.139e-05/2.807, allocations: 8.031 kB / 1.771 GB, free: 1.84 MB / 1.311 GB Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.002518/2.809, allocations: 0.6791 MB / 1.771 GB, free: 1.152 MB / 1.311 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01191/2.821, allocations: 1.957 MB / 1.773 GB, free: 15.19 MB / 1.326 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.03264/2.854, allocations: 13.11 MB / 1.786 GB, free: 2.473 MB / 1.326 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0008387/2.855, allocations: 445.4 kB / 1.786 GB, free: 2.039 MB / 1.326 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.002364/2.857, allocations: 0.5703 MB / 1.787 GB, free: 1.469 MB / 1.326 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.02045/2.877, allocations: 6.451 MB / 1.793 GB, free: 10.84 MB / 1.342 GB Notification: Performance of preOpt findStateOrder (simulation): time 0.0002196/2.878, allocations: 13.33 kB / 1.793 GB, free: 10.84 MB / 1.342 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.00154/2.879, allocations: 216 kB / 1.793 GB, free: 10.62 MB / 1.342 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002621/2.879, allocations: 185.8 kB / 1.794 GB, free: 10.44 MB / 1.342 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01792/2.897, allocations: 5.573 MB / 1.799 GB, free: 4.902 MB / 1.342 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.06338/2.961, allocations: 31.41 MB / 1.83 GB, free: 4.156 MB / 1.373 GB Notification: Performance of preOpt comSubExp (simulation): time 0.01242/2.973, allocations: 4.346 MB / 1.834 GB, free: 15.72 MB / 1.389 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.006162/2.979, allocations: 2.044 MB / 1.836 GB, free: 13.67 MB / 1.389 GB Notification: Performance of preOpt evalFunc (simulation): time 0.02796/3.007, allocations: 12.2 MB / 1.848 GB, free: 0.6758 MB / 1.389 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.007393/3.015, allocations: 2.828 MB / 1.851 GB, free: 13.8 MB / 1.404 GB Notification: Performance of preOpt simplifyInStream (simulation): time 0.004507/3.019, allocations: 0.6316 MB / 1.851 GB, free: 13.17 MB / 1.404 GB Notification: Performance of pre-optimization done (n=390): time 2.075e-05/3.019, allocations: 0 / 1.851 GB, free: 13.17 MB / 1.404 GB Notification: Performance of matching and sorting (n=390): time 0.03359/3.053, allocations: 8.497 MB / 1.86 GB, free: 4.57 MB / 1.404 GB Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002115/3.053, allocations: 268.6 kB / 1.86 GB, free: 4.258 MB / 1.404 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01563/3.069, allocations: 7.472 MB / 1.867 GB, free: 12.81 MB / 1.42 GB Notification: Performance of collectPreVariables (initialization): time 0.001153/3.07, allocations: 149.7 kB / 1.867 GB, free: 12.66 MB / 1.42 GB Notification: Performance of collectInitialEqns (initialization): time 0.004383/3.074, allocations: 3.775 MB / 1.871 GB, free: 8.922 MB / 1.42 GB Notification: Performance of collectInitialBindings (initialization): time 0.00199/3.076, allocations: 1.326 MB / 1.872 GB, free: 7.617 MB / 1.42 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.002631/3.079, allocations: 1.43 MB / 1.874 GB, free: 6.18 MB / 1.42 GB Notification: Performance of setup shared object (initialization): time 0.0001417/3.079, allocations: 305.1 kB / 1.874 GB, free: 5.879 MB / 1.42 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.006506/3.085, allocations: 2.914 MB / 1.877 GB, free: 2.957 MB / 1.42 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.008502/3.094, allocations: 4.32 MB / 1.881 GB, free: 14.12 MB / 1.436 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.01432/3.108, allocations: 6.801 MB / 1.888 GB, free: 6.938 MB / 1.436 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.28e-05/3.108, allocations: 12 kB / 1.888 GB, free: 6.926 MB / 1.436 GB Notification: Performance of matching and sorting (n=848) (initialization): time 0.02567/3.134, allocations: 8.866 MB / 1.896 GB, free: 13.97 MB / 1.451 GB Notification: Performance of prepare postOptimizeDAE: time 0.0001103/3.134, allocations: 83.39 kB / 1.896 GB, free: 13.88 MB / 1.451 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.765e-05/3.134, allocations: 35.94 kB / 1.896 GB, free: 13.84 MB / 1.451 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.005001/3.139, allocations: 0.9143 MB / 1.897 GB, free: 12.92 MB / 1.451 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.006224/3.145, allocations: 1.24 MB / 1.899 GB, free: 11.68 MB / 1.451 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.004777/3.15, allocations: 3.741 MB / 1.902 GB, free: 7.812 MB / 1.451 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.006972/3.157, allocations: 371.9 kB / 1.903 GB, free: 7.449 MB / 1.451 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001333/3.158, allocations: 307.9 kB / 1.903 GB, free: 7.148 MB / 1.451 GB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.01205/3.17, allocations: 4.297 MB / 1.907 GB, free: 2.848 MB / 1.451 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.01127/3.182, allocations: 4.204 MB / 1.911 GB, free: 14.11 MB / 1.467 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.01496/3.197, allocations: 6.545 MB / 1.918 GB, free: 7.051 MB / 1.467 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 4.202e-05/3.197, allocations: 8 kB / 1.918 GB, free: 7.043 MB / 1.467 GB Notification: Performance of matching and sorting (n=848) (initialization_lambda0): time 0.02776/3.224, allocations: 8.481 MB / 1.926 GB, free: 14.46 MB / 1.482 GB Notification: Performance of prepare postOptimizeDAE: time 0.0001456/3.225, allocations: 79.39 kB / 1.926 GB, free: 14.37 MB / 1.482 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.041e-05/3.225, allocations: 32 kB / 1.926 GB, free: 14.34 MB / 1.482 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.004987/3.23, allocations: 0.8423 MB / 1.927 GB, free: 13.48 MB / 1.482 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.006593/3.236, allocations: 1.236 MB / 1.928 GB, free: 12.25 MB / 1.482 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.008279/3.245, allocations: 5.578 MB / 1.933 GB, free: 6.363 MB / 1.482 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.007711/3.252, allocations: 401.9 kB / 1.934 GB, free: 5.973 MB / 1.482 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001492/3.254, allocations: 291.9 kB / 1.934 GB, free: 5.688 MB / 1.482 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 146 * Number of states: 0 () * Number of discrete variables: 119 ($PRE.hexPum.conWSE.ena.enableFire,$PRE.hexPum.conWSE.dis.enableFire,$PRE.hexPum.conWSE.isValIsoEvaClo.lesHys.y,$PRE.hexVal.conWSE.ena.enableFire,$PRE.hexVal.conWSE.dis.enableFire,$PRE.hexVal.conWSE.isValIsoEvaClo.lesHys.y,hexVal.conWSE.dis.t_start,$PRE.hexVal.conWSE.dis.t_start,hexVal.conWSE.ena.t_start,$PRE.hexVal.conWSE.ena.t_start,hexPum.conWSE.dis.t_start,$PRE.hexPum.conWSE.dis.t_start,hexPum.conWSE.ena.t_start,$PRE.hexPum.conWSE.ena.t_start,hexVal.conWSE.stateGraphRoot.resume,hexVal.conWSE.stateGraphRoot.suspend,hexPum.conWSE.stateGraphRoot.resume,hexPum.conWSE.stateGraphRoot.suspend,hexPum.hex.flowRegime_nominal,hexPum.hex.flowRegime,hexVal.hex.flowRegime_nominal,hexVal.hex.flowRegime,hexPum.conWSE.isValIsoEvaClo.lesHys.y,hexVal.conWSE.isValIsoEvaClo.lesHys.y,TSerWat.nextEventScaled,TSerWat.nextEvent,$PRE.TSerWat.nextEvent,TSerWat.last,TSerWat.b,TSerWat.a,TChiWatRet.nextEventScaled,TChiWatRet.nextEvent,$PRE.TChiWatRet.nextEvent,TChiWatRet.last,TChiWatRet.b,TChiWatRet.a,hexVal.uCoo,hexVal.conWSE.and1.y,hexVal.conWSE.tim1.entryTime,$PRE.hexVal.conWSE.tim1.entryTime,hexVal.conWSE.tim1.passed,$PRE.hexVal.conWSE.tim1.passed,hexVal.conWSE.tim.entryTime,$PRE.hexVal.conWSE.tim.entryTime,hexVal.conWSE.tim.passed,$PRE.hexVal.conWSE.tim.passed,hexVal.conWSE.or1.uTemp[2],hexVal.conWSE.or1.y,hexVal.conWSE.or1.u[1],hexVal.conWSE.mulAnd.uTemp[3],hexVal.conWSE.mulAnd.uTemp[2],hexVal.conWSE.mulAnd.u[1],hexVal.conWSE.stateGraphRoot.activeSteps,hexVal.conWSE.dis.enableFire,hexVal.conWSE.dis.localCondition,hexVal.conWSE.actSta.active,hexVal.conWSE.actSta.oldActive,$PRE.hexVal.conWSE.actSta.oldActive,hexVal.conWSE.actSta.newActive,$PRE.hexVal.conWSE.actSta.newActive,hexVal.conWSE.actSta.localActive,$PRE.hexVal.conWSE.actSta.localActive,hexVal.conWSE.ena.enableFire,hexVal.conWSE.ena.localCondition,hexVal.conWSE.iniSta.active,hexVal.conWSE.iniSta.oldActive,$PRE.hexVal.conWSE.iniSta.oldActive,hexVal.conWSE.iniSta.newActive,$PRE.hexVal.conWSE.iniSta.newActive,hexVal.conWSE.iniSta.localActive,$PRE.hexVal.conWSE.iniSta.localActive,hexPum.conWSE.and1.y,hexPum.conWSE.tim1.entryTime,$PRE.hexPum.conWSE.tim1.entryTime,hexPum.conWSE.tim1.passed,$PRE.hexPum.conWSE.tim1.passed,hexPum.conWSE.tim.entryTime,$PRE.hexPum.conWSE.tim.entryTime,hexPum.conWSE.tim.passed,$PRE.hexPum.conWSE.tim.passed,hexPum.conWSE.or1.uTemp[2],hexPum.conWSE.or1.y,hexPum.conWSE.or1.u[1],hexPum.conWSE.mulAnd.uTemp[3],hexPum.conWSE.mulAnd.uTemp[2],hexPum.conWSE.mulAnd.u[1],hexPum.conWSE.stateGraphRoot.activeSteps,hexPum.conWSE.dis.enableFire,hexPum.conWSE.dis.localCondition,hexPum.conWSE.actSta.active,hexPum.conWSE.actSta.oldActive,$PRE.hexPum.conWSE.actSta.oldActive,hexPum.conWSE.actSta.newActive,$PRE.hexPum.conWSE.actSta.newActive,hexPum.conWSE.actSta.localActive,$PRE.hexPum.conWSE.actSta.localActive,hexPum.conWSE.ena.enableFire,hexPum.conWSE.ena.localCondition,hexPum.conWSE.iniSta.active,hexPum.conWSE.iniSta.oldActive,$PRE.hexPum.conWSE.iniSta.oldActive,hexPum.conWSE.iniSta.newActive,$PRE.hexPum.conWSE.iniSta.newActive,hexPum.conWSE.iniSta.localActive,$PRE.hexPum.conWSE.iniSta.localActive,$whenCondition14,$whenCondition13,$whenCondition3,$whenCondition2,$whenCondition1,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition9,$whenCondition8,$whenCondition7,$whenCondition12,$whenCondition11,$whenCondition10) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (697): * Single equations (assignments): 684 * Array equations: 3 * Algorithm blocks: 2 * Record equations: 3 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 1 * Torn equation systems: 4 * 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): 1 system {1} * Without analytic Jacobian (size): 0 systems 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): 4 systems {(2,12), (1,7), (3,11), (1,7)} Notification: Performance of prepare postOptimizeDAE: time 0.002802/3.257, allocations: 0.6429 MB / 1.935 GB, free: 5.023 MB / 1.482 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.003224/3.26, allocations: 0.8227 MB / 1.936 GB, free: 4.195 MB / 1.482 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02261/3.282, allocations: 7.004 MB / 1.942 GB, free: 13.24 MB / 1.498 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001204/3.283, allocations: 59.98 kB / 1.942 GB, free: 13.18 MB / 1.498 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 1.845e-05/3.283, allocations: 0 / 1.942 GB, free: 13.18 MB / 1.498 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01523/3.298, allocations: 5.174 MB / 1.947 GB, free: 7.953 MB / 1.498 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.04654/3.344, allocations: 13.5 MB / 1.961 GB, free: 10.41 MB / 1.514 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.356e-05/3.344, allocations: 8.25 kB / 1.961 GB, free: 10.41 MB / 1.514 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.004394/3.349, allocations: 0.7021 MB / 1.961 GB, free: 9.703 MB / 1.514 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.002955/3.352, allocations: 0.6051 MB / 1.962 GB, free: 9.09 MB / 1.514 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0009895/3.353, allocations: 135.9 kB / 1.962 GB, free: 8.957 MB / 1.514 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.004681/3.357, allocations: 3.559 MB / 1.966 GB, free: 5.277 MB / 1.514 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 7.744e-06/3.357, allocations: 7.938 kB / 1.966 GB, free: 5.27 MB / 1.514 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.02708/3.384, allocations: 9.281 MB / 1.975 GB, free: 11.82 MB / 1.529 GB Notification: Performance of postOpt removeConstants (simulation): time 0.004824/3.389, allocations: 1.53 MB / 1.976 GB, free: 10.26 MB / 1.529 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.002459/3.392, allocations: 104 kB / 1.976 GB, free: 10.16 MB / 1.529 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.006076/3.398, allocations: 308.4 kB / 1.976 GB, free: 9.855 MB / 1.529 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001132/3.399, allocations: 341.7 kB / 1.977 GB, free: 9.523 MB / 1.529 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0008377/3.4, allocations: 191.9 kB / 1.977 GB, free: 9.336 MB / 1.529 GB Notification: Performance of sorting global known variables: time 0.01232/3.412, allocations: 4.872 MB / 1.982 GB, free: 4.496 MB / 1.529 GB Notification: Performance of sort global known variables: time 2.1e-07/3.412, allocations: 0 / 1.982 GB, free: 4.496 MB / 1.529 GB Notification: Performance of remove unused functions: time 0.0171/3.429, allocations: 4.257 MB / 1.986 GB, free: 236 kB / 1.529 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 13 * Number of states: 20 (pum2Pum.vol.dynBal.U,pum2Pum.filter.s[1],pum2Pum.filter.s[2],hexPum.senT2WatEnt.T,hexPum.senT2WatLvg.T,hexPum.senT1WatEnt.T,senT1OutPum.T,senT1InlPum.T,senT2OutPum.T,senT2InlPum.T,hexVal.senT2WatEnt.T,hexVal.senT2WatLvg.T,hexVal.senT1WatEnt.T,senT1InlVal.T,senT1OutVal.T,senT2OutVal.T,senT2InlVal.T,pum2Val.vol.dynBal.U,pum2Val.filter.s[1],pum2Val.filter.s[2]) * Number of discrete variables: 77 (hexVal.conWSE.actSta.localActive,hexVal.conWSE.actSta.active,hexVal.conWSE.iniSta.localActive,hexVal.conWSE.iniSta.active,hexPum.conWSE.actSta.localActive,hexPum.conWSE.actSta.active,hexPum.conWSE.iniSta.localActive,hexPum.conWSE.iniSta.active,$whenCondition10,$whenCondition11,$whenCondition12,$whenCondition7,$whenCondition8,$whenCondition9,$whenCondition4,$whenCondition5,$whenCondition6,$whenCondition1,$whenCondition2,$whenCondition3,$whenCondition13,$whenCondition14,hexPum.conWSE.iniSta.newActive,hexPum.conWSE.iniSta.oldActive,hexPum.conWSE.ena.localCondition,hexPum.conWSE.ena.enableFire,hexPum.conWSE.actSta.newActive,hexPum.conWSE.actSta.oldActive,hexPum.conWSE.dis.localCondition,hexPum.conWSE.dis.enableFire,hexPum.conWSE.stateGraphRoot.activeSteps,hexPum.conWSE.mulAnd.u[1],hexPum.conWSE.mulAnd.uTemp[2],hexPum.conWSE.mulAnd.uTemp[3],hexPum.conWSE.or1.u[1],hexPum.conWSE.or1.y,hexPum.conWSE.or1.uTemp[2],hexPum.conWSE.tim.passed,hexPum.conWSE.tim.entryTime,hexPum.conWSE.tim1.passed,hexPum.conWSE.tim1.entryTime,hexPum.conWSE.and1.y,hexVal.conWSE.iniSta.newActive,hexVal.conWSE.iniSta.oldActive,hexVal.conWSE.ena.localCondition,hexVal.conWSE.ena.enableFire,hexVal.conWSE.actSta.newActive,hexVal.conWSE.actSta.oldActive,hexVal.conWSE.dis.localCondition,hexVal.conWSE.dis.enableFire,hexVal.conWSE.stateGraphRoot.activeSteps,hexVal.conWSE.mulAnd.u[1],hexVal.conWSE.mulAnd.uTemp[2],hexVal.conWSE.mulAnd.uTemp[3],hexVal.conWSE.or1.u[1],hexVal.conWSE.or1.y,hexVal.conWSE.or1.uTemp[2],hexVal.conWSE.tim.passed,hexVal.conWSE.tim.entryTime,hexVal.conWSE.tim1.passed,hexVal.conWSE.tim1.entryTime,hexVal.conWSE.and1.y,hexVal.uCoo,TChiWatRet.a,TChiWatRet.b,TChiWatRet.last,TChiWatRet.nextEvent,TChiWatRet.nextEventScaled,TSerWat.a,TSerWat.b,TSerWat.last,TSerWat.nextEvent,TSerWat.nextEventScaled,hexPum.conWSE.ena.t_start,hexPum.conWSE.dis.t_start,hexVal.conWSE.ena.t_start,hexVal.conWSE.dis.t_start) * Number of discrete states: 24 (hexVal.conWSE.dis.t_start,hexVal.conWSE.ena.t_start,hexPum.conWSE.dis.t_start,hexPum.conWSE.ena.t_start,hexPum.conWSE.iniSta.newActive,hexPum.conWSE.tim1.entryTime,hexPum.conWSE.actSta.newActive,hexPum.conWSE.tim.entryTime,hexVal.conWSE.iniSta.newActive,hexVal.conWSE.tim1.entryTime,hexVal.conWSE.actSta.newActive,hexVal.conWSE.tim.entryTime,TChiWatRet.nextEvent,TChiWatRet.last,TChiWatRet.nextEventScaled,TChiWatRet.b,TChiWatRet.a,$whenCondition14,TSerWat.nextEvent,TSerWat.last,TSerWat.nextEventScaled,TSerWat.b,TSerWat.a,$whenCondition13) * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for simulation (418): * Single equations (assignments): 357 * Array equations: 0 * Algorithm blocks: 2 * Record equations: 38 * When equations: 16 * If-equations: 0 * Equation systems (not torn): 1 * Torn equation systems: 4 * 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): 1 system {1} * Without analytic Jacobian (size): 0 systems 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): 4 systems {(3,15), (4,14), (1,7), (1,7)} Notification: Performance of Backend phase and start with SimCode phase: time 0.02985/3.459, allocations: 11.51 MB / 1.997 GB, free: 4.652 MB / 1.545 GB Notification: Performance of simCode: created initialization part: time 0.0292/3.488, allocations: 10.48 MB / 2.007 GB, free: 10.09 MB / 1.561 GB Notification: Performance of simCode: created event and clocks part: time 1.057e-05/3.488, allocations: 0 / 2.007 GB, free: 10.09 MB / 1.561 GB Notification: Performance of simCode: created simulation system equations: time 0.008283/3.497, allocations: 2.78 MB / 2.01 GB, free: 7.293 MB / 1.561 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01967/3.516, allocations: 3.801 MB / 2.014 GB, free: 3.551 MB / 1.561 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.1512/3.667, allocations: 60.49 MB / 2.073 GB, free: 5.766 MB / 1.623 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.007759/3.675, allocations: 4.106 MB / 2.077 GB, free: 1.629 MB / 1.623 GB Notification: Performance of simCode: alias equations: time 0.01232/3.687, allocations: 2.074 MB / 2.079 GB, free: 15.55 MB / 1.639 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.008868/3.696, allocations: 3.951 MB / 2.083 GB, free: 11.6 MB / 1.639 GB Notification: Performance of SimCode: time 1.764e-06/3.696, allocations: 0 / 2.083 GB, free: 11.6 MB / 1.639 GB Notification: Performance of buildModelFMU: Generate the FMI files: time 1.15/4.846, allocations: 232.4 MB / 2.31 GB, free: 0.748 GB / 1.795 GB Notification: Performance of buildModelFMU: Generate platform static: time 36.7/41.55, allocations: 7.938 kB / 2.31 GB, free: 0.748 GB / 1.795 GB " [Timeout remaining time 258] (rm -f Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer.pipe ; mkfifo Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer.pipe ; head -c 1048576 < Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer.pipe >> ../files/Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer.sim & python3 -m fmpy simulate --output-file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv --start-time 0 --stop-time 5000 --timeout 400 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 2 Buildings_11_Buildings_DHC_ETS_Combined_Subsystems_Validation_WatersideEconomizer.fmu > Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer.pipe 2>&1) [Timeout 420.0] diffSimulationResults("Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv","/mnt/ReferenceFiles/Buildings/csv/maint_11.x/Buildings_DHC_ETS_Combined_Subsystems_Validation_WatersideEconomizer.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 300] "Error: Could not read variable senT1InlPum.T in file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv. Warning: Get data of variable senT1InlPum.T from file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv failed! Error: Could not read variable senT2InlPum.T in file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv. Warning: Get data of variable senT2InlPum.T from file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv failed! Error: Could not read variable hexPum.conWSE.calTemLvg.T2WatLvg in file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv. Warning: Get data of variable hexPum.conWSE.calTemLvg.T2WatLvg from file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv failed! Error: Could not read variable senT2OutPum.T in file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv. Warning: Get data of variable senT2OutPum.T from file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv failed! Error: Could not read variable hexPum.m1_flow in file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv. Warning: Get data of variable hexPum.m1_flow from file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv failed! Error: Could not read variable hexPum.m1_flow_nominal in file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv. Warning: Get data of variable hexPum.m1_flow_nominal from file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv failed! Error: Could not read variable hexPum.m2_flow_nominal in file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv. Warning: Get data of variable hexPum.m2_flow_nominal from file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv failed! Error: Could not read variable hexPum.hex.m2_flow in file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv. Warning: Get data of variable hexPum.hex.m2_flow from file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv failed! Error: Could not read variable hexPum.conWSE.y1 in file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv. Warning: Get data of variable hexPum.conWSE.y1 from file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv failed! Error: Could not read variable hexPum.conWSE.yVal2 in file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv. Warning: Get data of variable hexPum.conWSE.yVal2 from file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv failed! Error: Could not read variable senT1InlVal.T in file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv. Warning: Get data of variable senT1InlVal.T from file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv failed! Error: Could not read variable senT2InlVal.T in file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv. Warning: Get data of variable senT2InlVal.T from file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv failed! Error: Could not read variable hexVal.conWSE.calTemLvg.T2WatLvg in file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv. Warning: Get data of variable hexVal.conWSE.calTemLvg.T2WatLvg from file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv failed! Error: Could not read variable senT2OutVal.T in file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv. Warning: Get data of variable senT2OutVal.T from file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv failed! Error: Could not read variable hexVal.m1_flow in file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv. Warning: Get data of variable hexVal.m1_flow from file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv failed! Error: Could not read variable hexVal.m1_flow_nominal in file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv. Warning: Get data of variable hexVal.m1_flow_nominal from file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv failed! Error: Could not read variable hexVal.m2_flow_nominal in file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv. Warning: Get data of variable hexVal.m2_flow_nominal from file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv failed! Error: Could not read variable hexVal.hex.m2_flow in file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv. Warning: Get data of variable hexVal.hex.m2_flow from file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv failed! Error: Could not read variable hexVal.conWSE.y1 in file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv. Warning: Get data of variable hexVal.conWSE.y1 from file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv failed! Error: Could not read variable hexVal.conWSE.yVal2 in file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv. Warning: Get data of variable hexVal.conWSE.yVal2 from file Buildings_11_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.csv failed! " [Timeout remaining time 300] Reference file matches [Calling sys.exit(0), Time elapsed: 48.23404865292832]