Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_9_Buildings.Fluid.Movers.Examples.PumpsSeries.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 9.1.3-maint.9.1.x/package.mo", uses=false)
Using package Buildings with version 9.1.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.1.3-maint.9.1.x/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.Examples.PumpsSeries,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|floMac1.y|floMac1.dp|floMac2.dp|floMac1.m_flow|floMac2.m_flow",fileNamePrefix="Buildings_9_Buildings.Fluid.Movers.Examples.PumpsSeries")
translateModel(Buildings.Fluid.Movers.Examples.PumpsSeries,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|floMac1.y|floMac1.dp|floMac2.dp|floMac1.m_flow|floMac2.m_flow",fileNamePrefix="Buildings_9_Buildings.Fluid.Movers.Examples.PumpsSeries")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001206/0.001206, allocations: 110.7 kB / 16.42 MB, free: 6.5 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.001297/0.001297, allocations: 185.4 kB / 17.35 MB, free: 5.738 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.305/1.305, allocations: 222.9 MB / 241.1 MB, free: 15.15 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.1.3-maint.9.1.x/package.mo): time 2.154/2.154, allocations: 390.3 MB / 0.6655 GB, free: 0.6328 MB / 0.5294 GB
Notification: Performance of FrontEnd - loaded program: time 0.001263/0.001263, allocations: 63.89 kB / 0.9515 GB, free: 7.641 MB / 0.7325 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.6801/0.6814, allocations: 140.4 MB / 1.089 GB, free: 5.504 MB / 0.8575 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Movers.Examples.PumpsSeries): time 0.05007/0.7315, allocations: 50.73 MB / 1.138 GB, free: 1.156 MB / 0.8887 GB
Notification: Performance of NFInst.instExpressions: time 0.02251/0.7541, allocations: 16.12 MB / 1.154 GB, free: 5.648 MB / 0.9044 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002941/0.757, allocations: 75.97 kB / 1.154 GB, free: 5.621 MB / 0.9044 GB
Notification: Performance of NFTyping.typeComponents: time 0.002999/0.7601, allocations: 1.084 MB / 1.155 GB, free: 4.992 MB / 0.9044 GB
Notification: Performance of NFTyping.typeBindings: time 0.007159/0.7673, allocations: 2.536 MB / 1.158 GB, free: 3.539 MB / 0.9044 GB
Notification: Performance of NFTyping.typeClassSections: time 0.005645/0.7729, allocations: 2.003 MB / 1.159 GB, free: 2.461 MB / 0.9044 GB
Notification: Performance of NFFlatten.flatten: time 0.006959/0.7799, allocations: 4.434 MB / 1.164 GB, free: 360 kB / 0.9044 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.002513/0.7824, allocations: 1.656 MB / 1.165 GB, free: 15.56 MB / 0.92 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.004211/0.7866, allocations: 1.846 MB / 1.167 GB, free: 14.68 MB / 0.92 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.002322/0.789, allocations: 1.36 MB / 1.169 GB, free: 14.04 MB / 0.92 GB
Notification: Performance of NFPackage.collectConstants: time 0.0003199/0.7893, allocations: 188.8 kB / 1.169 GB, free: 14.04 MB / 0.92 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.003424/0.7927, allocations: 1.558 MB / 1.17 GB, free: 13.53 MB / 0.92 GB
Notification: Performance of NFScalarize.scalarize: time 0.0006628/0.7934, allocations: 0.6065 MB / 1.171 GB, free: 13.12 MB / 0.92 GB
Notification: Performance of NFVerifyModel.verify: time 0.001188/0.7946, allocations: 1.036 MB / 1.172 GB, free: 12.4 MB / 0.92 GB
Notification: Performance of NFConvertDAE.convert: time 0.004822/0.7994, allocations: 3.417 MB / 1.175 GB, free: 10.07 MB / 0.92 GB
Notification: Performance of FrontEnd - DAE generated: time 5.26e-06/0.7995, allocations: 4 kB / 1.175 GB, free: 10.07 MB / 0.92 GB
Notification: Performance of FrontEnd: time 1.683e-06/0.7995, allocations: 5.562 kB / 1.175 GB, free: 10.06 MB / 0.92 GB
Notification: Performance of Transformations before backend: time 3.536e-05/0.7995, allocations: 0 / 1.175 GB, free: 10.06 MB / 0.92 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 249
 * Number of variables: 249
