Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Fluid.Movers.Validation.FlowControlled_m_flow.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) [Timeout 90] Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001706/0.001706, allocations: 104.1 kB / 18.19 MB, free: 4.117 MB / 14.72 MB [Timeout remaining time 90] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 90] Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001929/0.001929, allocations: 192.4 kB / 21.34 MB, free: 0.9766 MB / 14.72 MB [Timeout remaining time 90] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) [Timeout 90] Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.412/1.412, allocations: 225.6 MB / 249.9 MB, free: 3.219 MB / 190.1 MB [Timeout remaining time 88] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-master/package.mo", uses=false) [Timeout 90] Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-master/package.mo): time 2.75/2.75, allocations: 489.7 MB / 0.7761 GB, free: 2.582 MB / 0.6075 GB [Timeout remaining time 87] Using package Buildings with version 12.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-master/package.mo) Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo) Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo) Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo) Running command: translateModel(Buildings.Fluid.Movers.Validation.FlowControlled_m_flow,tolerance=1e-06,outputFormat="mat",numberOfIntervals=503,variableFilter="time|gain.u|floMacSta.dpMachine|floMacDyn.dpMachine|floMacSta.VMachine_flow|floMacDyn.VMachine_flow",fileNamePrefix="Buildings_latest_Buildings.Fluid.Movers.Validation.FlowControlled_m_flow") translateModel(Buildings.Fluid.Movers.Validation.FlowControlled_m_flow,tolerance=1e-06,outputFormat="mat",numberOfIntervals=503,variableFilter="time|gain.u|floMacSta.dpMachine|floMacDyn.dpMachine|floMacSta.VMachine_flow|floMacDyn.VMachine_flow",fileNamePrefix="Buildings_latest_Buildings.Fluid.Movers.Validation.FlowControlled_m_flow") [Timeout 300] Notification: Performance of FrontEnd - loaded program: time 0.002008/0.002008, allocations: 79.88 kB / 1.127 GB, free: 5.168 MB / 0.9044 GB Notification: Performance of FrontEnd - Absyn->SCode: time 1.008/1.01, allocations: 172 MB / 1.295 GB, free: 38.68 MB / 1.061 GB Notification: Performance of NFInst.instantiate(Buildings.Fluid.Movers.Validation.FlowControlled_m_flow): time 0.3644/1.375, allocations: 326.5 MB / 1.614 GB, free: 11.48 MB / 1.295 GB Notification: Performance of NFInst.instExpressions: time 0.03517/1.41, allocations: 22.36 MB / 1.636 GB, free: 5.074 MB / 1.311 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.00363/1.413, allocations: 99.44 kB / 1.636 GB, free: 4.977 MB / 1.311 GB Notification: Performance of NFTyping.typeComponents: time 0.007031/1.42, allocations: 2.418 MB / 1.638 GB, free: 2.551 MB / 1.311 GB Notification: Performance of NFTyping.typeBindings: time 0.01274/1.433, allocations: 4.706 MB / 1.643 GB, free: 13.83 MB / 1.326 GB Notification: Performance of NFTyping.typeClassSections: time 0.008572/1.442, allocations: 2.59 MB / 1.645 GB, free: 11.25 MB / 1.326 GB Notification: Performance of NFFlatten.flatten: time 0.02811/1.47, allocations: 11.9 MB / 1.657 GB, free: 15.32 MB / 1.342 GB Notification: Performance of NFFlatten.resolveConnections: time 0.005038/1.475, allocations: 1.842 MB / 1.659 GB, free: 13.43 MB / 1.342 GB Notification: Performance of NFEvalConstants.evaluate: time 0.01217/1.487, allocations: 3.636 MB / 1.662 GB, free: 9.777 MB / 1.342 GB Notification: Performance of NFSimplifyModel.simplify: time 0.004786/1.492, allocations: 1.962 MB / 1.664 GB, free: 7.816 MB / 1.342 GB Notification: Performance of NFPackage.collectConstants: time 0.000899/1.493, allocations: 240 kB / 1.664 GB, free: 7.582 MB / 1.342 GB Notification: Performance of NFFlatten.collectFunctions: time 0.009919/1.503, allocations: 4.034 MB / 1.668 GB, free: 3.539 MB / 1.342 GB Notification: Performance of NFScalarize.scalarize: time 0.00299/1.506, allocations: 1.188 MB / 1.669 GB, free: 2.348 MB / 1.342 GB Notification: Performance of NFVerifyModel.verify: time 0.00478/1.51, allocations: 1.706 MB / 1.671 GB, free: 0.6328 MB / 1.342 GB Notification: Performance of NFConvertDAE.convert: time 0.01313/1.523, allocations: 5.87 MB / 1.677 GB, free: 10.74 MB / 1.357 GB Notification: Performance of FrontEnd - DAE generated: time 6.973e-06/1.523, allocations: 0 / 1.677 GB, free: 10.74 MB / 1.357 GB Notification: Performance of FrontEnd: time 2.395e-06/1.523, allocations: 4 kB / 1.677 GB, free: 10.74 MB / 1.357 GB Notification: Performance of Transformations before backend: time 0.000131/1.524, allocations: 0 / 1.677 GB, free: 10.74 MB / 1.357 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 349 * Number of variables: 349 Notification: Performance of Generate backend data structure: time 0.008466/1.532, allocations: 3.914 MB / 1.681 GB, free: 6.738 MB / 1.357 GB Notification: Performance of prepare preOptimizeDAE: time 4.58e-05/1.532, allocations: 12.03 kB / 1.681 GB, free: 6.727 MB / 1.357 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.007426/1.54, allocations: 1.118 MB / 1.682 GB, free: 5.605 MB / 1.357 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.008194/1.548, allocations: 4.059 MB / 1.686 GB, free: 1.484 MB / 1.357 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001566/1.548, allocations: 118.7 kB / 1.686 GB, free: 1.367 MB / 1.357 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002951/1.548, allocations: 155.9 kB / 1.686 GB, free: 1.215 MB / 1.357 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.003627/1.552, allocations: 1.719 MB / 1.688 GB, free: 15.42 MB / 1.373 GB Notification: Performance of preOpt findStateOrder (simulation): time 3.063e-05/1.552, allocations: 0 / 1.688 GB, free: 15.42 MB / 1.373 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001475/1.552, allocations: 60 kB / 1.688 GB, free: 15.36 MB / 1.373 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.405e-05/1.552, allocations: 46.59 kB / 1.688 GB, free: 15.32 MB / 1.373 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003652/1.556, allocations: 1.447 MB / 1.689 GB, free: 13.86 MB / 1.373 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.01515/1.571, allocations: 8.93 MB / 1.698 GB, free: 4.254 MB / 1.373 GB Notification: Performance of preOpt comSubExp (simulation): time 0.002279/1.573, allocations: 0.9763 MB / 1.699 GB, free: 3.234 MB / 1.373 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.001222/1.574, allocations: 482.2 kB / 1.699 GB, free: 2.762 MB / 1.373 GB Notification: Performance of preOpt evalFunc (simulation): time 0.0002094/1.575, allocations: 106 kB / 1.699 GB, free: 2.641 MB / 1.373 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 5.038e-05/1.575, allocations: 47.06 kB / 1.699 GB, free: 2.586 MB / 1.373 GB Notification: Performance of pre-optimization done (n=70): time 2.675e-06/1.575, allocations: 4 kB / 1.699 GB, free: 2.582 MB / 1.373 GB Notification: Performance of matching and sorting (n=70): time 0.004329/1.579, allocations: 1.469 MB / 1.701 GB, free: 1.102 MB / 1.373 GB Notification: Performance of inlineWhenForInitialization (initialization): time 5.149e-05/1.579, allocations: 59.97 kB / 1.701 GB, free: 1.031 MB / 1.373 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.004613/1.584, allocations: 2.983 MB / 1.704 GB, free: 14.04 MB / 1.389 GB Notification: Performance of collectPreVariables (initialization): time 0.0002116/1.584, allocations: 45.7 kB / 1.704 GB, free: 13.99 MB / 1.389 GB Notification: Performance of collectInitialEqns (initialization): time 0.001171/1.585, allocations: 1.274 MB / 1.705 GB, free: 12.71 MB / 1.389 GB Notification: Performance of collectInitialBindings (initialization): time 0.0003367/1.585, allocations: 277.7 kB / 1.705 GB, free: 12.43 MB / 1.389 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0005973/1.586, allocations: 427.3 kB / 1.706 GB, free: 12.01 MB / 1.389 GB Notification: Performance of setup shared object (initialization): time 0.0001293/1.586, allocations: 301.1 kB / 1.706 GB, free: 11.71 MB / 1.389 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.001676/1.588, allocations: 0.8129 MB / 1.707 GB, free: 10.9 MB / 1.389 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.00206/1.59, allocations: 1.326 MB / 1.708 GB, free: 9.375 MB / 1.389 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.003327/1.593, allocations: 1.899 MB / 1.71 GB, free: 7.32 MB / 1.389 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 9.839e-06/1.593, allocations: 4 kB / 1.71 GB, free: 7.316 MB / 1.389 GB Notification: Performance of matching and sorting (n=254) (initialization): time 0.004785/1.598, allocations: 2.407 MB / 1.712 GB, free: 4.902 MB / 1.389 GB Notification: Performance of prepare postOptimizeDAE: time 3.008e-05/1.598, allocations: 16 kB / 1.712 GB, free: 4.887 MB / 1.389 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.034e-05/1.598, allocations: 15.94 kB / 1.712 GB, free: 4.871 MB / 1.389 GB Notification: Performance of postOpt tearingSystem (initialization): time 3.612e-05/1.598, allocations: 20 kB / 1.712 GB, free: 4.852 MB / 1.389 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00162/1.6, allocations: 383.5 kB / 1.713 GB, free: 4.477 MB / 1.389 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0004496/1.6, allocations: 0.6093 MB / 1.713 GB, free: 3.844 MB / 1.389 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002236/1.602, allocations: 238.7 kB / 1.714 GB, free: 3.609 MB / 1.389 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001394/1.602, allocations: 75.91 kB / 1.714 GB, free: 3.535 MB / 1.389 GB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.002721/1.605, allocations: 1.437 MB / 1.715 GB, free: 2.094 MB / 1.389 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001985/1.607, allocations: 1.298 MB / 1.716 GB, free: 0.6016 MB / 1.389 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.003173/1.61, allocations: 1.861 MB / 1.718 GB, free: 14.59 MB / 1.404 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.171e-05/1.61, allocations: 7.938 kB / 1.718 GB, free: 14.58 MB / 1.404 GB Notification: Performance of matching and sorting (n=254) (initialization_lambda0): time 0.004688/1.615, allocations: 2.363 MB / 1.72 GB, free: 12.21 MB / 1.404 GB Notification: Performance of prepare postOptimizeDAE: time 2.26e-05/1.615, allocations: 15.94 kB / 1.72 GB, free: 12.2 MB / 1.404 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.764e-05/1.615, allocations: 15.98 kB / 1.721 GB, free: 12.18 MB / 1.404 GB Notification: Performance of postOpt tearingSystem (initialization): time 2.142e-05/1.615, allocations: 20 kB / 1.721 GB, free: 12.16 MB / 1.404 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001428/1.617, allocations: 359.4 kB / 1.721 GB, free: 11.81 MB / 1.404 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.295e-05/1.617, allocations: 19.94 kB / 1.721 GB, free: 11.79 MB / 1.404 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002119/1.619, allocations: 199.1 kB / 1.721 GB, free: 11.59 MB / 1.404 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001345/1.619, allocations: 67.98 kB / 1.721 GB, free: 11.53 MB / 1.404 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 50 * 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 (188): * Single equations (assignments): 183 * Array equations: 2 * Algorithm blocks: 0 * Record equations: 2 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 1 * Torn equation systems: 0 * 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: Performance of prepare postOptimizeDAE: time 0.0004304/1.619, allocations: 271.7 kB / 1.721 GB, free: 11.25 MB / 1.404 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0006271/1.62, allocations: 282.1 kB / 1.722 GB, free: 10.98 MB / 1.404 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.003059/1.623, allocations: 1.13 MB / 1.723 GB, free: 9.832 MB / 1.404 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 7.685e-06/1.623, allocations: 8 kB / 1.723 GB, free: 9.824 MB / 1.404 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 5.179e-06/1.623, allocations: 0 / 1.723 GB, free: 9.824 MB / 1.404 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.002234/1.625, allocations: 0.9217 MB / 1.724 GB, free: 8.871 MB / 1.404 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.006884/1.632, allocations: 3.329 MB / 1.727 GB, free: 5.426 MB / 1.404 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.602e-06/1.632, allocations: 4 kB / 1.727 GB, free: 5.422 MB / 1.404 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001149/1.633, allocations: 211.8 kB / 1.727 GB, free: 5.215 MB / 1.404 GB Notification: Performance of postOpt tearingSystem (simulation): time 1.082e-05/1.633, allocations: 4 kB / 1.727 GB, free: 5.211 MB / 1.404 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 6.509e-05/1.633, allocations: 23.97 kB / 1.727 GB, free: 5.188 MB / 1.404 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0003656/1.634, allocations: 0.5938 MB / 1.728 GB, free: 4.57 MB / 1.404 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.613e-06/1.634, allocations: 0 / 1.728 GB, free: 4.57 MB / 1.404 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.004157/1.638, allocations: 1.728 MB / 1.729 GB, free: 2.809 MB / 1.404 GB Notification: Performance of postOpt removeConstants (simulation): time 0.001278/1.639, allocations: 491.1 kB / 1.73 GB, free: 2.309 MB / 1.404 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003447/1.639, allocations: 16 kB / 1.73 GB, free: 2.293 MB / 1.404 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001308/1.641, allocations: 83.91 kB / 1.73 GB, free: 2.211 MB / 1.404 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001106/1.641, allocations: 48.44 kB / 1.73 GB, free: 2.164 MB / 1.404 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 6.358e-05/1.641, allocations: 23.98 kB / 1.73 GB, free: 2.141 MB / 1.404 GB Notification: Performance of sorting global known variables: time 0.003264/1.644, allocations: 1.995 MB / 1.732 GB, free: 156 kB / 1.404 GB Notification: Performance of sort global known variables: time 1.01e-07/1.644, allocations: 0 / 1.732 GB, free: 156 kB / 1.404 GB Notification: Performance of remove unused functions: time 0.003425/1.648, allocations: 1.263 MB / 1.733 GB, free: 14.89 MB / 1.42 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 5 * Number of states: 3 (floMacDyn.vol.dynBal.medium.Xi[1],floMacDyn.vol.dynBal.U,floMacDyn.vol.dynBal.m) * Number of discrete variables: 0 () * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for simulation (72): * Single equations (assignments): 71 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 1 * Torn equation systems: 0 * 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: Performance of Backend phase and start with SimCode phase: time 0.001229/1.649, allocations: 0.4975 MB / 1.734 GB, free: 14.39 MB / 1.42 GB Notification: Performance of simCode: created initialization part: time 0.005589/1.654, allocations: 2.468 MB / 1.736 GB, free: 11.93 MB / 1.42 GB Notification: Performance of simCode: created event and clocks part: time 6.572e-06/1.654, allocations: 0 / 1.736 GB, free: 11.93 MB / 1.42 GB Notification: Performance of simCode: created simulation system equations: time 0.001292/1.656, allocations: 455.3 kB / 1.737 GB, free: 11.48 MB / 1.42 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.0059/1.662, allocations: 1.445 MB / 1.738 GB, free: 10.08 MB / 1.42 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01055/1.672, allocations: 4.968 MB / 1.743 GB, free: 5.059 MB / 1.42 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.002255/1.674, allocations: 1.927 MB / 1.745 GB, free: 3.098 MB / 1.42 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0009661/1.675, allocations: 215.4 kB / 1.745 GB, free: 2.887 MB / 1.42 GB Notification: Performance of SimCode: time 9.72e-07/1.675, allocations: 0 / 1.745 GB, free: 2.887 MB / 1.42 GB Notification: Performance of Templates: time 0.09161/1.767, allocations: 58.97 MB / 1.803 GB, free: 8.168 MB / 1.482 GB [Timeout remaining time 298] make -j1 -f Buildings_latest_Buildings.Fluid.Movers.Validation.FlowControlled_m_flow.makefile [Timeout 300] (rm -f Buildings_latest_Buildings.Fluid.Movers.Validation.FlowControlled_m_flow.pipe ; mkfifo Buildings_latest_Buildings.Fluid.Movers.Validation.FlowControlled_m_flow.pipe ; head -c 1048576 < Buildings_latest_Buildings.Fluid.Movers.Validation.FlowControlled_m_flow.pipe >> ../files/Buildings_latest_Buildings.Fluid.Movers.Validation.FlowControlled_m_flow.sim & ./Buildings_latest_Buildings.Fluid.Movers.Validation.FlowControlled_m_flow -abortSlowSimulation -alarm=400 -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Fluid.Movers.Validation.FlowControlled_m_flow.pipe 2>&1) [Timeout 400] diffSimulationResults("Buildings_latest_Buildings.Fluid.Movers.Validation.FlowControlled_m_flow_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_Fluid_Movers_Validation_FlowControlled_m_flow.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.Fluid.Movers.Validation.FlowControlled_m_flow.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 300] [Timeout remaining time 300] Reference file matches