Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_master_IBPSA.Fluid.FixedResistances.Examples.PlugFlowPipe.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.FixedResistances.Examples.PlugFlowPipe,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_master_IBPSA.Fluid.FixedResistances.Examples.PlugFlowPipe")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.004129/0.004128, allocations: 356.9 kB / 15.94 MB, free: 6.207 MB / 13.93 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/package.mo): time 1.32/1.32, allocations: 165.8 MB / 182.5 MB, free: 5.922 MB / 90.72 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 4.569/4.569, allocations: 410.8 MB / 0.5995 GB, free: 2.125 MB / 410.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.001859/0.001858, allocations: 175.3 kB / 0.6662 GB, free: 13.98 MB / 490.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004576/0.0004578, allocations: 12 kB / 0.7423 GB, free: 15.98 MB / 0.5573 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4333/0.4338, allocations: 67.44 MB / 0.8081 GB, free: 245.4 MB / 0.5886 GB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.FixedResistances.Examples.PlugFlowPipe): time 0.0464/0.4802, allocations: 41.16 MB / 0.8483 GB, free: 215.4 MB / 0.5886 GB
Notification: Performance of NFInst.instExpressions: time 0.01724/0.4975, allocations: 12.07 MB / 0.8601 GB, free: 204.3 MB / 0.5886 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001881/0.4994, allocations: 37.41 kB / 0.8602 GB, free: 204.3 MB / 0.5886 GB
Notification: Performance of NFTyping.typeComponents: time 0.001633/0.5011, allocations: 469 kB / 0.8606 GB, free: 203.8 MB / 0.5886 GB
Notification: Performance of NFTyping.typeBindings: time 0.00663/0.5078, allocations: 1.905 MB / 0.8625 GB, free: 201.9 MB / 0.5886 GB
Notification: Performance of NFTyping.typeClassSections: time 0.004442/0.5122, allocations: 1.208 MB / 0.8636 GB, free: 200.7 MB / 0.5886 GB
Notification: Performance of NFFlatten.flatten: time 0.00454/0.5168, allocations: 3.676 MB / 0.8672 GB, free: 197.1 MB / 0.5886 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001346/0.5182, allocations: 0.7478 MB / 0.868 GB, free: 196.3 MB / 0.5886 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.00227/0.5205, allocations: 1.042 MB / 0.869 GB, free: 195.3 MB / 0.5886 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001376/0.5219, allocations: 0.8461 MB / 0.8698 GB, free: 194.4 MB / 0.5886 GB
Notification: Performance of NFPackage.collectConstants: time 0.0001959/0.5221, allocations: 48 kB / 0.8698 GB, free: 194.4 MB / 0.5886 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.002819/0.5249, allocations: 0.9586 MB / 0.8708 GB, free: 193.4 MB / 0.5886 GB
Notification: Performance of NFScalarize.scalarize: time 0.000322/0.5253, allocations: 203 kB / 0.871 GB, free: 193.2 MB / 0.5886 GB
Notification: Performance of NFVerifyModel.verify: time 0.0004653/0.5258, allocations: 279.3 kB / 0.8712 GB, free: 192.9 MB / 0.5886 GB
Notification: Performance of NFConvertDAE.convert: time 0.002448/0.5282, allocations: 1.699 MB / 0.8729 GB, free: 191.2 MB / 0.5886 GB
Notification: Performance of FrontEnd - DAE generated: time 7.332e-06/0.5283, allocations: 0 / 0.8729 GB, free: 191.2 MB / 0.5886 GB
Notification: Performance of FrontEnd: time 3.003e-06/0.5283, allocations: 3.938 kB / 0.8729 GB, free: 191.2 MB / 0.5886 GB
Notification: Performance of Transformations before backend: time 2.713e-05/0.5283, allocations: 0 / 0.8729 GB, free: 191.2 MB / 0.5886 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 170
 * Number of variables: 170
Notification: Performance of Generate backend data structure: time 0.003139/0.5315, allocations: 1.433 MB / 0.8743 GB, free: 189.7 MB / 0.5886 GB
Notification: Performance of prepare preOptimizeDAE: time 4.107e-05/0.5315, allocations: 12.03 kB / 0.8743 GB, free: 189.7 MB / 0.5886 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0004273/0.532, allocations: 138.5 kB / 0.8744 GB, free: 189.6 MB / 0.5886 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002909/0.5349, allocations: 1.162 MB / 0.8756 GB, free: 188.4 MB / 0.5886 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 4.768e-05/0.535, allocations: 50 kB / 0.8756 GB, free: 188.3 MB / 0.5886 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001331/0.5351, allocations: 72 kB / 0.8757 GB, free: 188.3 MB / 0.5886 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001556/0.5367, allocations: 0.7676 MB / 0.8764 GB, free: 187.5 MB / 0.5886 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.056e-05/0.5368, allocations: 0 / 0.8764 GB, free: 187.5 MB / 0.5886 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 8.641e-05/0.5369, allocations: 30.25 kB / 0.8765 GB, free: 187.5 MB / 0.5886 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.116e-05/0.5369, allocations: 16 kB / 0.8765 GB, free: 187.4 MB / 0.5886 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001387/0.5383, allocations: 0.5712 MB / 0.8771 GB, free: 186.9 MB / 0.5886 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.005775/0.5441, allocations: 4.007 MB / 0.881 GB, free: 182.6 MB / 0.5886 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.001192/0.5453, allocations: 477.7 kB / 0.8814 GB, free: 182.1 MB / 0.5886 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0004735/0.5458, allocations: 217.1 kB / 0.8816 GB, free: 181.9 MB / 0.5886 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001098/0.5469, allocations: 1.519 MB / 0.8831 GB, free: 180 MB / 0.5886 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.295e-05/0.547, allocations: 42.56 kB / 0.8832 GB, free: 180 MB / 0.5886 GB
Notification: Performance of pre-optimization done (n=46): time 3.691e-06/0.547, allocations: 0 / 0.8832 GB, free: 180 MB / 0.5886 GB
Notification: Performance of matching and sorting (n=46): time 0.001815/0.5488, allocations: 0.6764 MB / 0.8838 GB, free: 179.3 MB / 0.5886 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.139e-05/0.5489, allocations: 63.36 kB / 0.8839 GB, free: 179.2 MB / 0.5886 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001647/0.5506, allocations: 0.9981 MB / 0.8848 GB, free: 178.2 MB / 0.5886 GB
Notification: Performance of collectPreVariables (initialization): time 7.482e-05/0.5506, allocations: 33.7 kB / 0.8849 GB, free: 178.2 MB / 0.5886 GB
Notification: Performance of collectInitialEqns (initialization): time 0.00037/0.551, allocations: 480.6 kB / 0.8853 GB, free: 177.7 MB / 0.5886 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001526/0.5512, allocations: 169.6 kB / 0.8855 GB, free: 177.5 MB / 0.5886 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 3.689e-05/0.5512, allocations: 12 kB / 0.8855 GB, free: 177.5 MB / 0.5886 GB
Notification: Performance of setup shared object (initialization): time 6.561e-05/0.5513, allocations: 329.9 kB / 0.8858 GB, free: 177.2 MB / 0.5886 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0004665/0.5518, allocations: 189 kB / 0.886 GB, free: 177 MB / 0.5886 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0005252/0.5523, allocations: 328.4 kB / 0.8863 GB, free: 176.6 MB / 0.5886 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0005499/0.5529, allocations: 232.7 kB / 0.8865 GB, free: 176.4 MB / 0.5886 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.079e-06/0.5529, allocations: 8 kB / 0.8865 GB, free: 176.4 MB / 0.5886 GB
Notification: Performance of matching and sorting (n=68) (initialization): time 0.001591/0.5545, allocations: 0.651 MB / 0.8872 GB, free: 175.7 MB / 0.5886 GB
Notification: Performance of prepare postOptimizeDAE: time 8.44e-05/0.5546, allocations: 187.3 kB / 0.8874 GB, free: 175.5 MB / 0.5886 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.655e-05/0.5547, allocations: 8 kB / 0.8874 GB, free: 175.5 MB / 0.5886 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.261e-05/0.5547, allocations: 8 kB / 0.8874 GB, free: 175.5 MB / 0.5886 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0005846/0.5553, allocations: 123.8 kB / 0.8875 GB, free: 175.4 MB / 0.5886 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.516e-05/0.5553, allocations: 11.95 kB / 0.8875 GB, free: 175.4 MB / 0.5886 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001024/0.5564, allocations: 99.23 kB / 0.8876 GB, free: 175.3 MB / 0.5886 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.575e-05/0.5565, allocations: 35.17 kB / 0.8876 GB, free: 175.2 MB / 0.5886 GB
Notification: Performance of prepare postOptimizeDAE: time 1.085e-05/0.5565, allocations: 4 kB / 0.8876 GB, free: 175.2 MB / 0.5886 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.001277/0.5578, allocations: 0.5292 MB / 0.8882 GB, free: 174.7 MB / 0.5886 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.318e-05/0.5578, allocations: 10.3 kB / 0.8882 GB, free: 174.7 MB / 0.5886 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.189e-05/0.5579, allocations: 8 kB / 0.8882 GB, free: 174.7 MB / 0.5886 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0005727/0.5585, allocations: 132.2 kB / 0.8883 GB, free: 174.6 MB / 0.5886 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.094e-05/0.5585, allocations: 4 kB / 0.8883 GB, free: 174.5 MB / 0.5886 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0009278/0.5594, allocations: 95.27 kB / 0.8884 GB, free: 174.5 MB / 0.5886 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 7.581e-05/0.5595, allocations: 27.98 kB / 0.8884 GB, free: 174.4 MB / 0.5886 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 15
 * 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 (66):
 * Single equations (assignments): 64
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 2
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.0005236/0.56, allocations: 343 kB / 0.8887 GB, free: 174.1 MB / 0.5886 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002038/0.5603, allocations: 106.7 kB / 0.8888 GB, free: 174 MB / 0.5886 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002063/0.5623, allocations: 0.9778 MB / 0.8898 GB, free: 173 MB / 0.5886 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.251e-05/0.5624, allocations: 15.98 kB / 0.8898 GB, free: 173 MB / 0.5886 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.644e-06/0.5624, allocations: 0 / 0.8898 GB, free: 173 MB / 0.5886 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001221/0.5636, allocations: 0.8453 MB / 0.8906 GB, free: 172.1 MB / 0.5886 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.003851/0.5675, allocations: 2.023 MB / 0.8926 GB, free: 170 MB / 0.5886 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.566e-05/0.5676, allocations: 4 kB / 0.8926 GB, free: 170 MB / 0.5886 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0005602/0.5682, allocations: 101.5 kB / 0.8927 GB, free: 169.9 MB / 0.5886 GB
Notification: Performance of postOpt tearingSystem (simulation): time 1.428e-05/0.5682, allocations: 11.41 kB / 0.8927 GB, free: 169.9 MB / 0.5886 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 6.255e-05/0.5683, allocations: 16 kB / 0.8927 GB, free: 169.8 MB / 0.5886 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 8.888e-06/0.5683, allocations: 4 kB / 0.8928 GB, free: 169.8 MB / 0.5886 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.347e-06/0.5683, allocations: 7.938 kB / 0.8928 GB, free: 169.8 MB / 0.5886 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.002276/0.5706, allocations: 1.214 MB / 0.8939 GB, free: 168.6 MB / 0.5886 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.000635/0.5713, allocations: 311.3 kB / 0.8942 GB, free: 168.3 MB / 0.5886 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001876/0.5715, allocations: 15.98 kB / 0.8943 GB, free: 168.2 MB / 0.5886 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0008127/0.5723, allocations: 47.91 kB / 0.8943 GB, free: 168.2 MB / 0.5886 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001355/0.5724, allocations: 56.38 kB / 0.8944 GB, free: 168.1 MB / 0.5886 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 7.997e-05/0.5725, allocations: 31.48 kB / 0.8944 GB, free: 168.1 MB / 0.5886 GB
Notification: Performance of sorting global known variables: time 0.001301/0.5738, allocations: 0.7109 MB / 0.8951 GB, free: 167.4 MB / 0.5886 GB
Notification: Performance of sort global known variables: time 8.57e-07/0.5739, allocations: 0 / 0.8951 GB, free: 167.4 MB / 0.5886 GB
Notification: Performance of remove unused functions: time 0.003762/0.5776, allocations: 0.6084 MB / 0.8957 GB, free: 166.8 MB / 0.5886 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 8
 * Number of states: 5 (pip.cor.del.x,pip.cor.timDel.x,pip.vol.dynBal.U,senTemOut.T,senTemIn.T)
 * 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): 48
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 14
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.00196/0.5796, allocations: 496.2 kB / 0.8961 GB, free: 166.3 MB / 0.5886 GB
Notification: Performance of simCode: created initialization part: time 0.003765/0.5834, allocations: 0.9313 MB / 0.8971 GB, free: 165.4 MB / 0.5886 GB
Notification: Performance of simCode: created event and clocks part: time 1.066e-05/0.5835, allocations: 6.594 kB / 0.8971 GB, free: 165.4 MB / 0.5886 GB
Notification: Performance of simCode: created simulation system equations: time 0.001456/0.585, allocations: 406.4 kB / 0.8975 GB, free: 164.9 MB / 0.5886 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.006773/0.5918, allocations: 0.5805 MB / 0.898 GB, free: 164.4 MB / 0.5886 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.007042/0.5989, allocations: 2.474 MB / 0.9004 GB, free: 161.9 MB / 0.5886 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001043/0.6, allocations: 1.077 MB / 0.9015 GB, free: 160.8 MB / 0.5886 GB
Notification: Performance of simCode: alias equations: time 0.002713/0.6027, allocations: 298.5 kB / 0.9018 GB, free: 160.5 MB / 0.5886 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0005504/0.6033, allocations: 107.3 kB / 0.9019 GB, free: 160.4 MB / 0.5886 GB
Notification: Performance of SimCode: time 2.298e-06/0.6033, allocations: 0 / 0.9019 GB, free: 160.4 MB / 0.5886 GB
Notification: Performance of Templates: time 0.07805/0.6814, allocations: 24.74 MB / 0.926 GB, free: 136.3 MB / 0.5886 GB