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)
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.1-master/package.mo", uses=false)
Using package Buildings with version 11.0.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-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=5000,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=5000,variableFilter="time|gain.u|floMacSta.dpMachine|floMacDyn.dpMachine|floMacSta.VMachine_flow|floMacDyn.VMachine_flow",fileNamePrefix="Buildings_latest_Buildings.Fluid.Movers.Validation.FlowControlled_m_flow")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001546/0.001546, allocations: 115.2 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.001768/0.001768, allocations: 183.9 kB / 17.35 MB, free: 5.762 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.325/1.325, allocations: 222.9 MB / 241 MB, free: 15.14 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-master/package.mo): time 2.559/2.559, allocations: 469.4 MB / 0.7428 GB, free: 3.609 MB / 0.6075 GB
Notification: Performance of FrontEnd - loaded program: time 0.001434/0.001434, allocations: 71.89 kB / 1.066 GB, free: 13.8 MB / 0.8419 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.6878/0.6892, allocations: 159.1 MB / 1.221 GB, free: 2.41 MB / 0.9356 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Movers.Validation.FlowControlled_m_flow): time 0.3122/1.001, allocations: 325.1 MB / 1.538 GB, free: 12.17 MB / 1.264 GB
Notification: Performance of NFInst.instExpressions: time 0.03025/1.032, allocations: 22.3 MB / 1.56 GB, free: 5.812 MB / 1.279 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002941/1.035, allocations: 99.44 kB / 1.56 GB, free: 5.715 MB / 1.279 GB
Notification: Performance of NFTyping.typeComponents: time 0.006094/1.041, allocations: 2.395 MB / 1.563 GB, free: 3.309 MB / 1.279 GB
Notification: Performance of NFTyping.typeBindings: time 0.6503/1.691, allocations: 4.676 MB / 1.567 GB, free: 78.57 MB / 1.279 GB
Notification: Performance of NFTyping.typeClassSections: time 0.006024/1.697, allocations: 2.557 MB / 1.57 GB, free: 78.56 MB / 1.279 GB
Notification: Performance of NFFlatten.flatten: time 0.01712/1.714, allocations: 12.18 MB / 1.582 GB, free: 78.54 MB / 1.279 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.003344/1.718, allocations: 2.241 MB / 1.584 GB, free: 78.29 MB / 1.279 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.00633/1.724, allocations: 3.324 MB / 1.587 GB, free: 78.29 MB / 1.279 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.003013/1.727, allocations: 1.862 MB / 1.589 GB, free: 78.28 MB / 1.279 GB
Notification: Performance of NFPackage.collectConstants: time 0.0004299/1.727, allocations: 239 kB / 1.589 GB, free: 78.28 MB / 1.279 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.006293/1.734, allocations: 3.883 MB / 1.593 GB, free: 78.28 MB / 1.279 GB
Notification: Performance of NFScalarize.scalarize: time 0.0009954/1.735, allocations: 1.161 MB / 1.594 GB, free: 78.28 MB / 1.279 GB
Notification: Performance of NFVerifyModel.verify: time 0.001904/1.737, allocations: 1.703 MB / 1.596 GB, free: 78.28 MB / 1.279 GB
Notification: Performance of NFConvertDAE.convert: time 0.007456/1.744, allocations: 5.855 MB / 1.601 GB, free: 77.57 MB / 1.279 GB
Notification: Performance of FrontEnd - DAE generated: time 4.208e-06/1.744, allocations: 2.875 kB / 1.601 GB, free: 77.57 MB / 1.279 GB
Notification: Performance of FrontEnd: time 1.473e-06/1.744, allocations: 0 / 1.601 GB, free: 77.57 MB / 1.279 GB
Notification: Performance of Transformations before backend: time 7.045e-05/1.744, allocations: 0.6562 kB / 1.601 GB, free: 77.57 MB / 1.279 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.006289/1.751, allocations: 3.804 MB / 1.605 GB, free: 75.67 MB / 1.279 GB
Notification: Performance of prepare preOptimizeDAE: time 4.696e-05/1.751, allocations: 8.156 kB / 1.605 GB, free: 75.67 MB / 1.279 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0071/1.758, allocations: 1.099 MB / 1.606 GB, free: 75.49 MB / 1.279 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.006338/1.764, allocations: 4.035 MB / 1.61 GB, free: 74.82 MB / 1.279 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 7.988e-05/1.764, allocations: 113.8 kB / 1.61 GB, free: 74.81 MB / 1.279 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.000213/1.764, allocations: 154.5 kB / 1.61 GB, free: 74.81 MB / 1.279 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003075/1.768, allocations: 1.709 MB / 1.612 GB, free: 74.6 MB / 1.279 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.127e-05/1.768, allocations: 5.969 kB / 1.612 GB, free: 74.6 MB / 1.279 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001332/1.768, allocations: 59.5 kB / 1.612 GB, free: 74.6 MB / 1.279 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.373e-05/1.768, allocations: 54.03 kB / 1.612 GB, free: 74.59 MB / 1.279 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003315/1.771, allocations: 1.441 MB / 1.613 GB, free: 74.58 MB / 1.279 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.009994/1.781, allocations: 8.661 MB / 1.622 GB, free: 70.2 MB / 1.279 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002053/1.783, allocations: 1.027 MB / 1.623 GB, free: 69.98 MB / 1.279 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001149/1.784, allocations: 0.5059 MB / 1.623 GB, free: 69.96 MB / 1.279 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001595/1.784, allocations: 105.3 kB / 1.624 GB, free: 69.87 MB / 1.279 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.045e-05/1.785, allocations: 45.89 kB / 1.624 GB, free: 69.83 MB / 1.279 GB
Notification: Performance of pre-optimization done (n=70): time 2.465e-06/1.785, allocations: 0 / 1.624 GB, free: 69.83 MB / 1.279 GB
Notification: Performance of matching and sorting (n=70): time 0.003772/1.788, allocations: 1.462 MB / 1.625 GB, free: 69.64 MB / 1.279 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 1.798e-05/1.788, allocations: 63.66 kB / 1.625 GB, free: 69.57 MB / 1.279 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003234/1.792, allocations: 2.979 MB / 1.628 GB, free: 69.29 MB / 1.279 GB
Notification: Performance of collectPreVariables (initialization): time 0.000103/1.792, allocations: 48.02 kB / 1.628 GB, free: 69.25 MB / 1.279 GB
Notification: Performance of collectInitialEqns (initialization): time 0.000783/1.792, allocations: 1.274 MB / 1.629 GB, free: 68.9 MB / 1.279 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001826/1.793, allocations: 261.1 kB / 1.63 GB, free: 68.75 MB / 1.279 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0005071/1.793, allocations: 431.2 kB / 1.63 GB, free: 68.71 MB / 1.279 GB
Notification: Performance of setup shared object (initialization): time 3.13e-05/1.793, allocations: 301.1 kB / 1.63 GB, free: 68.41 MB / 1.279 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001535/1.795, allocations: 0.8166 MB / 1.631 GB, free: 68.39 MB / 1.279 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001731/1.797, allocations: 1.314 MB / 1.632 GB, free: 67.87 MB / 1.279 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002796/1.799, allocations: 1.901 MB / 1.634 GB, free: 67.43 MB / 1.279 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.296e-06/1.799, allocations: 4.656 kB / 1.634 GB, free: 67.43 MB / 1.279 GB
Notification: Performance of matching and sorting (n=254) (initialization): time 0.003881/1.803, allocations: 2.401 MB / 1.637 GB, free: 67.2 MB / 1.279 GB
Notification: Performance of prepare postOptimizeDAE: time 2.059e-05/1.803, allocations: 11 kB / 1.637 GB, free: 67.2 MB / 1.279 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.656e-05/1.803, allocations: 12.62 kB / 1.637 GB, free: 67.2 MB / 1.279 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.515e-05/1.803, allocations: 20.09 kB / 1.637 GB, free: 67.2 MB / 1.279 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001508/1.805, allocations: 393.1 kB / 1.637 GB, free: 67.18 MB / 1.279 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0002352/1.805, allocations: 0.6099 MB / 1.638 GB, free: 66.59 MB / 1.279 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001915/1.807, allocations: 238.7 kB / 1.638 GB, free: 66.5 MB / 1.279 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001133/1.807, allocations: 69.12 kB / 1.638 GB, free: 66.5 MB / 1.279 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.002154/1.809, allocations: 1.435 MB / 1.639 GB, free: 66.4 MB / 1.279 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001567/1.811, allocations: 1.296 MB / 1.64 GB, free: 65.86 MB / 1.279 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.002631/1.813, allocations: 1.864 MB / 1.642 GB, free: 65.4 MB / 1.279 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 8.707e-06/1.814, allocations: 3.281 kB / 1.642 GB, free: 65.4 MB / 1.279 GB
Notification: Performance of matching and sorting (n=254) (initialization_lambda0): time 0.003866/1.817, allocations: 2.344 MB / 1.645 GB, free: 65.18 MB / 1.279 GB
Notification: Performance of prepare postOptimizeDAE: time 1.602e-05/1.817, allocations: 13.05 kB / 1.645 GB, free: 65.18 MB / 1.279 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.305e-05/1.817, allocations: 13.12 kB / 1.645 GB, free: 65.18 MB / 1.279 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.498e-05/1.817, allocations: 16.53 kB / 1.645 GB, free: 65.18 MB / 1.279 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001281/1.819, allocations: 359.6 kB / 1.645 GB, free: 65.17 MB / 1.279 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.251e-05/1.819, allocations: 33.78 kB / 1.645 GB, free: 65.17 MB / 1.279 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002127/1.821, allocations: 195.2 kB / 1.645 GB, free: 65.11 MB / 1.279 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001118/1.821, allocations: 65.62 kB / 1.645 GB, free: 65.11 MB / 1.279 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.0003932/1.821, allocations: 272.2 kB / 1.646 GB, free: 64.92 MB / 1.279 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003939/1.822, allocations: 272.1 kB / 1.646 GB, free: 64.77 MB / 1.279 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002798/1.825, allocations: 1.125 MB / 1.647 GB, free: 64.66 MB / 1.279 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.002018/1.827, allocations: 0.9259 MB / 1.648 GB, free: 64.48 MB / 1.279 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.289e-06/1.827, allocations: 0 / 1.648 GB, free: 64.48 MB / 1.279 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0009064/1.828, allocations: 475.7 kB / 1.648 GB, free: 64.23 MB / 1.279 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003211/1.828, allocations: 12.22 kB / 1.648 GB, free: 64.23 MB / 1.279 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001289/1.829, allocations: 88.55 kB / 1.648 GB, free: 64.22 MB / 1.279 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 9.506e-05/1.829, allocations: 40.16 kB / 1.648 GB, free: 64.22 MB / 1.279 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.002984/1.832, allocations: 1.11 MB / 1.649 GB, free: 64.07 MB / 1.279 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.003473/1.836, allocations: 1.799 MB / 1.651 GB, free: 63.65 MB / 1.279 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0009885/1.837, allocations: 448.2 kB / 1.652 GB, free: 63.64 MB / 1.279 GB
Notification: Performance of sorting global known variables: time 0.002538/1.839, allocations: 1.989 MB / 1.654 GB, free: 63.49 MB / 1.279 GB
Notification: Performance of Backend: time 1.683e-06/1.839, allocations: 2.906 kB / 1.654 GB, free: 63.49 MB / 1.279 GB
Notification: Performance of simCode: created initialization part: time 0.006899/1.846, allocations: 3.256 MB / 1.657 GB, free: 63.21 MB / 1.279 GB
Notification: Performance of SimCode: time 0.00912/1.855, allocations: 6.255 MB / 1.663 GB, free: 60.74 MB / 1.279 GB
Notification: Performance of Templates: time 0.07565/1.931, allocations: 63.51 MB / 1.725 GB, free: 4.105 MB / 1.279 GB
make -j1 -f Buildings_latest_Buildings.Fluid.Movers.Validation.FlowControlled_m_flow.makefile
(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=480  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Fluid.Movers.Validation.FlowControlled_m_flow.pipe 2>&1)
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)
Reference file matches