Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Fluid.Movers.Validation.Pump_stratos.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001609/0.001609, allocations: 111.3 kB / 17.08 MB, free: 5.984 MB / 14.72 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.002094/0.002094, allocations: 191.7 kB / 20.03 MB, free: 3.059 MB / 14.72 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.429/1.429, allocations: 222.9 MB / 245.7 MB, free: 4.215 MB / 190.1 MB " [Timeout remaining time 178] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-master/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-master/package.mo): time 2.868/2.868, allocations: 489.3 MB / 0.7687 GB, free: 3.824 MB / 0.6075 GB " [Timeout remaining time 177] 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.Pump_stratos,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|gain.u|floMacSta.dpMachine|floMacDyn.dpMachine|floMacSta.VMachine_flow|floMacDyn.VMachine_flow",fileNamePrefix="Buildings_latest_Buildings.Fluid.Movers.Validation.Pump_stratos") translateModel(Buildings.Fluid.Movers.Validation.Pump_stratos,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|gain.u|floMacSta.dpMachine|floMacDyn.dpMachine|floMacSta.VMachine_flow|floMacDyn.VMachine_flow",fileNamePrefix="Buildings_latest_Buildings.Fluid.Movers.Validation.Pump_stratos") [Timeout 300] "Notification: Performance of FrontEnd - loaded program: time 0.001974/0.001974, allocations: 71.88 kB / 1.103 GB, free: 0.7969 MB / 0.8419 GB Notification: Performance of FrontEnd - Absyn->SCode: time 0.9268/0.9288, allocations: 163.8 MB / 1.263 GB, free: 8.008 MB / 0.9981 GB Notification: Performance of NFInst.instantiate(Buildings.Fluid.Movers.Validation.Pump_stratos): time 0.118/1.047, allocations: 103.3 MB / 1.364 GB, free: 13.98 MB / 1.076 GB Notification: Performance of NFInst.instExpressions: time 0.03689/1.084, allocations: 20.63 MB / 1.384 GB, free: 15.01 MB / 1.092 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.005033/1.089, allocations: 90.28 kB / 1.384 GB, free: 14.98 MB / 1.092 GB Notification: Performance of NFTyping.typeComponents: time 0.00807/1.097, allocations: 2.323 MB / 1.386 GB, free: 13.36 MB / 1.092 GB Notification: Performance of NFTyping.typeBindings: time 0.01079/1.108, allocations: 3.145 MB / 1.389 GB, free: 10.85 MB / 1.092 GB Notification: Performance of NFTyping.typeClassSections: time 0.007442/1.115, allocations: 2.354 MB / 1.391 GB, free: 9.094 MB / 1.092 GB Notification: Performance of NFFlatten.flatten: time 0.02003/1.135, allocations: 11.98 MB / 1.403 GB, free: 2.871 MB / 1.092 GB Notification: Performance of NFFlatten.resolveConnections: time 0.003932/1.139, allocations: 1.945 MB / 1.405 GB, free: 1.59 MB / 1.092 GB Notification: Performance of NFEvalConstants.evaluate: time 0.006789/1.146, allocations: 2.471 MB / 1.407 GB, free: 92 kB / 1.092 GB Notification: Performance of NFSimplifyModel.simplify: time 0.004122/1.15, allocations: 1.933 MB / 1.409 GB, free: 14.85 MB / 1.107 GB Notification: Performance of NFPackage.collectConstants: time 0.0007927/1.151, allocations: 276.5 kB / 1.41 GB, free: 14.85 MB / 1.107 GB Notification: Performance of NFFlatten.collectFunctions: time 0.006197/1.157, allocations: 2.29 MB / 1.412 GB, free: 13.67 MB / 1.107 GB Notification: Performance of NFScalarize.scalarize: time 0.001844/1.159, allocations: 1.368 MB / 1.413 GB, free: 12.78 MB / 1.107 GB Notification: Performance of NFVerifyModel.verify: time 0.003905/1.163, allocations: 1.989 MB / 1.415 GB, free: 11.41 MB / 1.107 GB Notification: Performance of NFConvertDAE.convert: time 0.01151/1.175, allocations: 6.147 MB / 1.421 GB, free: 6 MB / 1.107 GB Notification: Performance of FrontEnd - DAE generated: time 6.483e-06/1.175, allocations: 0 / 1.421 GB, free: 6 MB / 1.107 GB Notification: Performance of FrontEnd: time 1.894e-06/1.175, allocations: 0 / 1.421 GB, free: 6 MB / 1.107 GB Notification: Performance of Transformations before backend: time 0.0001279/1.175, allocations: 0 / 1.421 GB, free: 6 MB / 1.107 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 296 * Number of variables: 296 Notification: Performance of Generate backend data structure: time 0.00901/1.184, allocations: 4.455 MB / 1.425 GB, free: 1.457 MB / 1.107 GB Notification: Performance of prepare preOptimizeDAE: time 4.876e-05/1.184, allocations: 8.031 kB / 1.425 GB, free: 1.449 MB / 1.107 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005784/1.19, allocations: 1.063 MB / 1.426 GB, free: 392 kB / 1.107 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.01103/1.201, allocations: 5.566 MB / 1.432 GB, free: 10.74 MB / 1.123 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001228/1.201, allocations: 106.3 kB / 1.432 GB, free: 10.63 MB / 1.123 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003215/1.201, allocations: 136 kB / 1.432 GB, free: 10.5 MB / 1.123 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.003845/1.205, allocations: 1.96 MB / 1.434 GB, free: 8.465 MB / 1.123 GB Notification: Performance of preOpt findStateOrder (simulation): time 3.081e-05/1.205, allocations: 0 / 1.434 GB, free: 8.465 MB / 1.123 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001414/1.205, allocations: 48 kB / 1.434 GB, free: 8.418 MB / 1.123 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.183e-05/1.205, allocations: 39.92 kB / 1.434 GB, free: 8.379 MB / 1.123 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003667/1.209, allocations: 1.437 MB / 1.436 GB, free: 6.934 MB / 1.123 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.01434/1.223, allocations: 9.303 MB / 1.445 GB, free: 13.01 MB / 1.139 GB Notification: Performance of preOpt comSubExp (simulation): time 0.003669/1.227, allocations: 1.259 MB / 1.446 GB, free: 11.74 MB / 1.139 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.001754/1.229, allocations: 0.6896 MB / 1.447 GB, free: 11.05 MB / 1.139 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.005836/1.235, allocations: 3.196 MB / 1.45 GB, free: 7.664 MB / 1.139 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.389e-05/1.235, allocations: 43.12 kB / 1.45 GB, free: 7.613 MB / 1.139 GB Notification: Performance of pre-optimization done (n=61): time 2.915e-06/1.235, allocations: 0 / 1.45 GB, free: 7.613 MB / 1.139 GB Notification: Performance of matching and sorting (n=61): time 0.007934/1.243, allocations: 2.53 MB / 1.452 GB, free: 5.031 MB / 1.139 GB Notification: Performance of inlineWhenForInitialization (initialization): time 4.712e-05/1.243, allocations: 59.91 kB / 1.452 GB, free: 4.961 MB / 1.139 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.00696/1.25, allocations: 4.26 MB / 1.456 GB, free: 0.6836 MB / 1.139 GB Notification: Performance of collectPreVariables (initialization): time 0.0002881/1.25, allocations: 49.7 kB / 1.456 GB, free: 0.6289 MB / 1.139 GB Notification: Performance of collectInitialEqns (initialization): time 0.001588/1.252, allocations: 1.52 MB / 1.458 GB, free: 15.1 MB / 1.154 GB Notification: Performance of collectInitialBindings (initialization): time 0.0003372/1.252, allocations: 238 kB / 1.458 GB, free: 14.86 MB / 1.154 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.00078/1.253, allocations: 0.4996 MB / 1.459 GB, free: 14.36 MB / 1.154 GB Notification: Performance of setup shared object (initialization): time 0.0001199/1.253, allocations: 301.1 kB / 1.459 GB, free: 14.06 MB / 1.154 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.002672/1.256, allocations: 1.567 MB / 1.46 GB, free: 12.49 MB / 1.154 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.003263/1.259, allocations: 2.208 MB / 1.463 GB, free: 10.02 MB / 1.154 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.005457/1.264, allocations: 3.496 MB / 1.466 GB, free: 6.332 MB / 1.154 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.116e-05/1.264, allocations: 4 kB / 1.466 GB, free: 6.328 MB / 1.154 GB Notification: Performance of matching and sorting (n=276) (initialization): time 0.008096/1.272, allocations: 4.498 MB / 1.47 GB, free: 1.812 MB / 1.154 GB Notification: Performance of prepare postOptimizeDAE: time 3.574e-05/1.272, allocations: 19.88 kB / 1.47 GB, free: 1.793 MB / 1.154 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.517e-05/1.273, allocations: 12 kB / 1.47 GB, free: 1.781 MB / 1.154 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.001726/1.274, allocations: 0.7634 MB / 1.471 GB, free: 1.012 MB / 1.154 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001563/1.276, allocations: 379.4 kB / 1.472 GB, free: 0.6406 MB / 1.154 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001937/1.278, allocations: 1.745 MB / 1.473 GB, free: 14.84 MB / 1.17 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003024/1.281, allocations: 270.5 kB / 1.474 GB, free: 14.58 MB / 1.17 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002991/1.281, allocations: 108 kB / 1.474 GB, free: 14.47 MB / 1.17 GB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.003932/1.285, allocations: 2.167 MB / 1.476 GB, free: 12.3 MB / 1.17 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.003051/1.288, allocations: 2.009 MB / 1.478 GB, free: 10.03 MB / 1.17 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.00498/1.293, allocations: 3.107 MB / 1.481 GB, free: 6.73 MB / 1.17 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.237e-05/1.293, allocations: 4 kB / 1.481 GB, free: 6.727 MB / 1.17 GB Notification: Performance of matching and sorting (n=276) (initialization_lambda0): time 0.00835/1.302, allocations: 4.153 MB / 1.485 GB, free: 2.555 MB / 1.17 GB Notification: Performance of prepare postOptimizeDAE: time 2.65e-05/1.302, allocations: 12 kB / 1.485 GB, free: 2.543 MB / 1.17 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.645e-05/1.302, allocations: 12 kB / 1.485 GB, free: 2.531 MB / 1.17 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.002117/1.304, allocations: 0.7981 MB / 1.486 GB, free: 1.727 MB / 1.17 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001502/1.305, allocations: 371.3 kB / 1.486 GB, free: 1.363 MB / 1.17 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01609/1.321, allocations: 11.42 MB / 1.497 GB, free: 5.562 MB / 1.186 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003132/1.325, allocations: 227.1 kB / 1.497 GB, free: 5.34 MB / 1.186 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003236/1.325, allocations: 99.97 kB / 1.497 GB, free: 5.242 MB / 1.186 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 63 * 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 (182): * Single equations (assignments): 176 * Array equations: 2 * Algorithm blocks: 0 * Record equations: 2 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 2 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 0 systems * Non-linear torn systems (#iteration vars, #inner vars): 2 systems {(1,6), (1,6)} Notification: Performance of prepare postOptimizeDAE: time 0.0005445/1.325, allocations: 265.7 kB / 1.498 GB, free: 4.977 MB / 1.186 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0009888/1.326, allocations: 345.6 kB / 1.498 GB, free: 4.637 MB / 1.186 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.005395/1.332, allocations: 2.047 MB / 1.5 GB, free: 2.57 MB / 1.186 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.668e-05/1.332, allocations: 8 kB / 1.5 GB, free: 2.562 MB / 1.186 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 2.975e-06/1.332, allocations: 0 / 1.5 GB, free: 2.562 MB / 1.186 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.00404/1.336, allocations: 1.776 MB / 1.502 GB, free: 0.7109 MB / 1.186 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.009338/1.345, allocations: 4.153 MB / 1.506 GB, free: 12.48 MB / 1.201 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.62e-06/1.345, allocations: 0 / 1.506 GB, free: 12.48 MB / 1.201 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001032/1.346, allocations: 183.8 kB / 1.506 GB, free: 12.3 MB / 1.201 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.000783/1.347, allocations: 321.4 kB / 1.506 GB, free: 11.98 MB / 1.201 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 8.08e-05/1.347, allocations: 31.97 kB / 1.506 GB, free: 11.95 MB / 1.201 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001675/1.349, allocations: 1.616 MB / 1.508 GB, free: 10.29 MB / 1.201 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.104e-06/1.349, allocations: 0 / 1.508 GB, free: 10.29 MB / 1.201 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.007008/1.356, allocations: 2.791 MB / 1.511 GB, free: 7.461 MB / 1.201 GB Notification: Performance of postOpt removeConstants (simulation): time 0.001655/1.358, allocations: 0.5843 MB / 1.511 GB, free: 6.855 MB / 1.201 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0004961/1.358, allocations: 15.98 kB / 1.511 GB, free: 6.84 MB / 1.201 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0015/1.36, allocations: 87.97 kB / 1.511 GB, free: 6.754 MB / 1.201 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001138/1.36, allocations: 48.53 kB / 1.511 GB, free: 6.707 MB / 1.201 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001128/1.36, allocations: 47.95 kB / 1.511 GB, free: 6.66 MB / 1.201 GB Notification: Performance of sorting global known variables: time 0.00515/1.365, allocations: 2.917 MB / 1.514 GB, free: 3.734 MB / 1.201 GB Notification: Performance of sort global known variables: time 2.7e-07/1.365, allocations: 0 / 1.514 GB, free: 3.734 MB / 1.201 GB Notification: Performance of remove unused functions: time 0.005222/1.37, allocations: 1.575 MB / 1.516 GB, free: 2.156 MB / 1.201 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 3 * Number of states: 1 (floMacDyn.vol.dynBal.U) * 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 (60): * Single equations (assignments): 53 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 5 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 2 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 0 systems * Non-linear torn systems (#iteration vars, #inner vars): 2 systems {(1,7), (1,7)} Notification: Performance of Backend phase and start with SimCode phase: time 0.002026/1.372, allocations: 0.7601 MB / 1.516 GB, free: 1.395 MB / 1.201 GB Notification: Performance of simCode: created initialization part: time 0.008989/1.381, allocations: 4.507 MB / 1.521 GB, free: 12.87 MB / 1.217 GB Notification: Performance of simCode: created event and clocks part: time 6.152e-06/1.381, allocations: 0 / 1.521 GB, free: 12.87 MB / 1.217 GB Notification: Performance of simCode: created simulation system equations: time 0.001894/1.383, allocations: 0.6641 MB / 1.522 GB, free: 12.2 MB / 1.217 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.007497/1.391, allocations: 1.816 MB / 1.523 GB, free: 10.43 MB / 1.217 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01143/1.402, allocations: 5.851 MB / 1.529 GB, free: 4.531 MB / 1.217 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.002391/1.405, allocations: 2.139 MB / 1.531 GB, free: 2.363 MB / 1.217 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001234/1.406, allocations: 275.3 kB / 1.531 GB, free: 2.094 MB / 1.217 GB Notification: Performance of SimCode: time 9.82e-07/1.406, allocations: 0 / 1.531 GB, free: 2.094 MB / 1.217 GB Notification: Performance of Templates: time 0.1307/1.537, allocations: 89.62 MB / 1.619 GB, free: 8.836 MB / 1.311 GB " [Timeout remaining time 298] make -j1 -f Buildings_latest_Buildings.Fluid.Movers.Validation.Pump_stratos.makefile [Timeout 300] (rm -f Buildings_latest_Buildings.Fluid.Movers.Validation.Pump_stratos.pipe ; mkfifo Buildings_latest_Buildings.Fluid.Movers.Validation.Pump_stratos.pipe ; head -c 1048576 < Buildings_latest_Buildings.Fluid.Movers.Validation.Pump_stratos.pipe >> ../files/Buildings_latest_Buildings.Fluid.Movers.Validation.Pump_stratos.sim & ./Buildings_latest_Buildings.Fluid.Movers.Validation.Pump_stratos -abortSlowSimulation -alarm=800 -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Fluid.Movers.Validation.Pump_stratos.pipe 2>&1) [Timeout 800] diffSimulationResults("Buildings_latest_Buildings.Fluid.Movers.Validation.Pump_stratos_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_Fluid_Movers_Validation_Pump_stratos.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork_2/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.Fluid.Movers.Validation.Pump_stratos.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: 27.048015834996477]