Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_master_IBPSA.Fluid.Chillers.Validation.CarnotVerifyCOP.conf.json
Using package ModelicaServices with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo)
Using package Modelica with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo)
Using package IBPSA with version 3.0.0 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/package.mo)
Using package Complex with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo)
Running command: translateModel(IBPSA.Fluid.Chillers.Validation.CarnotVerifyCOP,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_master_IBPSA.Fluid.Chillers.Validation.CarnotVerifyCOP")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.002023/0.002027, allocations: 185.2 kB / 15.76 MB, free: 5.996 MB / 13.93 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/package.mo): time 0.8047/0.8047, allocations: 82.92 MB / 99.42 MB, free: 3.367 MB / 74.72 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 2.171/2.171, allocations: 205.4 MB / 325.4 MB, free: 3.434 MB / 250.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.001022/0.001021, allocations: 98.84 kB / 393.6 MB, free: 15.2 MB / 330.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004413/0.0004415, allocations: 12 kB / 471.5 MB, free: 66.58 MB / 362.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.08905/0.08951, allocations: 67.44 MB / 0.5263 GB, free: 15.1 MB / 378.7 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.Chillers.Validation.CarnotVerifyCOP): time 0.4968/0.5863, allocations: 110.6 MB / 0.6343 GB, free: 15.39 MB / 426.7 MB
Notification: Performance of NFInst.instExpressions: time 0.078/0.6644, allocations: 19.74 MB / 0.6536 GB, free: 296 kB / 426.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.006418/0.6709, allocations: 106 kB / 0.6537 GB, free: 244 kB / 426.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.008835/0.6798, allocations: 1.358 MB / 0.655 GB, free: 15.06 MB / 442.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.02572/0.7055, allocations: 4.097 MB / 0.659 GB, free: 11.61 MB / 442.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.01524/0.7208, allocations: 2.603 MB / 0.6616 GB, free: 9.855 MB / 442.7 MB
Notification: Performance of NFFlatten.flatten: time 0.0115/0.7324, allocations: 3.891 MB / 0.6654 GB, free: 7.305 MB / 442.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.003828/0.7362, allocations: 1.695 MB / 0.667 GB, free: 5.949 MB / 442.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.005943/0.7422, allocations: 2.02 MB / 0.669 GB, free: 3.922 MB / 442.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.00311/0.7454, allocations: 1.252 MB / 0.6702 GB, free: 2.664 MB / 442.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0005671/0.746, allocations: 92 kB / 0.6703 GB, free: 2.574 MB / 442.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.005353/0.7514, allocations: 1.338 MB / 0.6716 GB, free: 1.234 MB / 442.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.0009218/0.7523, allocations: 410.2 kB / 0.672 GB, free: 0.832 MB / 442.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.001844/0.7542, allocations: 0.555 MB / 0.6726 GB, free: 276 kB / 442.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.009733/0.764, allocations: 3.117 MB / 0.6756 GB, free: 13.14 MB / 458.7 MB
Notification: Performance of FrontEnd - DAE generated: time 4.931e-06/0.764, allocations: 0 / 0.6756 GB, free: 13.14 MB / 458.7 MB
Notification: Performance of FrontEnd: time 3.052e-06/0.7641, allocations: 0 / 0.6756 GB, free: 13.14 MB / 458.7 MB
Notification: Performance of Transformations before backend: time 8.116e-05/0.7642, allocations: 0 / 0.6756 GB, free: 13.14 MB / 458.7 MB
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.008268/0.7724, allocations: 2.71 MB / 0.6783 GB, free: 10.35 MB / 458.7 MB
Notification: Performance of prepare preOptimizeDAE: time 4.343e-05/0.7725, allocations: 8.031 kB / 0.6783 GB, free: 10.34 MB / 458.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005691/0.7782, allocations: 0.9606 MB / 0.6792 GB, free: 9.379 MB / 458.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.005722/0.784, allocations: 2.094 MB / 0.6812 GB, free: 7.211 MB / 458.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001196/0.7852, allocations: 326.8 kB / 0.6816 GB, free: 6.891 MB / 458.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0004284/0.7857, allocations: 160 kB / 0.6817 GB, free: 6.734 MB / 458.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.005989/0.7917, allocations: 1.958 MB / 0.6836 GB, free: 4.711 MB / 458.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 4.4e-05/0.7918, allocations: 3.938 kB / 0.6836 GB, free: 4.707 MB / 458.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002245/0.792, allocations: 64 kB / 0.6837 GB, free: 4.645 MB / 458.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.464e-05/0.7921, allocations: 39.95 kB / 0.6837 GB, free: 4.605 MB / 458.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.006841/0.7989, allocations: 1.889 MB / 0.6856 GB, free: 2.715 MB / 458.7 MB
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.01923/0.8182, allocations: 9.177 MB / 0.6945 GB, free: 8.941 MB / 474.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.005901/0.8241, allocations: 1.322 MB / 0.6958 GB, free: 7.602 MB / 474.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.001694/0.8259, allocations: 1.715 MB / 0.6975 GB, free: 5.5 MB / 474.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 5.278e-05/0.826, allocations: 46.56 kB / 0.6975 GB, free: 5.445 MB / 474.7 MB
Notification: Performance of pre-optimization done (n=76): time 4.572e-06/0.826, allocations: 3.938 kB / 0.6975 GB, free: 5.441 MB / 474.7 MB
Notification: Performance of matching and sorting (n=76): time 0.0114/0.8374, allocations: 2.482 MB / 0.7 GB, free: 2.906 MB / 474.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.541e-05/0.8375, allocations: 89.06 kB / 0.7001 GB, free: 2.801 MB / 474.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.005978/0.8435, allocations: 2.551 MB / 0.7025 GB, free: 236 kB / 474.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0002209/0.8438, allocations: 45.7 kB / 0.7026 GB, free: 184 kB / 474.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.001399/0.8452, allocations: 1.053 MB / 0.7036 GB, free: 15.12 MB / 490.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0005581/0.8458, allocations: 268.2 kB / 0.7039 GB, free: 14.85 MB / 490.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001831/0.846, allocations: 24 kB / 0.7039 GB, free: 14.83 MB / 490.7 MB
Notification: Performance of setup shared object (initialization): time 0.0002766/0.8463, allocations: 345.9 kB / 0.7042 GB, free: 14.48 MB / 490.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002788/0.8491, allocations: 0.6232 MB / 0.7048 GB, free: 13.86 MB / 490.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003054/0.8522, allocations: 1.009 MB / 0.7058 GB, free: 12.7 MB / 490.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.00264/0.8548, allocations: 0.6816 MB / 0.7065 GB, free: 12.02 MB / 490.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.512e-05/0.8549, allocations: 4 kB / 0.7065 GB, free: 12.02 MB / 490.7 MB
Notification: Performance of matching and sorting (n=133) (initialization): time 0.01004/0.8649, allocations: 1.959 MB / 0.7084 GB, free: 10.04 MB / 490.7 MB
Notification: Performance of prepare postOptimizeDAE: time 4.516e-05/0.865, allocations: 8.625 kB / 0.7084 GB, free: 10.04 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.113e-05/0.8651, allocations: 12 kB / 0.7084 GB, free: 10.02 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.003604/0.8687, allocations: 441.2 kB / 0.7088 GB, free: 9.586 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002862/0.8716, allocations: 303.6 kB / 0.7091 GB, free: 9.289 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.005022/0.8767, allocations: 1.546 MB / 0.7106 GB, free: 7.691 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.007444/0.8842, allocations: 486 kB / 0.7111 GB, free: 7.215 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0005104/0.8848, allocations: 63.95 kB / 0.7112 GB, free: 7.152 MB / 490.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 35
 * 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 (112):
 * Single equations (assignments): 110
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 2 {1 13,1 8}
Notification: Performance of prepare postOptimizeDAE: time 0.002424/0.8872, allocations: 469.4 kB / 0.7116 GB, free: 6.684 MB / 490.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001234/0.8885, allocations: 241 kB / 0.7118 GB, free: 6.445 MB / 490.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.00999/0.8985, allocations: 1.549 MB / 0.7134 GB, free: 4.879 MB / 490.7 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 5.056e-05/0.8986, allocations: 12 kB / 0.7134 GB, free: 4.867 MB / 490.7 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.306e-05/0.8987, allocations: 0 / 0.7134 GB, free: 4.867 MB / 490.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 3.19e-05/0.8987, allocations: 3.984 kB / 0.7134 GB, free: 4.863 MB / 490.7 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01517/0.9139, allocations: 3.729 MB / 0.717 GB, free: 1.023 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.327e-05/0.914, allocations: 7.984 kB / 0.717 GB, free: 1.016 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.000869/0.9148, allocations: 132.2 kB / 0.7171 GB, free: 0.8867 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (simulation): time 0.003434/0.9183, allocations: 442.9 kB / 0.7176 GB, free: 460 kB / 490.7 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0002532/0.9186, allocations: 31.94 kB / 0.7176 GB, free: 428 kB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.005705/0.9243, allocations: 1.628 MB / 0.7192 GB, free: 14.74 MB / 0.4948 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.216e-05/0.9244, allocations: 4 kB / 0.7192 GB, free: 14.73 MB / 0.4948 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01441/0.9388, allocations: 2.337 MB / 0.7215 GB, free: 12.21 MB / 0.4948 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002718/0.9416, allocations: 0.5248 MB / 0.722 GB, free: 11.66 MB / 0.4948 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001106/0.9428, allocations: 16 kB / 0.722 GB, free: 11.64 MB / 0.4948 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.005252/0.9481, allocations: 195.7 kB / 0.7222 GB, free: 11.45 MB / 0.4948 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002894/0.9484, allocations: 59.88 kB / 0.7222 GB, free: 11.39 MB / 0.4948 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002675/0.9487, allocations: 35.97 kB / 0.7223 GB, free: 11.36 MB / 0.4948 GB
Notification: Performance of sorting global known variables: time 0.008417/0.9571, allocations: 1.797 MB / 0.724 GB, free: 9.559 MB / 0.4948 GB
Notification: Performance of sort global known variables: time 6.012e-06/0.9572, allocations: 4 kB / 0.724 GB, free: 9.555 MB / 0.4948 GB
Notification: Performance of remove unused functions: time 0.005025/0.9622, allocations: 0.706 MB / 0.7247 GB, free: 8.848 MB / 0.4948 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 (63):
 * Single equations (assignments): 53
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 8
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 2 {1 15,1 9}
Notification: Performance of Backend phase and start with SimCode phase: time 0.002424/0.9647, allocations: 0.6059 MB / 0.7253 GB, free: 8.234 MB / 0.4948 GB
Notification: Performance of simCode: created initialization part: time 0.01024/0.975, allocations: 1.431 MB / 0.7267 GB, free: 6.805 MB / 0.4948 GB
Notification: Performance of simCode: created event and clocks part: time 1.16e-05/0.9751, allocations: 192 / 0.7267 GB, free: 6.805 MB / 0.4948 GB
Notification: Performance of simCode: created simulation system equations: time 0.005826/0.9809, allocations: 0.7303 MB / 0.7274 GB, free: 6.074 MB / 0.4948 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01449/0.9955, allocations: 1.275 MB / 0.7287 GB, free: 4.809 MB / 0.4948 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01644/1.012, allocations: 4.168 MB / 0.7327 GB, free: 0.5703 MB / 0.4948 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.002756/1.015, allocations: 1.533 MB / 0.7342 GB, free: 15.01 MB / 0.5105 GB
Notification: Performance of simCode: alias equations: time 0.005201/1.02, allocations: 440.5 kB / 0.7347 GB, free: 14.57 MB / 0.5105 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001187/1.021, allocations: 171.4 kB / 0.7348 GB, free: 14.41 MB / 0.5105 GB
Notification: Performance of SimCode: time 2.6e-06/1.021, allocations: 0 / 0.7348 GB, free: 14.41 MB / 0.5105 GB
Notification: Performance of Templates: time 0.1265/1.148, allocations: 48.05 MB / 0.7818 GB, free: 14.66 MB / 0.5573 GB