Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_9_Buildings.Fluid.Movers.Validation.ControlledFlowMachineDynamic.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.Validation.ControlledFlowMachineDynamic,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|fan1.m_flow|fan2.m_flow|fan3.m_flow|fan4.m_flow|fan1.dp|fan2.dp|fan3.dp|fan4.dp",fileNamePrefix="Buildings_9_Buildings.Fluid.Movers.Validation.ControlledFlowMachineDynamic")
translateModel(Buildings.Fluid.Movers.Validation.ControlledFlowMachineDynamic,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|fan1.m_flow|fan2.m_flow|fan3.m_flow|fan4.m_flow|fan1.dp|fan2.dp|fan3.dp|fan4.dp",fileNamePrefix="Buildings_9_Buildings.Fluid.Movers.Validation.ControlledFlowMachineDynamic")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001065/0.001065, allocations: 112 kB / 16.42 MB, free: 6.512 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.0009851/0.0009851, allocations: 183.9 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.269/1.269, allocations: 222.9 MB / 241 MB, free: 15.18 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.169/2.169, allocations: 390.3 MB / 0.6655 GB, free: 0.668 MB / 0.5294 GB
Notification: Performance of FrontEnd - loaded program: time 0.001242/0.001242, allocations: 63.91 kB / 0.9516 GB, free: 7.66 MB / 0.7325 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.6799/0.6811, allocations: 140.4 MB / 1.089 GB, free: 5.551 MB / 0.8575 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/Blocks/Math.mo:543:5-544:48:writable] Warning: Parameter fan3.gaiSpe.k has no value, and is fixed during initialization (fixed=true), using available start value (start=1) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/Blocks/Math.mo:543:5-544:48:writable] Warning: Parameter fan2.gaiSpe.k has no value, and is fixed during initialization (fixed=true), using available start value (start=1) as default value.
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Movers.Validation.ControlledFlowMachineDynamic): time 0.3611/1.042, allocations: 373.2 MB / 1.453 GB, free: 7.871 MB / 1.186 GB
Notification: Performance of NFInst.instExpressions: time 0.05822/1.1, allocations: 47.72 MB / 1.5 GB, free: 8.004 MB / 1.232 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.005067/1.106, allocations: 183 kB / 1.5 GB, free: 7.824 MB / 1.232 GB
Notification: Performance of NFTyping.typeComponents: time 0.007578/1.113, allocations: 3.154 MB / 1.503 GB, free: 4.652 MB / 1.232 GB
Notification: Performance of NFTyping.typeBindings: time 0.02123/1.134, allocations: 9.323 MB / 1.512 GB, free: 11.3 MB / 1.248 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01072/1.145, allocations: 4.489 MB / 1.516 GB, free: 6.82 MB / 1.248 GB
Notification: Performance of NFFlatten.flatten: time 0.01722/1.162, allocations: 13.47 MB / 1.53 GB, free: 9.32 MB / 1.264 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.007661/1.17, allocations: 4.84 MB / 1.534 GB, free: 4.395 MB / 1.264 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01536/1.185, allocations: 7.786 MB / 1.542 GB, free: 12.58 MB / 1.279 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.007506/1.193, allocations: 4.344 MB / 1.546 GB, free: 8.23 MB / 1.279 GB
Notification: Performance of NFPackage.collectConstants: time 0.001893/1.195, allocations: 0.5938 MB / 1.547 GB, free: 7.637 MB / 1.279 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01364/1.209, allocations: 6.845 MB / 1.553 GB, free: 0.7773 MB / 1.279 GB
Notification: Performance of NFScalarize.scalarize: time 0.003638/1.212, allocations: 2.692 MB / 1.556 GB, free: 14.08 MB / 1.295 GB
Notification: Performance of NFVerifyModel.verify: time 0.006599/1.219, allocations: 3.76 MB / 1.56 GB, free: 10.3 MB / 1.295 GB
Notification: Performance of NFConvertDAE.convert: time 0.01918/1.238, allocations: 12.33 MB / 1.572 GB, free: 13.94 MB / 1.311 GB
Notification: Performance of FrontEnd - DAE generated: time 4.679e-06/1.238, allocations: 0 / 1.572 GB, free: 13.94 MB / 1.311 GB
Notification: Performance of FrontEnd: time 1.753e-06/1.238, allocations: 0 / 1.572 GB, free: 13.94 MB / 1.311 GB
Notification: Performance of Transformations before backend: time 0.0003262/1.238, allocations: 0 / 1.572 GB, free: 13.94 MB / 1.311 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 813
 * Number of variables: 813
