Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_master_IBPSA.Fluid.FixedResistances.Validation.PlugFlowPipes.PlugFlowULg.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.Validation.PlugFlowPipes.PlugFlowULg,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_master_IBPSA.Fluid.FixedResistances.Validation.PlugFlowPipes.PlugFlowULg")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.002389/0.002394, allocations: 357.2 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.544/1.544, allocations: 165.8 MB / 182.5 MB, free: 5.484 MB / 138.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 4/4, allocations: 410.8 MB / 0.5995 GB, free: 15.17 MB / 298.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.001746/0.001746, allocations: 205.2 kB / 0.6662 GB, free: 6.941 MB / 298.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004855/0.0004857, allocations: 20 kB / 0.7423 GB, free: 8.969 MB / 378.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3345/0.3351, allocations: 67.44 MB / 0.8082 GB, free: 28.81 MB / 378.7 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.FixedResistances.Validation.PlugFlowPipes.PlugFlowULg): time 0.06742/0.4025, allocations: 56.01 MB / 0.8628 GB, free: 4.652 MB / 410.7 MB
Notification: Performance of NFInst.instExpressions: time 0.03061/0.4332, allocations: 16.95 MB / 0.8794 GB, free: 3.66 MB / 426.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002566/0.4358, allocations: 55.62 kB / 0.8794 GB, free: 3.605 MB / 426.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.003076/0.4389, allocations: 0.6793 MB / 0.8801 GB, free: 2.922 MB / 426.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.009422/0.4483, allocations: 2.47 MB / 0.8825 GB, free: 452 kB / 426.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.006528/0.4549, allocations: 1.526 MB / 0.884 GB, free: 14.93 MB / 442.7 MB
Notification: Performance of NFFlatten.flatten: time 0.008463/0.4634, allocations: 4.873 MB / 0.8888 GB, free: 10.04 MB / 442.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.002595/0.466, allocations: 1.092 MB / 0.8898 GB, free: 8.926 MB / 442.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.004094/0.4701, allocations: 1.434 MB / 0.8912 GB, free: 7.484 MB / 442.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.00268/0.4729, allocations: 1.171 MB / 0.8924 GB, free: 6.309 MB / 442.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.000388/0.4733, allocations: 64 kB / 0.8924 GB, free: 6.246 MB / 442.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.003947/0.4772, allocations: 1.118 MB / 0.8935 GB, free: 5.125 MB / 442.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.000617/0.4779, allocations: 294.6 kB / 0.8938 GB, free: 4.836 MB / 442.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.0008317/0.4787, allocations: 372.8 kB / 0.8942 GB, free: 4.465 MB / 442.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.004267/0.483, allocations: 2.209 MB / 0.8963 GB, free: 2.25 MB / 442.7 MB
Notification: Performance of FrontEnd - DAE generated: time 5.266e-06/0.4831, allocations: 0 / 0.8963 GB, free: 2.25 MB / 442.7 MB
Notification: Performance of FrontEnd: time 2.347e-06/0.4831, allocations: 0 / 0.8963 GB, free: 2.25 MB / 442.7 MB
Notification: Performance of Transformations before backend: time 3.292e-05/0.4831, allocations: 0 / 0.8963 GB, free: 2.25 MB / 442.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 265
 * Number of variables: 265
Notification: Performance of Generate backend data structure: time 0.005348/0.4885, allocations: 1.931 MB / 0.8982 GB, free: 268 kB / 442.7 MB
Notification: Performance of prepare preOptimizeDAE: time 4.054e-05/0.4885, allocations: 8.031 kB / 0.8982 GB, free: 260 kB / 442.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002356/0.4909, allocations: 405.4 kB / 0.8986 GB, free: 15.86 MB / 458.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.004627/0.4956, allocations: 1.487 MB / 0.9001 GB, free: 14.32 MB / 458.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001129/0.4957, allocations: 82.08 kB / 0.9001 GB, free: 14.23 MB / 458.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002449/0.496, allocations: 103.9 kB / 0.9002 GB, free: 14.13 MB / 458.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003185/0.4992, allocations: 1.24 MB / 0.9015 GB, free: 12.79 MB / 458.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 4.56e-05/0.4993, allocations: 11.98 kB / 0.9015 GB, free: 12.78 MB / 458.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001589/0.4994, allocations: 47.94 kB / 0.9015 GB, free: 12.73 MB / 458.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.037e-05/0.4995, allocations: 28 kB / 0.9015 GB, free: 12.71 MB / 458.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003003/0.5025, allocations: 0.9524 MB / 0.9025 GB, free: 11.76 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.01171/0.5143, allocations: 6.988 MB / 0.9093 GB, free: 4.211 MB / 458.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.00273/0.517, allocations: 0.8252 MB / 0.9101 GB, free: 3.379 MB / 458.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001161/0.5182, allocations: 410 kB / 0.9105 GB, free: 2.98 MB / 458.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.002294/0.5205, allocations: 1.789 MB / 0.9122 GB, free: 0.8047 MB / 458.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001436/0.522, allocations: 480.1 kB / 0.9127 GB, free: 328 kB / 458.7 MB
Notification: Performance of pre-optimization done (n=73): time 4.733e-06/0.522, allocations: 0 / 0.9127 GB, free: 328 kB / 458.7 MB
Notification: Performance of matching and sorting (n=73): time 0.003944/0.526, allocations: 1.187 MB / 0.9139 GB, free: 15.13 MB / 474.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 8.059e-05/0.5261, allocations: 85.77 kB / 0.9139 GB, free: 15.03 MB / 474.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002726/0.5289, allocations: 1.281 MB / 0.9152 GB, free: 13.73 MB / 474.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0001701/0.5291, allocations: 41.7 kB / 0.9152 GB, free: 13.69 MB / 474.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.000871/0.5299, allocations: 0.7238 MB / 0.9159 GB, free: 12.95 MB / 474.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0004019/0.5304, allocations: 256.2 kB / 0.9162 GB, free: 12.7 MB / 474.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 8.142e-05/0.5305, allocations: 16 kB / 0.9162 GB, free: 12.68 MB / 474.7 MB
Notification: Performance of setup shared object (initialization): time 0.0002003/0.5307, allocations: 349.9 kB / 0.9165 GB, free: 12.34 MB / 474.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001096/0.5318, allocations: 341.7 kB / 0.9169 GB, free: 12 MB / 474.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001416/0.5332, allocations: 0.5833 MB / 0.9174 GB, free: 11.3 MB / 474.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001241/0.5345, allocations: 407 kB / 0.9178 GB, free: 10.91 MB / 474.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.027e-05/0.5345, allocations: 4 kB / 0.9178 GB, free: 10.91 MB / 474.7 MB
Notification: Performance of matching and sorting (n=109) (initialization): time 0.004698/0.5392, allocations: 1.116 MB / 0.9189 GB, free: 9.781 MB / 474.7 MB
Notification: Performance of prepare postOptimizeDAE: time 0.0002905/0.5396, allocations: 305.1 kB / 0.9192 GB, free: 9.379 MB / 474.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.464e-05/0.5396, allocations: 8 kB / 0.9192 GB, free: 9.371 MB / 474.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 3.66e-05/0.5397, allocations: 12 kB / 0.9192 GB, free: 9.359 MB / 474.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001207/0.5409, allocations: 223.7 kB / 0.9194 GB, free: 9.141 MB / 474.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.767e-05/0.5409, allocations: 15.94 kB / 0.9194 GB, free: 9.125 MB / 474.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001702/0.5426, allocations: 171 kB / 0.9196 GB, free: 8.957 MB / 474.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001735/0.5428, allocations: 47.98 kB / 0.9196 GB, free: 8.91 MB / 474.7 MB
Notification: Performance of prepare postOptimizeDAE: time 1.316e-05/0.5429, allocations: 4 kB / 0.9197 GB, free: 8.906 MB / 474.7 MB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.002909/0.5458, allocations: 0.9443 MB / 0.9206 GB, free: 7.961 MB / 474.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.753e-05/0.5458, allocations: 15.98 kB / 0.9206 GB, free: 7.945 MB / 474.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 2.214e-05/0.5459, allocations: 12 kB / 0.9206 GB, free: 7.934 MB / 474.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001181/0.5471, allocations: 224.3 kB / 0.9208 GB, free: 7.715 MB / 474.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.85e-05/0.5471, allocations: 15.94 kB / 0.9208 GB, free: 7.699 MB / 474.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001631/0.5488, allocations: 159.1 kB / 0.921 GB, free: 7.543 MB / 474.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001726/0.549, allocations: 43.98 kB / 0.921 GB, free: 7.5 MB / 474.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 32
 * Number of states: 0 ()
 * Number of discrete variables: 6 ($whenCondition1,$PRE.DataReader.nextTimeEvent,DataReader.nextTimeEvent,$PRE.DataReader.nextTimeEventScaled,DataReader.nextTimeEventScaled,eneLosInt.local_reset)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (107):
 * Single equations (assignments): 105
 * 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.0009736/0.55, allocations: 408.8 kB / 0.9214 GB, free: 7.09 MB / 474.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0004094/0.5504, allocations: 154.1 kB / 0.9216 GB, free: 6.938 MB / 474.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004091/0.5545, allocations: 1.402 MB / 0.9229 GB, free: 5.543 MB / 474.7 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 3.037e-05/0.5546, allocations: 19.98 kB / 0.9229 GB, free: 5.523 MB / 474.7 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.068e-05/0.5546, allocations: 3.953 kB / 0.923 GB, free: 5.52 MB / 474.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.003057/0.5576, allocations: 1.205 MB / 0.9241 GB, free: 4.25 MB / 474.7 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.006898/0.5646, allocations: 2.674 MB / 0.9267 GB, free: 1.5 MB / 474.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.333e-05/0.5647, allocations: 7.984 kB / 0.9267 GB, free: 1.492 MB / 474.7 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001108/0.5658, allocations: 159.9 kB / 0.9269 GB, free: 1.336 MB / 474.7 MB
Notification: Performance of postOpt tearingSystem (simulation): time 1.555e-05/0.5658, allocations: 4 kB / 0.9269 GB, free: 1.332 MB / 474.7 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001295/0.566, allocations: 31.97 kB / 0.9269 GB, free: 1.301 MB / 474.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.205e-05/0.566, allocations: 11.88 kB / 0.9269 GB, free: 1.289 MB / 474.7 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.08e-06/0.566, allocations: 0 / 0.9269 GB, free: 1.289 MB / 474.7 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.3199/0.8859, allocations: 1.809 MB / 0.9287 GB, free: 113.2 MB / 474.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.001004/0.887, allocations: 388 kB / 0.9291 GB, free: 113.1 MB / 474.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002556/0.8872, allocations: 17.92 kB / 0.9291 GB, free: 113.1 MB / 474.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001319/0.8886, allocations: 120.2 kB / 0.9292 GB, free: 113.1 MB / 474.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001859/0.8888, allocations: 68.55 kB / 0.9293 GB, free: 113.1 MB / 474.7 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001292/0.8889, allocations: 35.25 kB / 0.9293 GB, free: 113.1 MB / 474.7 MB
Notification: Performance of sorting global known variables: time 0.001873/0.8908, allocations: 0.868 MB / 0.9302 GB, free: 112.9 MB / 474.7 MB
Notification: Performance of sort global known variables: time 1.025e-06/0.8908, allocations: 0 / 0.9302 GB, free: 112.9 MB / 474.7 MB
Notification: Performance of remove unused functions: time 0.003649/0.8945, allocations: 0.8416 MB / 0.931 GB, free: 112.9 MB / 474.7 MB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 4
 * Number of states: 4 (pipe.cor.del.x,pipe.cor.timDel.x,pipe.vol.dynBal.U,eneLosInt.y)
 * Number of discrete variables: 3 ($whenCondition1,DataReader.nextTimeEvent,DataReader.nextTimeEventScaled)
 * Number of discrete states: 2 (DataReader.nextTimeEvent,DataReader.nextTimeEventScaled)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (91):
 * Single equations (assignments): 74
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 15
 * When equations: 2
 * 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.002811/0.8973, allocations: 0.915 MB / 0.9319 GB, free: 112.7 MB / 474.7 MB
Notification: Performance of simCode: created initialization part: time 0.00441/0.9018, allocations: 1.543 MB / 0.9334 GB, free: 112.2 MB / 474.7 MB
Notification: Performance of simCode: created event and clocks part: time 7.932e-06/0.9018, allocations: 6.656 kB / 0.9334 GB, free: 112.2 MB / 474.7 MB
Notification: Performance of simCode: created simulation system equations: time 0.001473/0.9033, allocations: 0.5845 MB / 0.934 GB, free: 111.9 MB / 474.7 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.004042/0.9074, allocations: 0.6318 MB / 0.9346 GB, free: 111.8 MB / 474.7 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.008946/0.9164, allocations: 3.577 MB / 0.9381 GB, free: 110 MB / 474.7 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001062/0.9175, allocations: 1.28 MB / 0.9393 GB, free: 109.3 MB / 474.7 MB
Notification: Performance of simCode: alias equations: time 0.002505/0.92, allocations: 402.8 kB / 0.9397 GB, free: 109.2 MB / 474.7 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0005467/0.9206, allocations: 147.8 kB / 0.9398 GB, free: 109.2 MB / 474.7 MB
Notification: Performance of SimCode: time 2.021e-06/0.9206, allocations: 0 / 0.9398 GB, free: 109.2 MB / 474.7 MB
Notification: Performance of Templates: time 0.06368/0.9843, allocations: 29.84 MB / 0.969 GB, free: 83.89 MB / 474.7 MB