Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_latest_IBPSA.Fluid.Examples.Performance.Example3.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/IBPSA 4.0.0-master/package.mo", uses=false) Using package IBPSA with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-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(IBPSA.Fluid.Examples.Performance.Example3,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Fluid.Examples.Performance.Example3") translateModel(IBPSA.Fluid.Examples.Performance.Example3,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Fluid.Examples.Performance.Example3") Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001532/0.001532, allocations: 105.1 kB / 16.4 MB, free: 6.465 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.001625/0.001625, allocations: 193.2 kB / 17.34 MB, free: 5.715 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 MB, free: 15.14 MB / 206.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo): time 0.7292/0.7292, allocations: 122.9 MB / 414.1 MB, free: 15.75 MB / 334.1 MB Notification: Performance of FrontEnd - loaded program: time 0.001174/0.001174, allocations: 65.88 kB / 0.5685 GB, free: 28.64 MB / 446.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.147/0.1482, allocations: 77.94 MB / 0.6446 GB, free: 8.98 MB / 494.1 MB Notification: Performance of NFInst.instantiate(IBPSA.Fluid.Examples.Performance.Example3): time 0.03009/0.1783, allocations: 33.15 MB / 0.677 GB, free: 7.711 MB / 0.5137 GB Notification: Performance of NFInst.instExpressions: time 0.01691/0.1952, allocations: 12.32 MB / 0.689 GB, free: 11.36 MB / 0.5294 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.002001/0.1973, allocations: 55.69 kB / 0.689 GB, free: 11.3 MB / 0.5294 GB Notification: Performance of NFTyping.typeComponents: time 0.004355/0.2016, allocations: 1.539 MB / 0.6905 GB, free: 9.758 MB / 0.5294 GB Notification: Performance of NFTyping.typeBindings: time 0.00471/0.2064, allocations: 1.734 MB / 0.6922 GB, free: 8.016 MB / 0.5294 GB Notification: Performance of NFTyping.typeClassSections: time 0.004153/0.2105, allocations: 1.504 MB / 0.6937 GB, free: 6.52 MB / 0.5294 GB Notification: Performance of NFFlatten.flatten: time 0.01025/0.2208, allocations: 7.786 MB / 0.7013 GB, free: 14.71 MB / 0.545 GB Notification: Performance of NFFlatten.resolveConnections: time 0.002985/0.2238, allocations: 2.117 MB / 0.7034 GB, free: 12.56 MB / 0.545 GB Notification: Performance of NFEvalConstants.evaluate: time 0.003882/0.2277, allocations: 1.908 MB / 0.7052 GB, free: 10.65 MB / 0.545 GB Notification: Performance of NFSimplifyModel.simplify: time 0.002365/0.2301, allocations: 1.432 MB / 0.7066 GB, free: 9.215 MB / 0.545 GB Notification: Performance of NFPackage.collectConstants: time 0.0005488/0.2306, allocations: 152 kB / 0.7068 GB, free: 9.066 MB / 0.545 GB Notification: Performance of NFFlatten.collectFunctions: time 0.003166/0.2338, allocations: 1.353 MB / 0.7081 GB, free: 7.711 MB / 0.545 GB Notification: Performance of NFScalarize.scalarize: time 0.0006504/0.2345, allocations: 0.5994 MB / 0.7087 GB, free: 7.109 MB / 0.545 GB Notification: Performance of NFVerifyModel.verify: time 0.001442/0.2359, allocations: 1.193 MB / 0.7098 GB, free: 5.91 MB / 0.545 GB Notification: Performance of NFConvertDAE.convert: time 0.004558/0.2405, allocations: 3.553 MB / 0.7133 GB, free: 2.344 MB / 0.545 GB Notification: Performance of FrontEnd - DAE generated: time 4.157e-06/0.2405, allocations: 3.938 kB / 0.7133 GB, free: 2.34 MB / 0.545 GB Notification: Performance of FrontEnd: time 1.633e-06/0.2405, allocations: 0 / 0.7133 GB, free: 2.34 MB / 0.545 GB Notification: Performance of Transformations before backend: time 5.037e-05/0.2406, allocations: 3.938 kB / 0.7133 GB, free: 2.336 MB / 0.545 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 239 * Number of variables: 239 Notification: Performance of Generate backend data structure: time 0.004463/0.245, allocations: 2.898 MB / 0.7162 GB, free: 15.36 MB / 0.5606 GB Notification: Performance of prepare preOptimizeDAE: time 4.193e-05/0.2451, allocations: 12.62 kB / 0.7162 GB, free: 15.34 MB / 0.5606 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001828/0.2469, allocations: 446.1 kB / 0.7166 GB, free: 14.91 MB / 0.5606 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.004326/0.2513, allocations: 2.777 MB / 0.7193 GB, free: 12.06 MB / 0.5606 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 6.924e-05/0.2514, allocations: 78 kB / 0.7194 GB, free: 11.98 MB / 0.5606 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001529/0.2515, allocations: 104 kB / 0.7195 GB, free: 11.88 MB / 0.5606 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.002147/0.2537, allocations: 1.327 MB / 0.7208 GB, free: 10.48 MB / 0.5606 GB Notification: Performance of preOpt findStateOrder (simulation): time 3.059e-05/0.2537, allocations: 3.938 kB / 0.7208 GB, free: 10.47 MB / 0.5606 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 9.976e-05/0.2538, allocations: 44 kB / 0.7208 GB, free: 10.43 MB / 0.5606 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 2.111e-05/0.2539, allocations: 24 kB / 0.7208 GB, free: 10.41 MB / 0.5606 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002014/0.2559, allocations: 1.022 MB / 0.7218 GB, free: 9.383 MB / 0.5606 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.008282/0.2642, allocations: 6.903 MB / 0.7286 GB, free: 2.051 MB / 0.5606 GB Notification: Performance of preOpt comSubExp (simulation): time 0.001372/0.2656, allocations: 0.5964 MB / 0.7292 GB, free: 1.449 MB / 0.5606 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.0007297/0.2663, allocations: 403.2 kB / 0.7296 GB, free: 1.055 MB / 0.5606 GB Notification: Performance of preOpt evalFunc (simulation): time 0.002841/0.2692, allocations: 1.782 MB / 0.7313 GB, free: 15.14 MB / 0.5762 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0008004/0.27, allocations: 370.9 kB / 0.7316 GB, free: 14.76 MB / 0.5762 GB Notification: Performance of preOpt simplifyInStream (simulation): time 0.0007101/0.2707, allocations: 91.38 kB / 0.7317 GB, free: 14.67 MB / 0.5762 GB Notification: Performance of pre-optimization done (n=44): time 5.41e-06/0.2707, allocations: 4 kB / 0.7317 GB, free: 14.67 MB / 0.5762 GB Notification: Performance of matching and sorting (n=44): time 0.003606/0.2743, allocations: 1.38 MB / 0.7331 GB, free: 13.26 MB / 0.5762 GB Notification: Performance of inlineWhenForInitialization (initialization): time 4.73e-05/0.2744, allocations: 55.41 kB / 0.7331 GB, free: 13.19 MB / 0.5762 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003221/0.2776, allocations: 2.384 MB / 0.7355 GB, free: 10.79 MB / 0.5762 GB Notification: Performance of collectPreVariables (initialization): time 8.848e-05/0.2777, allocations: 45.7 kB / 0.7355 GB, free: 10.74 MB / 0.5762 GB Notification: Performance of collectInitialEqns (initialization): time 0.0009353/0.2787, allocations: 0.9974 MB / 0.7365 GB, free: 9.73 MB / 0.5762 GB Notification: Performance of collectInitialBindings (initialization): time 0.0001569/0.2788, allocations: 166.7 kB / 0.7366 GB, free: 9.566 MB / 0.5762 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0003967/0.2792, allocations: 302.7 kB / 0.7369 GB, free: 9.266 MB / 0.5762 GB Notification: Performance of setup shared object (initialization): time 0.0002062/0.2794, allocations: 361.9 kB / 0.7373 GB, free: 8.906 MB / 0.5762 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.0009126/0.2804, allocations: 0.494 MB / 0.7378 GB, free: 8.406 MB / 0.5762 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.00134/0.2817, allocations: 0.9873 MB / 0.7387 GB, free: 7.203 MB / 0.5762 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.002107/0.2838, allocations: 1.339 MB / 0.74 GB, free: 5.707 MB / 0.5762 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.049e-05/0.2839, allocations: 4 kB / 0.74 GB, free: 5.703 MB / 0.5762 GB Notification: Performance of matching and sorting (n=164) (initialization): time 0.003762/0.2876, allocations: 1.812 MB / 0.7418 GB, free: 3.875 MB / 0.5762 GB Notification: Performance of prepare postOptimizeDAE: time 6.223e-05/0.2877, allocations: 37.64 kB / 0.7418 GB, free: 3.832 MB / 0.5762 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.403e-05/0.2877, allocations: 16.8 kB / 0.7419 GB, free: 3.816 MB / 0.5762 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.0007031/0.2884, allocations: 184.7 kB / 0.742 GB, free: 3.633 MB / 0.5762 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0007925/0.2892, allocations: 227.6 kB / 0.7422 GB, free: 3.41 MB / 0.5762 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0006626/0.2899, allocations: 0.763 MB / 0.743 GB, free: 2.621 MB / 0.5762 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0014/0.2913, allocations: 83.81 kB / 0.7431 GB, free: 2.539 MB / 0.5762 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001203/0.2915, allocations: 55.98 kB / 0.7431 GB, free: 2.484 MB / 0.5762 GB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001932/0.2934, allocations: 1.029 MB / 0.7441 GB, free: 1.449 MB / 0.5762 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001142/0.2946, allocations: 0.9694 MB / 0.7451 GB, free: 272 kB / 0.5762 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.3368/0.6313, allocations: 1.286 MB / 0.7463 GB, free: 94.45 MB / 0.5762 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.045e-05/0.6314, allocations: 3.125 kB / 0.7463 GB, free: 94.45 MB / 0.5762 GB Notification: Performance of matching and sorting (n=164) (initialization_lambda0): time 0.003241/0.6346, allocations: 1.806 MB / 0.7481 GB, free: 94.2 MB / 0.5762 GB Notification: Performance of prepare postOptimizeDAE: time 3.459e-05/0.6347, allocations: 40.44 kB / 0.7481 GB, free: 94.17 MB / 0.5762 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.481e-05/0.6347, allocations: 14.5 kB / 0.7482 GB, free: 94.17 MB / 0.5762 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.0002531/0.635, allocations: 126.7 kB / 0.7483 GB, free: 94.16 MB / 0.5762 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0007825/0.6358, allocations: 219.1 kB / 0.7485 GB, free: 94.14 MB / 0.5762 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.00205/0.6378, allocations: 2.325 MB / 0.7508 GB, free: 92.39 MB / 0.5762 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00132/0.6392, allocations: 80.69 kB / 0.7508 GB, free: 92.37 MB / 0.5762 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001028/0.6393, allocations: 56.81 kB / 0.7509 GB, free: 92.36 MB / 0.5762 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 50 * Number of states: 0 () * Number of discrete variables: 8 (pulse.count,$PRE.pulse.count,pulse.T_start,$PRE.pulse.T_start,$whenCondition1,nRes.y,from_dp.y,mergeDp.y) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (118): * Single equations (assignments): 114 * Array equations: 1 * Algorithm blocks: 1 * Record equations: 1 * 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,12)} Notification: Performance of prepare postOptimizeDAE: time 0.0002617/0.6395, allocations: 250 kB / 0.7511 GB, free: 92.14 MB / 0.5762 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002954/0.6398, allocations: 228.1 kB / 0.7513 GB, free: 92.13 MB / 0.5762 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.00254/0.6424, allocations: 1.035 MB / 0.7524 GB, free: 91.79 MB / 0.5762 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.268e-05/0.6424, allocations: 5.453 kB / 0.7524 GB, free: 91.79 MB / 0.5762 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 2.785e-06/0.6424, allocations: 5.125 kB / 0.7524 GB, free: 91.78 MB / 0.5762 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001648/0.6441, allocations: 0.9655 MB / 0.7533 GB, free: 91.21 MB / 0.5762 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.004143/0.6482, allocations: 2.309 MB / 0.7556 GB, free: 90.2 MB / 0.5762 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.039e-06/0.6482, allocations: 1.188 kB / 0.7556 GB, free: 90.2 MB / 0.5762 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0004738/0.6487, allocations: 89.92 kB / 0.7556 GB, free: 90.19 MB / 0.5762 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.0002903/0.649, allocations: 119.2 kB / 0.7558 GB, free: 90.16 MB / 0.5762 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 5.074e-05/0.6491, allocations: 23.12 kB / 0.7558 GB, free: 90.14 MB / 0.5762 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0004994/0.6496, allocations: 0.7379 MB / 0.7565 GB, free: 89.56 MB / 0.5762 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.435e-06/0.6496, allocations: 1 kB / 0.7565 GB, free: 89.56 MB / 0.5762 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.002753/0.6524, allocations: 1.413 MB / 0.7579 GB, free: 88.93 MB / 0.5762 GB Notification: Performance of postOpt removeConstants (simulation): time 0.0006621/0.653, allocations: 372.9 kB / 0.7582 GB, free: 88.67 MB / 0.5762 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002171/0.6533, allocations: 12.58 kB / 0.7583 GB, free: 88.66 MB / 0.5762 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0007452/0.654, allocations: 43.41 kB / 0.7583 GB, free: 88.66 MB / 0.5762 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001092/0.6541, allocations: 44.91 kB / 0.7583 GB, free: 88.64 MB / 0.5762 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 5.84e-05/0.6542, allocations: 25.64 kB / 0.7584 GB, free: 88.64 MB / 0.5762 GB Notification: Performance of sorting global known variables: time 0.0026/0.6568, allocations: 1.627 MB / 0.7599 GB, free: 88.06 MB / 0.5762 GB Notification: Performance of sort global known variables: time 9.72e-07/0.6568, allocations: 0 / 0.7599 GB, free: 88.06 MB / 0.5762 GB Notification: Performance of remove unused functions: time 0.002654/0.6595, allocations: 0.9621 MB / 0.7609 GB, free: 87.96 MB / 0.5762 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 3 * Number of states: 1 (pump.vol.dynBal.U) * Number of discrete variables: 3 ($whenCondition1,pulse.T_start,pulse.count) * Number of discrete states: 1 (pulse.count) * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for simulation (38): * Single equations (assignments): 32 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 3 * When equations: 2 * 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,12)} Notification: Performance of Backend phase and start with SimCode phase: time 0.001339/0.6608, allocations: 0.5169 MB / 0.7614 GB, free: 87.84 MB / 0.5762 GB Notification: Performance of simCode: created initialization part: time 0.003483/0.6643, allocations: 2.013 MB / 0.7634 GB, free: 87 MB / 0.5762 GB Notification: Performance of simCode: created event and clocks part: time 4.559e-06/0.6643, allocations: 4.125 kB / 0.7634 GB, free: 87 MB / 0.5762 GB Notification: Performance of simCode: created simulation system equations: time 0.0007769/0.6651, allocations: 344.1 kB / 0.7637 GB, free: 86.9 MB / 0.5762 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003787/0.6689, allocations: 0.9753 MB / 0.7646 GB, free: 86.64 MB / 0.5762 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.006253/0.6752, allocations: 3.716 MB / 0.7683 GB, free: 85.01 MB / 0.5762 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0009892/0.6762, allocations: 1.671 MB / 0.7699 GB, free: 84.14 MB / 0.5762 GB Notification: Performance of simCode: alias equations: time 0.001898/0.6781, allocations: 0.5443 MB / 0.7704 GB, free: 84.04 MB / 0.5762 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0003527/0.6785, allocations: 165.2 kB / 0.7706 GB, free: 84.02 MB / 0.5762 GB Notification: Performance of SimCode: time 7.41e-07/0.6785, allocations: 0 / 0.7706 GB, free: 84.02 MB / 0.5762 GB Notification: Performance of Templates: time 0.05025/0.7287, allocations: 39.68 MB / 0.8093 GB, free: 49.28 MB / 0.5762 GB make -j1 -f IBPSA_latest_IBPSA.Fluid.Examples.Performance.Example3.makefile (rm -f IBPSA_latest_IBPSA.Fluid.Examples.Performance.Example3.pipe ; mkfifo IBPSA_latest_IBPSA.Fluid.Examples.Performance.Example3.pipe ; head -c 1048576 < IBPSA_latest_IBPSA.Fluid.Examples.Performance.Example3.pipe >> ../files/IBPSA_latest_IBPSA.Fluid.Examples.Performance.Example3.sim & ./IBPSA_latest_IBPSA.Fluid.Examples.Performance.Example3 -abortSlowSimulation -alarm=480 -lv LOG_STATS > IBPSA_latest_IBPSA.Fluid.Examples.Performance.Example3.pipe 2>&1)