Notification: Performance of Generate backend data structure: time 0.01849/1.257, allocations: 7.931 MB / 1.579 GB, free: 5.898 MB / 1.311 GB
Notification: Performance of prepare preOptimizeDAE: time 4.109e-05/1.257, allocations: 8.031 kB / 1.58 GB, free: 5.891 MB / 1.311 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0138/1.271, allocations: 2.04 MB / 1.582 GB, free: 3.84 MB / 1.311 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.492/1.763, allocations: 6.646 MB / 1.588 GB, free: 443 MB / 1.311 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002612/1.763, allocations: 270.8 kB / 1.588 GB, free: 442.8 MB / 1.311 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0009865/1.764, allocations: 369.1 kB / 1.589 GB, free: 442.7 MB / 1.311 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.008718/1.773, allocations: 4.528 MB / 1.593 GB, free: 440.9 MB / 1.311 GB
Notification: Performance of preOpt findStateOrder (simulation): time 6.507e-05/1.773, allocations: 6.812 kB / 1.593 GB, free: 440.9 MB / 1.311 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003233/1.773, allocations: 133.7 kB / 1.593 GB, free: 440.8 MB / 1.311 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001279/1.773, allocations: 125.8 kB / 1.593 GB, free: 440.8 MB / 1.311 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.007344/1.781, allocations: 3.408 MB / 1.597 GB, free: 439.7 MB / 1.311 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.02849/1.809, allocations: 19.2 MB / 1.615 GB, free: 427.4 MB / 1.311 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.00621/1.815, allocations: 2.801 MB / 1.618 GB, free: 426.4 MB / 1.311 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002948/1.818, allocations: 1.589 MB / 1.62 GB, free: 425.8 MB / 1.311 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0003173/1.819, allocations: 224.6 kB / 1.62 GB, free: 425.7 MB / 1.311 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.003375/1.822, allocations: 2.016 MB / 1.622 GB, free: 425 MB / 1.311 GB
Notification: Performance of pre-optimization done (n=192): time 3.848e-06/1.822, allocations: 0 / 1.622 GB, free: 425 MB / 1.311 GB
Notification: Performance of matching and sorting (n=192): time 0.01057/1.833, allocations: 4.526 MB / 1.626 GB, free: 423.2 MB / 1.311 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.449e-05/1.833, allocations: 73.31 kB / 1.626 GB, free: 423.1 MB / 1.311 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.008625/1.841, allocations: 5.884 MB / 1.632 GB, free: 421.1 MB / 1.311 GB
Notification: Performance of collectPreVariables (initialization): time 0.0007797/1.842, allocations: 81.55 kB / 1.632 GB, free: 421 MB / 1.311 GB
Notification: Performance of collectInitialEqns (initialization): time 0.002104/1.844, allocations: 2.734 MB / 1.635 GB, free: 418.9 MB / 1.311 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0009688/1.845, allocations: 0.677 MB / 1.635 GB, free: 418.3 MB / 1.311 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001045/1.846, allocations: 0.6653 MB / 1.636 GB, free: 418.1 MB / 1.311 GB
Notification: Performance of setup shared object (initialization): time 3.514e-05/1.846, allocations: 306.9 kB / 1.636 GB, free: 417.8 MB / 1.311 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003473/1.85, allocations: 2.22 MB / 1.639 GB, free: 417 MB / 1.311 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.004398/1.854, allocations: 3.328 MB / 1.642 GB, free: 414.8 MB / 1.311 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.007338/1.862, allocations: 5.524 MB / 1.647 GB, free: 411.8 MB / 1.311 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.817e-05/1.862, allocations: 12.97 kB / 1.647 GB, free: 411.8 MB / 1.311 GB
Notification: Performance of matching and sorting (n=389) (initialization): time 0.01067/1.872, allocations: 6.383 MB / 1.653 GB, free: 409.3 MB / 1.311 GB
Notification: Performance of prepare postOptimizeDAE: time 6.153e-05/1.873, allocations: 49.23 kB / 1.654 GB, free: 409.3 MB / 1.311 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.453e-05/1.873, allocations: 33.31 kB / 1.654 GB, free: 409.3 MB / 1.311 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001207/1.874, allocations: 0.5638 MB / 1.654 GB, free: 409.1 MB / 1.311 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003813/1.878, allocations: 0.7506 MB / 1.655 GB, free: 409.1 MB / 1.311 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002793/1.88, allocations: 3.749 MB / 1.658 GB, free: 405.9 MB / 1.311 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005031/1.885, allocations: 409.1 kB / 1.659 GB, free: 405.7 MB / 1.311 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0005746/1.886, allocations: 226.3 kB / 1.659 GB, free: 405.6 MB / 1.311 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.005766/1.892, allocations: 3.174 MB / 1.662 GB, free: 404.3 MB / 1.311 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.003628/1.895, allocations: 2.955 MB / 1.665 GB, free: 402.3 MB / 1.311 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.005946/1.901, allocations: 4.803 MB / 1.67 GB, free: 399.2 MB / 1.311 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 4.104e-05/1.901, allocations: 11.92 kB / 1.67 GB, free: 399.2 MB / 1.311 GB
Notification: Performance of matching and sorting (n=389) (initialization_lambda0): time 0.009356/1.911, allocations: 5.658 MB / 1.675 GB, free: 396.3 MB / 1.311 GB
Notification: Performance of prepare postOptimizeDAE: time 4.733e-05/1.911, allocations: 49.41 kB / 1.675 GB, free: 396.3 MB / 1.311 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.444e-05/1.911, allocations: 31.5 kB / 1.675 GB, free: 396.3 MB / 1.311 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001559/1.913, allocations: 0.66 MB / 1.676 GB, free: 396 MB / 1.311 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002894/1.915, allocations: 0.7188 MB / 1.677 GB, free: 395.9 MB / 1.311 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.009996/1.925, allocations: 9.284 MB / 1.686 GB, free: 389.4 MB / 1.311 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004739/1.93, allocations: 318.4 kB / 1.686 GB, free: 389.2 MB / 1.311 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0005871/1.931, allocations: 195.4 kB / 1.686 GB, free: 389.2 MB / 1.311 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 133
 * Number of states: 0 ()
 * Number of discrete variables: 5 (y.count,$PRE.y.count,y.T_start,$PRE.y.T_start,$whenCondition1)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (340):
 * Single equations (assignments): 330
 * Array equations: 4
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 3
 * Torn equation systems: 2
 * 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): 3 systems
   {1, 1, 1}
 * Without analytic Jacobian (size): 0 systems
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,4), (1,4)}
Notification: Performance of prepare postOptimizeDAE: time 0.00123/1.932, allocations: 377.9 kB / 1.687 GB, free: 388.9 MB / 1.311 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001375/1.933, allocations: 0.5311 MB / 1.687 GB, free: 388.6 MB / 1.311 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.00701/1.94, allocations: 3.507 MB / 1.691 GB, free: 385.2 MB / 1.311 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.004726/1.945, allocations: 3.047 MB / 1.694 GB, free: 382.1 MB / 1.311 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.131e-06/1.945, allocations: 0 / 1.694 GB, free: 382.1 MB / 1.311 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002377/1.948, allocations: 0.884 MB / 1.694 GB, free: 381.2 MB / 1.311 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001209/1.949, allocations: 44 kB / 1.694 GB, free: 381.2 MB / 1.311 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003202/1.952, allocations: 136.8 kB / 1.695 GB, free: 381 MB / 1.311 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002881/1.952, allocations: 141.8 kB / 1.695 GB, free: 380.9 MB / 1.311 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.007395/1.96, allocations: 3.369 MB / 1.698 GB, free: 377.5 MB / 1.311 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.00765/1.967, allocations: 4.874 MB / 1.703 GB, free: 372.6 MB / 1.311 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.001977/1.969, allocations: 1.316 MB / 1.704 GB, free: 371.3 MB / 1.311 GB
Notification: Performance of sorting global known variables: time 0.005896/1.975, allocations: 4.043 MB / 1.708 GB, free: 367.3 MB / 1.311 GB
Notification: Performance of Backend: time 7.92e-07/1.975, allocations: 0 / 1.708 GB, free: 367.3 MB / 1.311 GB
Notification: Performance of simCode: created initialization part: time 0.01798/1.993, allocations: 7.594 MB / 1.715 GB, free: 359.9 MB / 1.311 GB
Notification: Performance of SimCode: time 0.02313/2.017, allocations: 13.58 MB / 1.729 GB, free: 346.3 MB / 1.311 GB
Notification: Performance of Templates: time 0.1758/2.192, allocations: 146 MB / 1.871 GB, free: 202.2 MB / 1.311 GB
make -j1 -f Buildings_9_Buildings.Fluid.Movers.Validation.ControlledFlowMachineDynamic.makefile
(rm -f Buildings_9_Buildings.Fluid.Movers.Validation.ControlledFlowMachineDynamic.pipe ; mkfifo Buildings_9_Buildings.Fluid.Movers.Validation.ControlledFlowMachineDynamic.pipe ; head -c 1048576 < Buildings_9_Buildings.Fluid.Movers.Validation.ControlledFlowMachineDynamic.pipe >> ../files/Buildings_9_Buildings.Fluid.Movers.Validation.ControlledFlowMachineDynamic.sim & ./Buildings_9_Buildings.Fluid.Movers.Validation.ControlledFlowMachineDynamic  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_9_Buildings.Fluid.Movers.Validation.ControlledFlowMachineDynamic.pipe 2>&1)
diffSimulationResults("Buildings_9_Buildings.Fluid.Movers.Validation.ControlledFlowMachineDynamic_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_9.1.x/Buildings_Fluid_Movers_Validation_ControlledFlowMachineDynamic.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_9_Buildings.Fluid.Movers.Validation.ControlledFlowMachineDynamic.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches