Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_11_Buildings.Fluid.Chillers.Validation.CarnotVerifyCOP.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.0009522/0.0009522, allocations: 83.59 kB / 20.45 MB, free: 4.113 MB / 18.57 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.001188/0.001188, allocations: 165 kB / 23.82 MB, free: 0.7422 MB / 18.57 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 0.95/0.95, allocations: 177.1 MB / 204.2 MB, free: 5.648 MB / 186.7 MB " [Timeout remaining time 179] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.2-maint.11.x/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.2-maint.11.x/package.mo): time 1.758/1.758, allocations: 359 MB / 0.6052 GB, free: 10.98 MB / 0.573 GB " [Timeout remaining time 178] Using package Buildings with version 11.1.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.2-maint.11.x/package.mo) Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo) Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo) Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo) Running command: translateModel(Buildings.Fluid.Chillers.Validation.CarnotVerifyCOP,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|chi_TEva.COP_nominal|chi_TEva.COP|chi_TEva.m1_flow|chi_TEva.m2_flow|chi_TEva.m1_flow_nominal|chi_TEva.m2_flow_nominal|chi_TEva.TCon_nominal|chi_TEva.TEva_nominal|chi_TEva.sta_b1.T|chi_TEva.sta_b2.T|chi_TEva.sta_a1.T|chi_TEva.sta_a2.T|chi_y.COP_nominal|chi_y.COP|chi_y.m1_flow_nominal|chi_y.m2_flow_nominal|chi_y.m2_flow|chi_y.m1_flow|chi_y.TCon_nominal|chi_y.TEva_nominal|chi_y.sta_a1.T|chi_y.sta_b1.T|chi_y.sta_a2.T|chi_y.sta_b2.T",fileNamePrefix="Buildings_11_Buildings.Fluid.Chillers.Validation.CarnotVerifyCOP") translateModel(Buildings.Fluid.Chillers.Validation.CarnotVerifyCOP,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|chi_TEva.COP_nominal|chi_TEva.COP|chi_TEva.m1_flow|chi_TEva.m2_flow|chi_TEva.m1_flow_nominal|chi_TEva.m2_flow_nominal|chi_TEva.TCon_nominal|chi_TEva.TEva_nominal|chi_TEva.sta_b1.T|chi_TEva.sta_b2.T|chi_TEva.sta_a1.T|chi_TEva.sta_a2.T|chi_y.COP_nominal|chi_y.COP|chi_y.m1_flow_nominal|chi_y.m2_flow_nominal|chi_y.m2_flow|chi_y.m1_flow|chi_y.TCon_nominal|chi_y.TEva_nominal|chi_y.sta_a1.T|chi_y.sta_b1.T|chi_y.sta_a2.T|chi_y.sta_b2.T",fileNamePrefix="Buildings_11_Buildings.Fluid.Chillers.Validation.CarnotVerifyCOP") [Timeout 300] "Notification: Performance of FrontEnd - loaded program: time 1.302e-06/1.302e-06, allocations: 0 / 0.7871 GB, free: 12.47 MB / 0.7448 GB Notification: Performance of FrontEnd - Absyn->SCode: time 2.385e-05/2.516e-05, allocations: 2.312 kB / 0.7871 GB, free: 12.46 MB / 0.7448 GB Notification: Performance of NFInst.instantiate(Buildings.Fluid.Chillers.Validation.CarnotVerifyCOP): time 0.02325/0.02328, allocations: 32.6 MB / 0.8189 GB, free: 11.77 MB / 0.7761 GB Notification: Performance of NFInst.instExpressions: time 0.01613/0.03941, allocations: 9.638 MB / 0.8283 GB, free: 2.156 MB / 0.7761 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.003893/0.0433, allocations: 174.5 kB / 0.8285 GB, free: 1.984 MB / 0.7761 GB Notification: Performance of NFTyping.typeComponents: time 0.001995/0.0453, allocations: 0.7636 MB / 0.8293 GB, free: 1.215 MB / 0.7761 GB Notification: Performance of NFTyping.typeBindings: time 0.005692/0.05099, allocations: 2.68 MB / 0.8319 GB, free: 14.52 MB / 0.7917 GB Notification: Performance of NFTyping.typeClassSections: time 0.003845/0.05483, allocations: 2.186 MB / 0.834 GB, free: 12.34 MB / 0.7917 GB Notification: Performance of NFFlatten.flatten: time 0.007277/0.06211, allocations: 6.524 MB / 0.8404 GB, free: 5.793 MB / 0.7917 GB Notification: Performance of NFFlatten.resolveConnections: time 0.002934/0.06504, allocations: 1.907 MB / 0.8422 GB, free: 3.82 MB / 0.7917 GB Notification: Performance of NFEvalConstants.evaluate: time 0.006058/0.0711, allocations: 3.347 MB / 0.8455 GB, free: 500 kB / 0.7917 GB Notification: Performance of NFSimplifyModel.simplify: time 0.002638/0.07374, allocations: 1.581 MB / 0.8471 GB, free: 14.9 MB / 0.8073 GB Notification: Performance of NFPackage.collectConstants: time 0.000665/0.0744, allocations: 236 kB / 0.8473 GB, free: 14.67 MB / 0.8073 GB Notification: Performance of NFFlatten.collectFunctions: time 0.001655/0.07606, allocations: 0.702 MB / 0.848 GB, free: 13.97 MB / 0.8073 GB Notification: Performance of NFScalarize.scalarize: time 0.0005617/0.07662, allocations: 0.6183 MB / 0.8486 GB, free: 13.35 MB / 0.8073 GB Notification: Performance of NFVerifyModel.verify: time 0.001503/0.07812, allocations: 0.9391 MB / 0.8495 GB, free: 12.41 MB / 0.8073 GB Notification: Performance of NFConvertDAE.convert: time 0.003406/0.08153, allocations: 2.367 MB / 0.8518 GB, free: 10.03 MB / 0.8073 GB Notification: Performance of FrontEnd - DAE generated: time 5.28e-06/0.08154, allocations: 0 / 0.8518 GB, free: 10.03 MB / 0.8073 GB Notification: Performance of FrontEnd: time 1.312e-06/0.08154, allocations: 0 / 0.8518 GB, free: 10.03 MB / 0.8073 GB Notification: Performance of Transformations before backend: time 9.775e-05/0.08163, allocations: 0 / 0.8518 GB, free: 10.03 MB / 0.8073 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 388 * Number of variables: 388 Notification: Performance of Generate backend data structure: time 0.004157/0.08579, allocations: 3.124 MB / 0.8548 GB, free: 6.828 MB / 0.8073 GB Notification: Performance of prepare preOptimizeDAE: time 4.436e-05/0.08584, allocations: 12.03 kB / 0.8549 GB, free: 6.816 MB / 0.8073 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002056/0.08789, allocations: 0.8455 MB / 0.8557 GB, free: 5.969 MB / 0.8073 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.002571/0.09046, allocations: 2.18 MB / 0.8578 GB, free: 3.707 MB / 0.8073 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 8.965e-05/0.09055, allocations: 127 kB / 0.8579 GB, free: 3.582 MB / 0.8073 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001546/0.09071, allocations: 160 kB / 0.8581 GB, free: 3.426 MB / 0.8073 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.002093/0.0928, allocations: 1.434 MB / 0.8595 GB, free: 1.891 MB / 0.8073 GB Notification: Performance of preOpt findStateOrder (simulation): time 2.393e-05/0.09282, allocations: 0 / 0.8595 GB, free: 1.891 MB / 0.8073 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 9.994e-05/0.09292, allocations: 60 kB / 0.8595 GB, free: 1.832 MB / 0.8073 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 2.604e-05/0.09295, allocations: 40 kB / 0.8596 GB, free: 1.793 MB / 0.8073 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001243/0.09419, allocations: 0.6985 MB / 0.8603 GB, free: 1.094 MB / 0.8073 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.006725/0.1009, allocations: 6.406 MB / 0.8665 GB, free: 10.53 MB / 0.823 GB Notification: Performance of preOpt comSubExp (simulation): time 0.001481/0.1024, allocations: 0.6736 MB / 0.8672 GB, free: 9.836 MB / 0.823 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.0002982/0.1027, allocations: 203.8 kB / 0.8674 GB, free: 9.629 MB / 0.823 GB Notification: Performance of preOpt evalFunc (simulation): time 0.0001345/0.1028, allocations: 43.97 kB / 0.8674 GB, free: 9.586 MB / 0.823 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.035e-05/0.1029, allocations: 45.39 kB / 0.8675 GB, free: 9.531 MB / 0.823 GB Notification: Performance of pre-optimization done (n=76): time 4.949e-06/0.1029, allocations: 0 / 0.8675 GB, free: 9.531 MB / 0.823 GB Notification: Performance of matching and sorting (n=76): time 0.00338/0.1063, allocations: 1.335 MB / 0.8688 GB, free: 8.18 MB / 0.823 GB Notification: Performance of inlineWhenForInitialization (initialization): time 5.733e-05/0.1063, allocations: 89.11 kB / 0.8688 GB, free: 8.074 MB / 0.823 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.00196/0.1083, allocations: 1.686 MB / 0.8705 GB, free: 6.348 MB / 0.823 GB Notification: Performance of collectPreVariables (initialization): time 8.745e-05/0.1084, allocations: 45.7 kB / 0.8705 GB, free: 6.297 MB / 0.823 GB Notification: Performance of collectInitialEqns (initialization): time 0.0007723/0.1091, allocations: 1.142 MB / 0.8717 GB, free: 5.141 MB / 0.823 GB Notification: Performance of collectInitialBindings (initialization): time 0.0002417/0.1094, allocations: 281.6 kB / 0.8719 GB, free: 4.863 MB / 0.823 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0003245/0.1097, allocations: 256.4 kB / 0.8722 GB, free: 4.602 MB / 0.823 GB Notification: Performance of setup shared object (initialization): time 0.0001642/0.1099, allocations: 0.516 MB / 0.8727 GB, free: 4.078 MB / 0.823 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.0003732/0.1102, allocations: 162.5 kB / 0.8728 GB, free: 3.922 MB / 0.823 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.0009093/0.1111, allocations: 1.358 MB / 0.8742 GB, free: 2.18 MB / 0.823 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.0009314/0.1121, allocations: 0.7623 MB / 0.8749 GB, free: 1.258 MB / 0.823 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.281e-06/0.1121, allocations: 0 / 0.8749 GB, free: 1.258 MB / 0.823 GB Notification: Performance of matching and sorting (n=127) (initialization): time 0.00287/0.115, allocations: 1.295 MB / 0.8762 GB, free: 15.94 MB / 0.8386 GB Notification: Performance of prepare postOptimizeDAE: time 3.521e-05/0.115, allocations: 11.98 kB / 0.8762 GB, free: 15.93 MB / 0.8386 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.606e-05/0.115, allocations: 8 kB / 0.8762 GB, free: 15.92 MB / 0.8386 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.0008731/0.1159, allocations: 341.8 kB / 0.8765 GB, free: 15.58 MB / 0.8386 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0005363/0.1164, allocations: 231.7 kB / 0.8767 GB, free: 15.36 MB / 0.8386 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001096/0.1175, allocations: 1.826 MB / 0.8785 GB, free: 13.46 MB / 0.8386 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0009598/0.1185, allocations: 223.1 kB / 0.8787 GB, free: 13.25 MB / 0.8386 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.106e-05/0.1186, allocations: 59.95 kB / 0.8788 GB, free: 13.19 MB / 0.8386 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 38 * 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 (105): * Single equations (assignments): 103 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * 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,14), (1,8)} Notification: Performance of prepare postOptimizeDAE: time 0.0004245/0.119, allocations: 232.3 kB / 0.879 GB, free: 12.95 MB / 0.8386 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002458/0.1192, allocations: 230.6 kB / 0.8792 GB, free: 12.73 MB / 0.8386 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0013/0.1205, allocations: 0.9339 MB / 0.8801 GB, free: 11.78 MB / 0.8386 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.363e-05/0.1205, allocations: 15.94 kB / 0.8802 GB, free: 11.76 MB / 0.8386 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 6.733e-06/0.1206, allocations: 4 kB / 0.8802 GB, free: 11.76 MB / 0.8386 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.01e-05/0.1206, allocations: 7.969 kB / 0.8802 GB, free: 11.75 MB / 0.8386 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.003309/0.1239, allocations: 2.557 MB / 0.8827 GB, free: 9.086 MB / 0.8386 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 9.998e-06/0.1239, allocations: 7.938 kB / 0.8827 GB, free: 9.078 MB / 0.8386 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0002739/0.1242, allocations: 111.8 kB / 0.8828 GB, free: 8.969 MB / 0.8386 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.0006931/0.1248, allocations: 331.4 kB / 0.8831 GB, free: 8.637 MB / 0.8386 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 4.88e-05/0.1249, allocations: 23.98 kB / 0.8831 GB, free: 8.613 MB / 0.8386 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001109/0.126, allocations: 1.876 MB / 0.8849 GB, free: 6.676 MB / 0.8386 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.547e-06/0.126, allocations: 4 kB / 0.8849 GB, free: 6.672 MB / 0.8386 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.002015/0.128, allocations: 1.391 MB / 0.8863 GB, free: 5.199 MB / 0.8386 GB Notification: Performance of postOpt removeConstants (simulation): time 0.0005415/0.1286, allocations: 368.2 kB / 0.8867 GB, free: 4.836 MB / 0.8386 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001562/0.1287, allocations: 23.92 kB / 0.8867 GB, free: 4.812 MB / 0.8386 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0005566/0.1293, allocations: 75.94 kB / 0.8868 GB, free: 4.738 MB / 0.8386 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 6.812e-05/0.1293, allocations: 59.83 kB / 0.8868 GB, free: 4.68 MB / 0.8386 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 5.822e-05/0.1294, allocations: 47.91 kB / 0.8869 GB, free: 4.633 MB / 0.8386 GB Notification: Performance of sorting global known variables: time 0.001117/0.1305, allocations: 1.005 MB / 0.8878 GB, free: 3.609 MB / 0.8386 GB Notification: Performance of sort global known variables: time 2.3e-07/0.1305, allocations: 0 / 0.8878 GB, free: 3.609 MB / 0.8386 GB Notification: Performance of remove unused functions: time 0.001287/0.1318, allocations: 0.5885 MB / 0.8884 GB, free: 3.02 MB / 0.8386 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 14 * 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 simulation (62): * Single equations (assignments): 52 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 8 * 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,16), (1,9)} Notification: Performance of Backend phase and start with SimCode phase: time 0.0004007/0.1322, allocations: 214.8 kB / 0.8886 GB, free: 2.801 MB / 0.8386 GB Notification: Performance of simCode: created initialization part: time 0.001503/0.1337, allocations: 0.668 MB / 0.8893 GB, free: 2.133 MB / 0.8386 GB Notification: Performance of simCode: created event and clocks part: time 4.719e-06/0.1337, allocations: 0 / 0.8893 GB, free: 2.133 MB / 0.8386 GB Notification: Performance of simCode: created simulation system equations: time 0.0006989/0.1344, allocations: 394.2 kB / 0.8896 GB, free: 1.742 MB / 0.8386 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002283/0.1367, allocations: 0.9068 MB / 0.8905 GB, free: 0.8516 MB / 0.8386 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.004676/0.1414, allocations: 3.231 MB / 0.8937 GB, free: 13.52 MB / 0.8542 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0002764/0.1417, allocations: 358.2 kB / 0.894 GB, free: 13.14 MB / 0.8542 GB Notification: Performance of simCode: alias equations: time 0.001012/0.1427, allocations: 351.4 kB / 0.8944 GB, free: 12.79 MB / 0.8542 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0002658/0.1429, allocations: 140.5 kB / 0.8945 GB, free: 12.66 MB / 0.8542 GB Notification: Performance of SimCode: time 2.044e-06/0.1429, allocations: 0 / 0.8945 GB, free: 12.66 MB / 0.8542 GB Notification: Performance of Templates: time 0.04836/0.1913, allocations: 37.69 MB / 0.9313 GB, free: 7.832 MB / 0.8855 GB " [Timeout remaining time 300] make -j1 -f Buildings_11_Buildings.Fluid.Chillers.Validation.CarnotVerifyCOP.makefile [Timeout 300] (rm -f Buildings_11_Buildings.Fluid.Chillers.Validation.CarnotVerifyCOP.pipe ; mkfifo Buildings_11_Buildings.Fluid.Chillers.Validation.CarnotVerifyCOP.pipe ; head -c 1048576 < Buildings_11_Buildings.Fluid.Chillers.Validation.CarnotVerifyCOP.pipe >> ../files/Buildings_11_Buildings.Fluid.Chillers.Validation.CarnotVerifyCOP.sim & ./Buildings_11_Buildings.Fluid.Chillers.Validation.CarnotVerifyCOP -abortSlowSimulation -alarm=240 -emit_protected -lv LOG_STATS > Buildings_11_Buildings.Fluid.Chillers.Validation.CarnotVerifyCOP.pipe 2>&1) [Timeout 240] diffSimulationResults("Buildings_11_Buildings.Fluid.Chillers.Validation.CarnotVerifyCOP_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_11.x/Buildings_Fluid_Chillers_Validation_CarnotVerifyCOP.csv","",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 300] "" [Timeout remaining time 300] Reference file matches [Calling sys.exit(0), Time elapsed: 5.783758518751711]