Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Fluid.HeatExchangers.Examples.WetCoilCounterFlowPIControlAutoTuningFailure.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.00194/0.00194, allocations: 105.1 kB / 18.99 MB, free: 2.766 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.002348/0.002348, allocations: 217 kB / 22.29 MB, free: 5.148 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.549/1.549, allocations: 230.6 MB / 256.1 MB, free: 7.773 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo): time 3.528/3.528, allocations: 0.5096 GB / 0.8148 GB, free: 18.4 MB / 0.6231 GB
"
[Timeout remaining time 176]
Using package Buildings with version 13.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/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: translateModel(Buildings.Fluid.HeatExchangers.Examples.WetCoilCounterFlowPIControlAutoTuningFailure,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|hex.m1_flow|hex.m2_flow|con.u_s|con.u_m|hex.Q1_flow|hex.Q2_flow|hex.QLat2_flow|hex.QSen2_flow|autTunSig.y|con.inTunPro.y|con.con.k|con.con.Ti",fileNamePrefix="Buildings_latest_Buildings.Fluid.HeatExchangers.Examples.WetCoilCounterFlowPIControlAutoTuningFailure")
translateModel(Buildings.Fluid.HeatExchangers.Examples.WetCoilCounterFlowPIControlAutoTuningFailure,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|hex.m1_flow|hex.m2_flow|con.u_s|con.u_m|hex.Q1_flow|hex.Q2_flow|hex.QLat2_flow|hex.QSen2_flow|autTunSig.y|con.inTunPro.y|con.con.k|con.con.Ti",fileNamePrefix="Buildings_latest_Buildings.Fluid.HeatExchangers.Examples.WetCoilCounterFlowPIControlAutoTuningFailure") [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.002203/0.002203, allocations: 71.48 kB / 1.184 GB, free: 14.59 MB / 0.9044 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4035/0.4057, allocations: 181.4 MB / 1.362 GB, free: 15.69 MB / 1.061 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.HeatExchangers.Examples.WetCoilCounterFlowPIControlAutoTuningFailure): time 0.3338/0.7395, allocations: 253 MB / 1.609 GB, free: 1.812 MB / 1.295 GB
Notification: Performance of NFInst.instExpressions: time 1.031/1.771, allocations: 24.38 MB / 1.632 GB, free: 26.26 MB / 1.295 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.007829/1.779, allocations: 194.5 kB / 1.633 GB, free: 26.26 MB / 1.295 GB
Notification: Performance of NFTyping.typeComponents: time 0.006462/1.785, allocations: 1.696 MB / 1.634 GB, free: 26.24 MB / 1.295 GB
Notification: Performance of NFTyping.typeBindings: time 0.02011/1.805, allocations: 5.016 MB / 1.639 GB, free: 26.09 MB / 1.295 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01478/1.82, allocations: 4.24 MB / 1.643 GB, free: 26.02 MB / 1.295 GB
Notification: Performance of NFFlatten.flatten: time 0.03834/1.858, allocations: 21.71 MB / 1.664 GB, free: 25.99 MB / 1.295 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.01614/1.874, allocations: 7.816 MB / 1.672 GB, free: 25.44 MB / 1.295 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.02364/1.898, allocations: 8.392 MB / 1.68 GB, free: 25.15 MB / 1.295 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01579/1.914, allocations: 6.845 MB / 1.687 GB, free: 22.54 MB / 1.295 GB
Notification: Performance of NFPackage.collectConstants: time 0.004726/1.919, allocations: 1.221 MB / 1.688 GB, free: 22.54 MB / 1.295 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01658/1.935, allocations: 4.532 MB / 1.693 GB, free: 21.95 MB / 1.295 GB
Notification: Performance of NFScalarize.scalarize: time 0.006274/1.941, allocations: 3.029 MB / 1.696 GB, free: 20.19 MB / 1.295 GB
Notification: Performance of NFVerifyModel.verify: time 0.01244/1.954, allocations: 4.383 MB / 1.7 GB, free: 17.78 MB / 1.295 GB
Notification: Performance of NFConvertDAE.convert: time 0.02923/1.983, allocations: 18.98 MB / 1.718 GB, free: 11.44 MB / 1.295 GB
Notification: Performance of FrontEnd - DAE generated: time 6.913e-06/1.983, allocations: 0.9062 kB / 1.718 GB, free: 11.44 MB / 1.295 GB
Notification: Performance of FrontEnd: time 1.924e-06/1.983, allocations: 0 / 1.718 GB, free: 11.44 MB / 1.295 GB
Notification: Performance of Transformations before backend: time 0.00061/1.984, allocations: 0.875 kB / 1.718 GB, free: 11.44 MB / 1.295 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1758
 * Number of variables: 1758
Notification: Performance of Generate backend data structure: time 0.02898/2.013, allocations: 11.81 MB / 1.73 GB, free: 3.625 MB / 1.295 GB
Notification: Performance of prepare preOptimizeDAE: time 5.855e-05/2.013, allocations: 11.88 kB / 1.73 GB, free: 3.625 MB / 1.295 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0116/2.024, allocations: 1.811 MB / 1.732 GB, free: 2.77 MB / 1.295 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01822/2.043, allocations: 7.777 MB / 1.739 GB, free: 13.87 MB / 1.311 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0005601/2.043, allocations: 0.5272 MB / 1.74 GB, free: 13.63 MB / 1.311 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.002569/2.046, allocations: 0.7117 MB / 1.74 GB, free: 13.4 MB / 1.311 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02209/2.068, allocations: 9.912 MB / 1.75 GB, free: 7.082 MB / 1.311 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001686/2.068, allocations: 9.578 kB / 1.75 GB, free: 7.078 MB / 1.311 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0008181/2.069, allocations: 288.6 kB / 1.75 GB, free: 6.863 MB / 1.311 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002757/2.069, allocations: 296.6 kB / 1.751 GB, free: 6.82 MB / 1.311 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01731/2.086, allocations: 7.697 MB / 1.758 GB, free: 2.879 MB / 1.311 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.06136/2.148, allocations: 24.34 MB / 1.782 GB, free: 14.39 MB / 1.342 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.009664/2.157, allocations: 5.206 MB / 1.787 GB, free: 9.238 MB / 1.342 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.005466/2.163, allocations: 3.103 MB / 1.79 GB, free: 6.117 MB / 1.342 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0009633/2.164, allocations: 183.4 kB / 1.79 GB, free: 5.938 MB / 1.342 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.006488/2.17, allocations: 4.022 MB / 1.794 GB, free: 1.672 MB / 1.342 GB
Notification: Performance of pre-optimization done (n=479): time 8.436e-06/2.17, allocations: 0 / 1.794 GB, free: 1.672 MB / 1.342 GB
Notification: Performance of matching and sorting (n=483): time 0.03933/2.21, allocations: 16.03 MB / 1.81 GB, free: 1.578 MB / 1.357 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001779/2.21, allocations: 196.2 kB / 1.81 GB, free: 1.355 MB / 1.357 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0108/2.221, allocations: 5.412 MB / 1.815 GB, free: 11.96 MB / 1.373 GB
Notification: Performance of collectPreVariables (initialization): time 0.001399/2.222, allocations: 168.4 kB / 1.816 GB, free: 11.8 MB / 1.373 GB
Notification: Performance of collectInitialEqns (initialization): time 0.004543/2.227, allocations: 3.432 MB / 1.819 GB, free: 8.367 MB / 1.373 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002957/2.23, allocations: 1.62 MB / 1.82 GB, free: 6.773 MB / 1.373 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.002214/2.232, allocations: 0.9957 MB / 1.821 GB, free: 5.77 MB / 1.373 GB
Notification: Performance of setup shared object (initialization): time 0.0001693/2.232, allocations: 309.1 kB / 1.822 GB, free: 5.465 MB / 1.373 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.004643/2.237, allocations: 2.51 MB / 1.824 GB, free: 2.93 MB / 1.373 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.006599/2.243, allocations: 4.569 MB / 1.829 GB, free: 13.75 MB / 1.389 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01079/2.254, allocations: 5.939 MB / 1.834 GB, free: 7.551 MB / 1.389 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.635e-05/2.254, allocations: 4 kB / 1.834 GB, free: 7.547 MB / 1.389 GB
Notification: Performance of matching and sorting (n=663) (initialization): time 0.01572/2.27, allocations: 7.07 MB / 1.841 GB, free: 492 kB / 1.389 GB
Notification: Performance of prepare postOptimizeDAE: time 0.00012/2.27, allocations: 75.39 kB / 1.841 GB, free: 404 kB / 1.389 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.104e-05/2.27, allocations: 16 kB / 1.841 GB, free: 388 kB / 1.389 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.00113/2.271, allocations: 285.6 kB / 1.842 GB, free: 96 kB / 1.389 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005215/2.276, allocations: 1.017 MB / 1.843 GB, free: 15.14 MB / 1.404 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.004021/2.28, allocations: 3.537 MB / 1.846 GB, free: 11.49 MB / 1.404 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.007032/2.287, allocations: 374.8 kB / 1.846 GB, free: 11.13 MB / 1.404 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001316/2.289, allocations: 199.8 kB / 1.847 GB, free: 10.93 MB / 1.404 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.01246/2.301, allocations: 4.882 MB / 1.851 GB, free: 6.027 MB / 1.404 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.007928/2.309, allocations: 4.538 MB / 1.856 GB, free: 0.875 MB / 1.404 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.01288/2.322, allocations: 5.889 MB / 1.862 GB, free: 10.73 MB / 1.42 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 4.417e-05/2.322, allocations: 4 kB / 1.862 GB, free: 10.73 MB / 1.42 GB
Notification: Performance of matching and sorting (n=663) (initialization_lambda0): time 0.01852/2.34, allocations: 6.986 MB / 1.868 GB, free: 3.738 MB / 1.42 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001115/2.341, allocations: 82.02 kB / 1.869 GB, free: 3.648 MB / 1.42 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.089e-05/2.341, allocations: 16 kB / 1.869 GB, free: 3.633 MB / 1.42 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0008041/2.341, allocations: 241.2 kB / 1.869 GB, free: 3.395 MB / 1.42 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004988/2.346, allocations: 0.9854 MB / 1.87 GB, free: 2.473 MB / 1.42 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.005157/2.352, allocations: 4.294 MB / 1.874 GB, free: 14.02 MB / 1.436 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.006511/2.358, allocations: 400.8 kB / 1.874 GB, free: 13.63 MB / 1.436 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0009505/2.359, allocations: 188 kB / 1.875 GB, free: 13.45 MB / 1.436 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 82
 * Number of states: 0 ()
 * Number of discrete variables: 118 ($PRE.con.resPro.norTimDel.tunEndDel.u,$PRE.con.tunStaDel.u,$whenCondition20,$PRE.con.resPro.norTimDel.tunEndDel.t_next,$whenCondition13,$PRE.con.tunStaDel.t_next,$whenCondition5,$whenCondition2,$whenCondition3,con.resPro.norTimDel.tunEndDel.t_next,con.tunStaDel.t_next,autTunSig.y,$PRE.autTunSig.y,con.falEdg.not_u,$PRE.con.falEdg.not_u,con.falEdg.y,con.greThr.greHys.y,$PRE.con.greThr.greHys.y,con.sam_u_s.y,$PRE.con.sam_u_s.y,con.tunStaDel.y,con.tunStaDel.u,con.edgReq.u,$PRE.con.edgReq.u,con.nand.y,con.nand.u2,con.samTi.y,$PRE.con.samTi.y,con.samTi.trigger,con.samk.y,$PRE.con.samk.y,con.inTunPro.y,$PRE.con.inTunPro.y,con.inTunPro.clr,con.inTunPro.u,con.conProMod.not1.y,con.conProMod.samTau.y,$PRE.con.conProMod.samTau.y,con.conProMod.samT.y,$PRE.con.conProMod.samT.y,con.conProMod.samtOn.y,$PRE.con.conProMod.samtOn.y,con.conProMod.samL.y,$PRE.con.conProMod.samL.y,con.conProMod.samK.y,$PRE.con.conProMod.samK.y,con.conProMod.timConDel.edg.u,$PRE.con.conProMod.timConDel.edg.u,con.conProMod.timConDel.gre1.greHys.y,$PRE.con.conProMod.timConDel.gre1.greHys.y,con.conProMod.tunSta,con.conProMod.triEnd,con.resPro.tunMon.greThr1.y,con.resPro.tunMon.edgTunEnd.u,$PRE.con.resPro.tunMon.edgTunEnd.u,con.resPro.tunMon.edgTunSta.u,$PRE.con.resPro.tunMon.edgTunSta.u,con.resPro.tunMon.tDec.y,con.resPro.tunMon.tInc.y,con.resPro.tunMon.samAddtOntOff.y,$PRE.con.resPro.tunMon.samAddtOntOff.y,con.resPro.norTimDel.tunEndDel.y,con.resPro.norTimDel.tunEndDel.u,con.resPro.norTimDel.or2.y,con.resPro.norTimDel.gre.greHys.y,$PRE.con.resPro.norTimDel.gre.greHys.y,con.resPro.halPerRatio.tOffSam.y,$PRE.con.resPro.halPerRatio.tOffSam.y,con.resPro.halPerRatio.tOnSam.y,$PRE.con.resPro.halPerRatio.tOnSam.y,con.resPro.onOffPer.timOffRec.edgThr.y,con.resPro.onOffPer.timOffRec.edgThr.u,$PRE.con.resPro.onOffPer.timOffRec.edgThr.u,con.resPro.onOffPer.timOffRec.edgRes.u,$PRE.con.resPro.onOffPer.timOffRec.edgRes.u,con.resPro.onOffPer.timOffRec.samTri.y,con.resPro.onOffPer.timOffRec.samTri.u2,con.resPro.onOffPer.timOffRec.yRec.y,$PRE.con.resPro.onOffPer.timOffRec.yRec.y,con.resPro.onOffPer.timOnRec.edgThr.y,con.resPro.onOffPer.timOnRec.edgThr.u,$PRE.con.resPro.onOffPer.timOnRec.edgThr.u,con.resPro.onOffPer.timOnRec.edgRes.u,$PRE.con.resPro.onOffPer.timOnRec.edgRes.u,con.resPro.onOffPer.timOnRec.samTri.y,con.resPro.onOffPer.timOnRec.samTri.u2,con.resPro.onOffPer.timOnRec.yRec.y,$PRE.con.resPro.onOffPer.timOnRec.yRec.y,con.resPro.onOffPer.timOff.y,$PRE.con.resPro.onOffPer.timOff.y,con.resPro.onOffPer.timOn.y,$PRE.con.resPro.onOffPer.timOn.y,con.resPro.triSta,con.rel.hys.y,$PRE.con.rel.hys.y,TSet.nextEventScaled,TSet.nextEvent,$PRE.TSet.nextEvent,TSet.last,TSet.b,TSet.a,$whenCondition1,$whenCondition4,$whenCondition7,$whenCondition6,$whenCondition8,$whenCondition9,$whenCondition10,$whenCondition11,$whenCondition12,$whenCondition15,$whenCondition14,$whenCondition16,$whenCondition17,$whenCondition18,$whenCondition19,$whenCondition21,con.gre.y)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (634):
 * Single equations (assignments): 625
 * Array equations: 4
 * Algorithm blocks: 2
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 1
 * Torn equation systems: 2
 * 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): 1 system
   {(1,7,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(2,10)}
Notification: Performance of prepare postOptimizeDAE: time 0.002102/2.361, allocations: 0.584 MB / 1.875 GB, free: 12.92 MB / 1.436 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.002598/2.364, allocations: 0.6095 MB / 1.876 GB, free: 12.3 MB / 1.436 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01517/2.379, allocations: 6.297 MB / 1.882 GB, free: 5.984 MB / 1.436 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 5.198e-05/2.379, allocations: 47.98 kB / 1.882 GB, free: 5.938 MB / 1.436 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 2.088e-05/2.379, allocations: 7.938 kB / 1.882 GB, free: 5.93 MB / 1.436 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01061/2.39, allocations: 5.298 MB / 1.887 GB, free: 0.5977 MB / 1.436 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.03436/2.424, allocations: 13.31 MB / 1.9 GB, free: 3.336 MB / 1.451 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.729e-05/2.424, allocations: 7.938 kB / 1.9 GB, free: 3.328 MB / 1.451 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.004531/2.428, allocations: 0.8789 MB / 1.901 GB, free: 2.492 MB / 1.451 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0006713/2.429, allocations: 200.2 kB / 1.901 GB, free: 2.293 MB / 1.451 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0006354/2.43, allocations: 127.9 kB / 1.901 GB, free: 2.168 MB / 1.451 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.00362/2.433, allocations: 3.436 MB / 1.905 GB, free: 14.61 MB / 1.467 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 8.977e-06/2.433, allocations: 7.844 kB / 1.905 GB, free: 14.61 MB / 1.467 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01867/2.452, allocations: 9.481 MB / 1.914 GB, free: 5.008 MB / 1.467 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.005028/2.457, allocations: 1.294 MB / 1.915 GB, free: 3.715 MB / 1.467 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.002065/2.459, allocations: 124 kB / 1.915 GB, free: 3.594 MB / 1.467 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.005065/2.464, allocations: 279.6 kB / 1.915 GB, free: 3.32 MB / 1.467 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001003/2.465, allocations: 355.8 kB / 1.916 GB, free: 2.977 MB / 1.467 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0006564/2.466, allocations: 171.9 kB / 1.916 GB, free: 2.809 MB / 1.467 GB
Notification: Performance of sorting global known variables: time 0.009073/2.475, allocations: 3.712 MB / 1.92 GB, free: 15.12 MB / 1.482 GB
Notification: Performance of sort global known variables: time 9e-08/2.475, allocations: 0 / 1.92 GB, free: 15.12 MB / 1.482 GB
Notification: Performance of remove unused functions: time 0.01566/2.491, allocations: 3.087 MB / 1.923 GB, free: 12.04 MB / 1.482 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 23
 * Number of states: 21 (temSen.T,val.actPos.y,hex.ele[1].vol1.dynBal.U,hex.ele[1].vol2.dynBal.medium.Xi[1],hex.ele[1].vol2.dynBal.U,hex.ele[1].mas.T,hex.ele[2].vol1.dynBal.U,hex.ele[2].vol2.dynBal.medium.Xi[1],hex.ele[2].vol2.dynBal.U,hex.ele[2].mas.T,hex.ele[3].vol1.dynBal.U,hex.ele[3].vol2.dynBal.medium.Xi[1],hex.ele[3].vol2.dynBal.U,hex.ele[3].mas.T,hex.ele[4].vol1.dynBal.U,hex.ele[4].vol2.dynBal.medium.Xi[1],hex.ele[4].vol2.dynBal.U,hex.ele[4].vol2.dynBal.m,hex.ele[4].mas.T,con.con.I.y,con.conProMod.gain.Iy.y)
 * Number of discrete variables: 83 (con.samTi.trigger,con.tunStaDel.u,con.resPro.norTimDel.tunEndDel.u,con.inTunPro.clr,con.resPro.triSta,con.conProMod.triEnd,con.resPro.tunMon.greThr1.y,con.resPro.onOffPer.timOnRec.samTri.y,con.resPro.onOffPer.timOffRec.samTri.y,con.inTunPro.u,$whenCondition21,$whenCondition20,$whenCondition19,$whenCondition18,$whenCondition17,$whenCondition16,$whenCondition13,$whenCondition14,$whenCondition15,$whenCondition12,$whenCondition11,$whenCondition10,$whenCondition9,$whenCondition8,$whenCondition5,$whenCondition6,$whenCondition7,$whenCondition4,$whenCondition2,$whenCondition3,$whenCondition1,TSet.a,TSet.b,TSet.last,TSet.nextEvent,TSet.nextEventScaled,con.rel.hys.y,con.resPro.onOffPer.timOn.y,con.resPro.onOffPer.timOff.y,con.resPro.onOffPer.timOnRec.yRec.y,con.resPro.onOffPer.timOnRec.samTri.u2,con.resPro.onOffPer.timOnRec.edgRes.u,con.resPro.onOffPer.timOnRec.edgThr.u,con.resPro.onOffPer.timOnRec.edgThr.y,con.resPro.onOffPer.timOffRec.yRec.y,con.resPro.onOffPer.timOffRec.samTri.u2,con.resPro.onOffPer.timOffRec.edgRes.u,con.resPro.onOffPer.timOffRec.edgThr.u,con.resPro.onOffPer.timOffRec.edgThr.y,con.resPro.halPerRatio.tOnSam.y,con.resPro.halPerRatio.tOffSam.y,con.resPro.norTimDel.gre.greHys.y,con.resPro.norTimDel.or2.y,con.resPro.norTimDel.tunEndDel.y,con.resPro.norTimDel.tunEndDel.t_next,con.resPro.tunMon.samAddtOntOff.y,con.resPro.tunMon.tInc.y,con.resPro.tunMon.tDec.y,con.resPro.tunMon.edgTunSta.u,con.resPro.tunMon.edgTunEnd.u,con.conProMod.tunSta,con.conProMod.timConDel.gre1.greHys.y,con.conProMod.timConDel.edg.u,con.conProMod.samK.y,con.conProMod.samL.y,con.conProMod.samtOn.y,con.conProMod.samT.y,con.conProMod.samTau.y,con.conProMod.not1.y,con.inTunPro.y,con.samk.y,con.samTi.y,con.nand.u2,con.nand.y,con.edgReq.u,con.tunStaDel.y,con.tunStaDel.t_next,con.sam_u_s.y,con.greThr.greHys.y,con.falEdg.y,con.falEdg.not_u,autTunSig.y,con.gre.y)
 * Number of discrete states: 21 (con.resPro.norTimDel.tunEndDel.t_next,con.tunStaDel.t_next,con.edgReq.u,con.resPro.onOffPer.timOffRec.edgRes.u,con.resPro.onOffPer.timOnRec.edgRes.u,TSet.nextEvent,TSet.last,TSet.nextEventScaled,TSet.b,TSet.a,$whenCondition1,con.rel.hys.y,con.resPro.onOffPer.timOffRec.edgThr.u,con.resPro.onOffPer.timOnRec.edgThr.u,con.resPro.tunMon.edgTunEnd.u,con.conProMod.timConDel.gre1.greHys.y,con.conProMod.timConDel.edg.u,con.resPro.norTimDel.gre.greHys.y,con.resPro.tunMon.edgTunSta.u,con.greThr.greHys.y,con.falEdg.not_u)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (472):
 * Single equations (assignments): 443
 * Array equations: 0
 * Algorithm blocks: 1
 * Record equations: 4
 * When equations: 21
 * If-equations: 0
 * Equation systems (not torn): 1
 * Torn equation systems: 2
 * 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): 1 system
   {(1,7,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(2,6)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.002368/2.493, allocations: 0.718 MB / 1.923 GB, free: 11.4 MB / 1.482 GB
Notification: Performance of simCode: created initialization part: time 0.02251/2.516, allocations: 9.509 MB / 1.933 GB, free: 1.977 MB / 1.482 GB
Notification: Performance of simCode: created event and clocks part: time 2.436e-05/2.516, allocations: 5 kB / 1.933 GB, free: 1.973 MB / 1.482 GB
Notification: Performance of simCode: created simulation system equations: time 0.006916/2.522, allocations: 3.054 MB / 1.936 GB, free: 14.99 MB / 1.498 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01852/2.541, allocations: 3.078 MB / 1.939 GB, free: 11.98 MB / 1.498 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.03833/2.579, allocations: 16.3 MB / 1.955 GB, free: 11.6 MB / 1.514 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.009052/2.588, allocations: 4.676 MB / 1.959 GB, free: 6.883 MB / 1.514 GB
Notification: Performance of simCode: alias equations: time 0.01181/2.6, allocations: 2.814 MB / 1.962 GB, free: 4.086 MB / 1.514 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.00233/2.602, allocations: 467.3 kB / 1.962 GB, free: 3.629 MB / 1.514 GB
Notification: Performance of SimCode: time 1.313e-06/2.602, allocations: 0 / 1.962 GB, free: 3.629 MB / 1.514 GB
Notification: Performance of Templates: time 0.2452/2.848, allocations: 134.5 MB / 2.094 GB, free: 15.14 MB / 1.654 GB
"
[Timeout remaining time 297]
make -j1 -f Buildings_latest_Buildings.Fluid.HeatExchangers.Examples.WetCoilCounterFlowPIControlAutoTuningFailure.makefile [Timeout 300]
(rm -f Buildings_latest_Buildings.Fluid.HeatExchangers.Examples.WetCoilCounterFlowPIControlAutoTuningFailure.pipe ; mkfifo Buildings_latest_Buildings.Fluid.HeatExchangers.Examples.WetCoilCounterFlowPIControlAutoTuningFailure.pipe ; head -c 1048576 < Buildings_latest_Buildings.Fluid.HeatExchangers.Examples.WetCoilCounterFlowPIControlAutoTuningFailure.pipe >> ../files/Buildings_latest_Buildings.Fluid.HeatExchangers.Examples.WetCoilCounterFlowPIControlAutoTuningFailure.sim & ./Buildings_latest_Buildings.Fluid.HeatExchangers.Examples.WetCoilCounterFlowPIControlAutoTuningFailure  -abortSlowSimulation -alarm=800  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Fluid.HeatExchangers.Examples.WetCoilCounterFlowPIControlAutoTuningFailure.pipe 2>&1) [Timeout 800]
diffSimulationResults("Buildings_latest_Buildings.Fluid.HeatExchangers.Examples.WetCoilCounterFlowPIControlAutoTuningFailure_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_Fluid_HeatExchangers_Examples_WetCoilCounterFlowPIControlAutoTuningFailure.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.Fluid.HeatExchangers.Examples.WetCoilCounterFlowPIControlAutoTuningFailure.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 300]
""
[Timeout remaining time 300]
Reference file matches
[Calling sys.exit(0), Time elapsed: 16.344510153867304]