Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Fluid.Storage.Validation.HeatExchangerDynamics.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.0-master/package.mo", uses=false) Using package Buildings with version 11.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.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.Fluid.Storage.Validation.HeatExchangerDynamics,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|senTanDyn.port_a.m_flow|senTanDyn.T|senTanSte.T|tanDyn.QHex_flow|tanSte.QHex_flow|tanDyn.vol.1..T|tanDyn.vol.5..T|tanDyn.vol.7..T|tanSte.vol.1..T|tanSte.vol.5..T|tanSte.vol.7..T",fileNamePrefix="Buildings_latest_Buildings.Fluid.Storage.Validation.HeatExchangerDynamics") translateModel(Buildings.Fluid.Storage.Validation.HeatExchangerDynamics,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|senTanDyn.port_a.m_flow|senTanDyn.T|senTanSte.T|tanDyn.QHex_flow|tanSte.QHex_flow|tanDyn.vol.1..T|tanDyn.vol.5..T|tanDyn.vol.7..T|tanSte.vol.1..T|tanSte.vol.5..T|tanSte.vol.7..T",fileNamePrefix="Buildings_latest_Buildings.Fluid.Storage.Validation.HeatExchangerDynamics") Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001127/0.001127, allocations: 109.3 kB / 16.37 MB, free: 6.262 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.001151/0.001151, allocations: 192.8 kB / 17.3 MB, free: 5.848 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.453/1.453, allocations: 222.9 MB / 241 MB, free: 15.07 MB / 206.1 MB [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.0-master/Experimental/DHC/UsersGuide/package.mo:2:1-389:15:writable] Warning: UsersGuide was referenced in the package.order file, but was not found in package.mo, UsersGuide/package.mo or UsersGuide.mo. Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.0-master/package.mo): time 2.39/2.39, allocations: 442.6 MB / 0.7166 GB, free: 14.62 MB / 0.5919 GB Notification: Performance of FrontEnd - loaded program: time 0.001272/0.001272, allocations: 75.84 kB / 0.8774 GB, free: 10.94 MB / 0.6544 GB Notification: Performance of FrontEnd - Absyn->SCode: time 0.2626/0.2639, allocations: 153 MB / 1.027 GB, free: 2.031 MB / 0.795 GB Notification: Performance of NFInst.instantiate(Buildings.Fluid.Storage.Validation.HeatExchangerDynamics): time 0.6199/0.8838, allocations: 112.1 MB / 1.136 GB, free: 6.82 MB / 0.8575 GB Notification: Performance of NFInst.instExpressions: time 0.04577/0.9296, allocations: 32.04 MB / 1.168 GB, free: 15.76 MB / 0.8887 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.007012/0.9367, allocations: 152.4 kB / 1.168 GB, free: 15.71 MB / 0.8887 GB Notification: Performance of NFTyping.typeComponents: time 0.006043/0.9428, allocations: 1.804 MB / 1.169 GB, free: 14.55 MB / 0.8887 GB Notification: Performance of NFTyping.typeBindings: time 0.01506/0.9579, allocations: 4.617 MB / 1.174 GB, free: 11.36 MB / 0.8887 GB Notification: Performance of NFTyping.typeClassSections: time 0.01107/0.9689, allocations: 3.587 MB / 1.177 GB, free: 8.508 MB / 0.8887 GB Notification: Performance of NFFlatten.flatten: time 0.05103/1.02, allocations: 47.72 MB / 1.224 GB, free: 3.555 MB / 0.92 GB Notification: Performance of NFFlatten.resolveConnections: time 0.02962/1.05, allocations: 23.8 MB / 1.247 GB, free: 11.6 MB / 0.9512 GB Notification: Performance of NFEvalConstants.evaluate: time 0.02864/1.078, allocations: 16.16 MB / 1.263 GB, free: 11.48 MB / 0.9669 GB Notification: Performance of NFSimplifyModel.simplify: time 0.02341/1.102, allocations: 14.03 MB / 1.277 GB, free: 13.4 MB / 0.9825 GB Notification: Performance of NFPackage.collectConstants: time 0.007198/1.109, allocations: 2.434 MB / 1.279 GB, free: 10.96 MB / 0.9825 GB Notification: Performance of NFFlatten.collectFunctions: time 0.0178/1.127, allocations: 4.746 MB / 1.284 GB, free: 6.215 MB / 0.9825 GB Notification: Performance of NFScalarize.scalarize: time 0.01047/1.137, allocations: 5.501 MB / 1.289 GB, free: 0.6992 MB / 0.9825 GB Notification: Performance of NFVerifyModel.verify: time 0.02203/1.159, allocations: 11.09 MB / 1.3 GB, free: 5.562 MB / 0.9981 GB Notification: Performance of NFConvertDAE.convert: time 0.04053/1.2, allocations: 34.56 MB / 1.334 GB, free: 2.91 MB / 1.029 GB Notification: Performance of FrontEnd - DAE generated: time 7.564e-06/1.2, allocations: 0 / 1.334 GB, free: 2.91 MB / 1.029 GB Notification: Performance of FrontEnd: time 1.723e-06/1.2, allocations: 0 / 1.334 GB, free: 2.91 MB / 1.029 GB Notification: Performance of Transformations before backend: time 0.00108/1.201, allocations: 0 / 1.334 GB, free: 2.91 MB / 1.029 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 3345 * Number of variables: 3345 Notification: Performance of Generate backend data structure: time 0.05383/1.255, allocations: 19.84 MB / 1.353 GB, free: 14.93 MB / 1.061 GB Notification: Performance of prepare preOptimizeDAE: time 4.615e-05/1.255, allocations: 8.031 kB / 1.353 GB, free: 14.93 MB / 1.061 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01041/1.265, allocations: 1.98 MB / 1.355 GB, free: 12.93 MB / 1.061 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.03752/1.303, allocations: 16.34 MB / 1.371 GB, free: 12.48 MB / 1.076 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001051/1.304, allocations: 1.002 MB / 1.372 GB, free: 11.48 MB / 1.076 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.005769/1.31, allocations: 1.336 MB / 1.373 GB, free: 10.15 MB / 1.076 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.05014/1.36, allocations: 20.26 MB / 1.393 GB, free: 5.328 MB / 1.092 GB Notification: Performance of preOpt findStateOrder (simulation): time 0.0006142/1.361, allocations: 39.64 kB / 1.393 GB, free: 5.289 MB / 1.092 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.004221/1.365, allocations: 0.543 MB / 1.394 GB, free: 4.746 MB / 1.092 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.000417/1.365, allocations: 387.8 kB / 1.394 GB, free: 4.367 MB / 1.092 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03992/1.405, allocations: 18.14 MB / 1.412 GB, free: 2.199 MB / 1.107 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.1396/1.545, allocations: 86.46 MB / 1.496 GB, free: 7.062 MB / 1.201 GB Notification: Performance of preOpt comSubExp (simulation): time 0.02203/1.567, allocations: 12.96 MB / 1.509 GB, free: 10.11 MB / 1.217 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.01312/1.58, allocations: 7.42 MB / 1.516 GB, free: 2.68 MB / 1.217 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 evalFunc (simulation): time 0.06043/1.641, allocations: 26.92 MB / 1.542 GB, free: 6.562 MB / 1.248 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.01346/1.654, allocations: 6.061 MB / 1.548 GB, free: 456 kB / 1.248 GB Notification: Performance of preOpt simplifyInStream (simulation): time 0.9147/2.569, allocations: 0.8133 MB / 1.549 GB, free: 417.2 MB / 1.248 GB Notification: Performance of pre-optimization done (n=772): time 6.145e-05/2.569, allocations: 3.891 kB / 1.549 GB, free: 417.2 MB / 1.248 GB Notification: Performance of matching and sorting (n=772): time 0.1138/2.683, allocations: 32.37 MB / 1.581 GB, free: 411.7 MB / 1.248 GB Notification: Performance of inlineWhenForInitialization (initialization): time 9.057e-05/2.683, allocations: 155.9 kB / 1.581 GB, free: 411.6 MB / 1.248 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.02703/2.71, allocations: 12.84 MB / 1.593 GB, free: 407.4 MB / 1.248 GB Notification: Performance of collectPreVariables (initialization): time 0.00206/2.712, allocations: 202.5 kB / 1.594 GB, free: 407.2 MB / 1.248 GB Notification: Performance of collectInitialEqns (initialization): time 0.007915/2.72, allocations: 7.029 MB / 1.6 GB, free: 402.7 MB / 1.248 GB Notification: Performance of collectInitialBindings (initialization): time 0.003845/2.724, allocations: 2.698 MB / 1.603 GB, free: 400.6 MB / 1.248 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.008164/2.732, allocations: 2.315 MB / 1.605 GB, free: 399.5 MB / 1.248 GB Notification: Performance of setup shared object (initialization): time 4.996e-05/2.732, allocations: 305.1 kB / 1.606 GB, free: 399.2 MB / 1.248 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.01112/2.743, allocations: 6.331 MB / 1.612 GB, free: 395.8 MB / 1.248 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.01278/2.756, allocations: 9.6 MB / 1.621 GB, free: 388.2 MB / 1.248 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.02101/2.777, allocations: 15.96 MB / 1.637 GB, free: 377 MB / 1.248 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001267/2.777, allocations: 27.22 kB / 1.637 GB, free: 377 MB / 1.248 GB Notification: Performance of matching and sorting (n=1474) (initialization): time 0.03998/2.817, allocations: 18.88 MB / 1.655 GB, free: 359.5 MB / 1.248 GB Notification: Performance of prepare postOptimizeDAE: time 0.0001361/2.817, allocations: 74.36 kB / 1.655 GB, free: 359.5 MB / 1.248 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.000152/2.817, allocations: 96 kB / 1.655 GB, free: 359.4 MB / 1.248 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.05766/2.875, allocations: 9.118 MB / 1.664 GB, free: 350.2 MB / 1.248 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.009908/2.885, allocations: 2.453 MB / 1.667 GB, free: 347.8 MB / 1.248 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01094/2.896, allocations: 10.83 MB / 1.677 GB, free: 336.7 MB / 1.248 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.012/2.908, allocations: 0.7237 MB / 1.678 GB, free: 336 MB / 1.248 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002555/2.911, allocations: 0.5194 MB / 1.678 GB, free: 335.4 MB / 1.248 GB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.01905/2.93, allocations: 11.73 MB / 1.69 GB, free: 323.7 MB / 1.248 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.01297/2.943, allocations: 9.594 MB / 1.699 GB, free: 312.7 MB / 1.248 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.02186/2.965, allocations: 15.94 MB / 1.715 GB, free: 295.3 MB / 1.248 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0001019/2.965, allocations: 28 kB / 1.715 GB, free: 295.3 MB / 1.248 GB Notification: Performance of matching and sorting (n=1474) (initialization_lambda0): time 0.03657/3.001, allocations: 18.87 MB / 1.733 GB, free: 276.3 MB / 1.248 GB Notification: Performance of prepare postOptimizeDAE: time 0.0001169/3.001, allocations: 77.69 kB / 1.733 GB, free: 276.2 MB / 1.248 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001417/3.002, allocations: 100 kB / 1.733 GB, free: 276.1 MB / 1.248 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.05675/3.058, allocations: 9.115 MB / 1.742 GB, free: 267 MB / 1.248 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.009597/3.068, allocations: 2.457 MB / 1.745 GB, free: 264.5 MB / 1.248 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01109/3.079, allocations: 10.82 MB / 1.755 GB, free: 253.4 MB / 1.248 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01362/3.093, allocations: 0.7215 MB / 1.756 GB, free: 252.7 MB / 1.248 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002792/3.096, allocations: 0.5194 MB / 1.757 GB, free: 252.2 MB / 1.248 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 448 * Number of states: 0 () * Number of discrete variables: 5 (mHex_flow_in.count,$PRE.mHex_flow_in.count,mHex_flow_in.T_start,$PRE.mHex_flow_in.T_start,$whenCondition1) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (1286): * Single equations (assignments): 1282 * Array equations: 0 * Algorithm blocks: 1 * 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): 2 systems {(1,14,100.0%), (1,14,100.0%)} * Non-linear torn systems (#iteration vars, #inner vars): 1 system {(16,144)} Notification: Performance of prepare postOptimizeDAE: time 0.004204/3.1, allocations: 0.8678 MB / 1.757 GB, free: 251.3 MB / 1.248 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.004717/3.105, allocations: 1.173 MB / 1.759 GB, free: 250.1 MB / 1.248 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02574/3.13, allocations: 13.37 MB / 1.772 GB, free: 236.7 MB / 1.248 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01757/3.148, allocations: 11.04 MB / 1.782 GB, free: 225.6 MB / 1.248 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.678e-05/3.148, allocations: 4 kB / 1.782 GB, free: 225.6 MB / 1.248 GB Notification: Performance of postOpt removeConstants (simulation): time 0.007877/3.156, allocations: 2.767 MB / 1.785 GB, free: 222.8 MB / 1.248 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.004328/3.16, allocations: 155.9 kB / 1.785 GB, free: 222.6 MB / 1.248 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.009019/3.169, allocations: 459.6 kB / 1.786 GB, free: 222.2 MB / 1.248 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001545/3.171, allocations: 465.5 kB / 1.786 GB, free: 221.7 MB / 1.248 GB Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.0299/3.201, allocations: 14.31 MB / 1.8 GB, free: 207.5 MB / 1.248 GB Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.03015/3.231, allocations: 18.92 MB / 1.819 GB, free: 188.5 MB / 1.248 GB Notification: Performance of postOpt setEvaluationStage (simulation): time 0.007361/3.238, allocations: 5.514 MB / 1.824 GB, free: 182.9 MB / 1.248 GB Notification: Performance of sorting global known variables: time 0.01489/3.253, allocations: 8.908 MB / 1.833 GB, free: 174.1 MB / 1.248 GB Notification: Performance of Backend: time 1.022e-06/3.253, allocations: 0 / 1.833 GB, free: 174.1 MB / 1.248 GB Notification: Performance of simCode: created initialization part: time 0.04258/3.296, allocations: 19.77 MB / 1.852 GB, free: 154.4 MB / 1.248 GB Notification: Performance of SimCode: time 0.07526/3.371, allocations: 36.06 MB / 1.887 GB, free: 118.6 MB / 1.248 GB Notification: Performance of Templates: time 2.158/5.529, allocations: 327.8 MB / 2.207 GB, free: 292.5 MB / 1.28 GB make -j1 -f Buildings_latest_Buildings.Fluid.Storage.Validation.HeatExchangerDynamics.makefile (rm -f Buildings_latest_Buildings.Fluid.Storage.Validation.HeatExchangerDynamics.pipe ; mkfifo Buildings_latest_Buildings.Fluid.Storage.Validation.HeatExchangerDynamics.pipe ; head -c 1048576 < Buildings_latest_Buildings.Fluid.Storage.Validation.HeatExchangerDynamics.pipe >> ../files/Buildings_latest_Buildings.Fluid.Storage.Validation.HeatExchangerDynamics.sim & ./Buildings_latest_Buildings.Fluid.Storage.Validation.HeatExchangerDynamics -abortSlowSimulation -alarm=480 -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Fluid.Storage.Validation.HeatExchangerDynamics.pipe 2>&1)