Notification: Performance of Generate backend data structure: time 0.004305/0.8038, allocations: 2.387 MB / 1.178 GB, free: 8.285 MB / 0.92 GB
Notification: Performance of prepare preOptimizeDAE: time 3.903e-05/0.8039, allocations: 8.469 kB / 1.178 GB, free: 8.285 MB / 0.92 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004345/0.8082, allocations: 0.7289 MB / 1.178 GB, free: 7.965 MB / 0.92 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.004581/0.8128, allocations: 1.93 MB / 1.18 GB, free: 6.562 MB / 0.92 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 7.86e-05/0.8129, allocations: 87.44 kB / 1.18 GB, free: 6.52 MB / 0.92 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001802/0.8131, allocations: 108.8 kB / 1.18 GB, free: 6.484 MB / 0.92 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002487/0.8156, allocations: 1.298 MB / 1.182 GB, free: 5.676 MB / 0.92 GB
Notification: Performance of preOpt findStateOrder (simulation): time 1.95e-05/0.8156, allocations: 0 / 1.182 GB, free: 5.676 MB / 0.92 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001121/0.8158, allocations: 38.03 kB / 1.182 GB, free: 5.648 MB / 0.92 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.092e-05/0.8158, allocations: 35.5 kB / 1.182 GB, free: 5.645 MB / 0.92 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002591/0.8184, allocations: 1.047 MB / 1.183 GB, free: 5.137 MB / 0.92 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.007766/0.8262, allocations: 5.905 MB / 1.188 GB, free: 15.98 MB / 0.9356 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002339/0.8285, allocations: 0.8989 MB / 1.189 GB, free: 15.47 MB / 0.9356 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0009336/0.8295, allocations: 400.4 kB / 1.19 GB, free: 15.29 MB / 0.9356 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.003024/0.8325, allocations: 2.197 MB / 1.192 GB, free: 13.22 MB / 0.9356 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.082e-05/0.8326, allocations: 46.03 kB / 1.192 GB, free: 13.17 MB / 0.9356 GB
Notification: Performance of pre-optimization done (n=57): time 1.994e-06/0.8326, allocations: 0 / 1.192 GB, free: 13.17 MB / 0.9356 GB
Notification: Performance of matching and sorting (n=57): time 0.003868/0.8364, allocations: 1.347 MB / 1.193 GB, free: 12.45 MB / 0.9356 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.044e-05/0.8365, allocations: 57.38 kB / 1.193 GB, free: 12.39 MB / 0.9356 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002026/0.8385, allocations: 1.501 MB / 1.195 GB, free: 11.59 MB / 0.9356 GB
Notification: Performance of collectPreVariables (initialization): time 8.695e-05/0.8386, allocations: 43.02 kB / 1.195 GB, free: 11.54 MB / 0.9356 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0005882/0.8392, allocations: 0.7862 MB / 1.196 GB, free: 10.85 MB / 0.9356 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001951/0.8394, allocations: 202.2 kB / 1.196 GB, free: 10.67 MB / 0.9356 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0003209/0.8397, allocations: 215.6 kB / 1.196 GB, free: 10.55 MB / 0.9356 GB
Notification: Performance of setup shared object (initialization): time 0.0001171/0.8399, allocations: 341.8 kB / 1.196 GB, free: 10.21 MB / 0.9356 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001078/0.8409, allocations: 463.6 kB / 1.197 GB, free: 9.996 MB / 0.9356 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001305/0.8423, allocations: 0.7622 MB / 1.197 GB, free: 9.375 MB / 0.9356 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002337/0.8446, allocations: 1.176 MB / 1.199 GB, free: 8.594 MB / 0.9356 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.285e-06/0.8446, allocations: 7.219 kB / 1.199 GB, free: 8.59 MB / 0.9356 GB
Notification: Performance of matching and sorting (n=107) (initialization): time 0.003225/0.8479, allocations: 1.454 MB / 1.2 GB, free: 7.863 MB / 0.9356 GB
Notification: Performance of prepare postOptimizeDAE: time 2.344e-05/0.8479, allocations: 15.52 kB / 1.2 GB, free: 7.859 MB / 0.9356 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.319e-05/0.8479, allocations: 8.5 kB / 1.2 GB, free: 7.859 MB / 0.9356 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.000483/0.8484, allocations: 145.1 kB / 1.2 GB, free: 7.797 MB / 0.9356 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001034/0.8494, allocations: 242.5 kB / 1.2 GB, free: 7.734 MB / 0.9356 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0005462/0.85, allocations: 0.6639 MB / 1.201 GB, free: 7.137 MB / 0.9356 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001177/0.8512, allocations: 126.7 kB / 1.201 GB, free: 7.059 MB / 0.9356 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001047/0.8513, allocations: 60.06 kB / 1.201 GB, free: 7.043 MB / 0.9356 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001393/0.8527, allocations: 0.7251 MB / 1.202 GB, free: 6.621 MB / 0.9356 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001094/0.8538, allocations: 0.6947 MB / 1.203 GB, free: 6.043 MB / 0.9356 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001896/0.8557, allocations: 1.058 MB / 1.204 GB, free: 5.309 MB / 0.9356 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 6.171e-06/0.8557, allocations: 6.641 kB / 1.204 GB, free: 5.305 MB / 0.9356 GB
Notification: Performance of matching and sorting (n=107) (initialization_lambda0): time 0.003019/0.8588, allocations: 1.342 MB / 1.205 GB, free: 4.637 MB / 0.9356 GB
Notification: Performance of prepare postOptimizeDAE: time 1.553e-05/0.8588, allocations: 8.656 kB / 1.205 GB, free: 4.637 MB / 0.9356 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.312e-05/0.8588, allocations: 15.31 kB / 1.205 GB, free: 4.629 MB / 0.9356 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0009073/0.8597, allocations: 204.8 kB / 1.205 GB, free: 4.547 MB / 0.9356 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0009038/0.8606, allocations: 236.7 kB / 1.205 GB, free: 4.484 MB / 0.9356 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.005685/0.8663, allocations: 3.499 MB / 1.209 GB, free: 1.301 MB / 0.9356 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001117/0.8675, allocations: 107.3 kB / 1.209 GB, free: 1.195 MB / 0.9356 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001085/0.8676, allocations: 51.98 kB / 1.209 GB, free: 1.145 MB / 0.9356 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 37
 * 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 (100):
 * Single equations (assignments): 97
 * Array equations: 2
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * 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): 1 system
   {(1,5)}
Notification: Performance of prepare postOptimizeDAE: time 0.0003001/0.8679, allocations: 232.5 kB / 1.209 GB, free: 0.9102 MB / 0.9356 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002997/0.8682, allocations: 162 kB / 1.209 GB, free: 0.75 MB / 0.9356 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.003123/0.8713, allocations: 1.283 MB / 1.211 GB, free: 15.46 MB / 0.9512 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.117e-05/0.8713, allocations: 3.984 kB / 1.211 GB, free: 15.45 MB / 0.9512 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.542e-06/0.8714, allocations: 7.938 kB / 1.211 GB, free: 15.45 MB / 0.9512 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0006302/0.872, allocations: 338.7 kB / 1.211 GB, free: 15.09 MB / 0.9512 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002935/0.8723, allocations: 16 kB / 1.211 GB, free: 15.08 MB / 0.9512 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0009305/0.8732, allocations: 55.89 kB / 1.211 GB, free: 15.02 MB / 0.9512 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001117/0.8734, allocations: 60.56 kB / 1.211 GB, free: 14.96 MB / 0.9512 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.00302/0.8764, allocations: 1.095 MB / 1.212 GB, free: 13.86 MB / 0.9512 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.0033/0.8797, allocations: 1.619 MB / 1.214 GB, free: 12.22 MB / 0.9512 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0009396/0.8807, allocations: 421 kB / 1.214 GB, free: 11.81 MB / 0.9512 GB
Notification: Performance of sorting global known variables: time 0.001564/0.8822, allocations: 1.02 MB / 1.215 GB, free: 10.8 MB / 0.9512 GB
Notification: Performance of Backend: time 3.71e-07/0.8822, allocations: 0 / 1.215 GB, free: 10.8 MB / 0.9512 GB
Notification: Performance of simCode: created initialization part: time 0.00544/0.8877, allocations: 2.015 MB / 1.217 GB, free: 8.77 MB / 0.9512 GB
Notification: Performance of SimCode: time 0.006333/0.894, allocations: 3.717 MB / 1.221 GB, free: 5.008 MB / 0.9512 GB
Notification: Performance of Templates: time 0.06191/0.956, allocations: 41.52 MB / 1.261 GB, free: 11.93 MB / 0.9981 GB
make -j1 -f Buildings_9_Buildings.Fluid.Movers.Examples.PumpsSeries.makefile
(rm -f Buildings_9_Buildings.Fluid.Movers.Examples.PumpsSeries.pipe ; mkfifo Buildings_9_Buildings.Fluid.Movers.Examples.PumpsSeries.pipe ; head -c 1048576 < Buildings_9_Buildings.Fluid.Movers.Examples.PumpsSeries.pipe >> ../files/Buildings_9_Buildings.Fluid.Movers.Examples.PumpsSeries.sim & ./Buildings_9_Buildings.Fluid.Movers.Examples.PumpsSeries  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_9_Buildings.Fluid.Movers.Examples.PumpsSeries.pipe 2>&1)
diffSimulationResults("Buildings_9_Buildings.Fluid.Movers.Examples.PumpsSeries_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_9.1.x/Buildings_Fluid_Movers_Examples_PumpsSeries.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_9_Buildings.Fluid.Movers.Examples.PumpsSeries.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches