Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ModelicaTest_3.2.1_ModelicaTest.Media.TestAllProperties.IncompleteMedia.Essotherm650.conf.json
Using package ModelicaTest with version 3.2.1 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.1+maint.om/package.mo)
Using package ModelicaServices with version 3.2.1 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.1+maint.om/package.mo)
Using package Modelica with version 3.2.1 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.1+maint.om/package.mo)
Using package Complex with version 3.2.1 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.1+maint.om/package.mo)
Running command: translateModel(ModelicaTest.Media.TestAllProperties.IncompleteMedia.Essotherm650,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|eps_h_is|eta|lambda|Pr|p|T|d|h|u|s|cp|cp2|cv|cv2|h2|d2|err_T|err_d|err_u|eps",fileNamePrefix="ModelicaTest_3.2.1_ModelicaTest.Media.TestAllProperties.IncompleteMedia.Essotherm650")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.1+maint.om/package.mo): time 0.003949/0.003948, allocations: 348.9 kB / 15.95 MB, free: 6.223 MB / 13.93 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.1+maint.om/package.mo): time 3.741/3.741, allocations: 341.5 MB / 358.2 MB, free: 12.56 MB / 298.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.1+maint.om/package.mo): time 0.003493/0.003493, allocations: 233.2 kB / 397.9 MB, free: 4.898 MB / 330.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.1+maint.om/package.mo): time 0.4738/0.4738, allocations: 76.09 MB / 0.5014 GB, free: 112.6 MB / 362.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0009111/0.0009113, allocations: 11.98 kB / 0.5592 GB, free: 53.44 MB / 362.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.09155/0.0925, allocations: 48.71 MB / 0.6067 GB, free: 4.633 MB / 362.7 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Media.TestAllProperties.IncompleteMedia.Essotherm650): time 0.2818/0.3744, allocations: 7.116 MB / 0.6137 GB, free: 88.45 MB / 362.7 MB
Notification: Performance of NFInst.instExpressions: time 0.003417/0.3778, allocations: 1.752 MB / 0.6154 GB, free: 88.29 MB / 362.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0001918/0.3781, allocations: 4.906 kB / 0.6154 GB, free: 88.29 MB / 362.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.0002662/0.3784, allocations: 30.97 kB / 0.6154 GB, free: 88.28 MB / 362.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.004914/0.3833, allocations: 1.056 MB / 0.6165 GB, free: 88.12 MB / 362.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.0006315/0.384, allocations: 140.5 kB / 0.6166 GB, free: 88.11 MB / 362.7 MB
Notification: Performance of NFFlatten.flatten: time 0.0007124/0.3847, allocations: 300.9 kB / 0.6169 GB, free: 88.04 MB / 362.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 7.484e-05/0.3848, allocations: 11.8 kB / 0.6169 GB, free: 88.04 MB / 362.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.002003/0.3868, allocations: 0.7415 MB / 0.6176 GB, free: 87.99 MB / 362.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.000531/0.3874, allocations: 148.7 kB / 0.6178 GB, free: 87.96 MB / 362.7 MB
Notification: Performance of NFPackage.collectConstants: time 4.853e-05/0.3874, allocations: 4.844 kB / 0.6178 GB, free: 87.96 MB / 362.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.004586/0.392, allocations: 1.411 MB / 0.6192 GB, free: 87.75 MB / 362.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.000111/0.3922, allocations: 37.59 kB / 0.6192 GB, free: 87.73 MB / 362.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.0001353/0.3924, allocations: 52.42 kB / 0.6192 GB, free: 87.7 MB / 362.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.001901/0.3943, allocations: 461.7 kB / 0.6197 GB, free: 87.62 MB / 362.7 MB
Notification: Performance of FrontEnd - DAE generated: time 7.264e-06/0.3943, allocations: 0.6562 kB / 0.6197 GB, free: 87.62 MB / 362.7 MB
Notification: Performance of FrontEnd: time 3.246e-06/0.3943, allocations: 1.188 kB / 0.6197 GB, free: 87.62 MB / 362.7 MB
Notification: Performance of Transformations before backend: time 1.557e-05/0.3943, allocations: 0 / 0.6197 GB, free: 87.62 MB / 362.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 41
 * Number of variables: 41
Notification: Performance of Generate backend data structure: time 0.001423/0.3958, allocations: 0.5659 MB / 0.6202 GB, free: 87.14 MB / 362.7 MB
Notification: Performance of prepare preOptimizeDAE: time 5.904e-05/0.3959, allocations: 9.656 kB / 0.6202 GB, free: 87.14 MB / 362.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0005174/0.3964, allocations: 43.77 kB / 0.6203 GB, free: 87.13 MB / 362.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0003263/0.3967, allocations: 212.4 kB / 0.6205 GB, free: 86.91 MB / 362.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 2.483e-05/0.3968, allocations: 13.66 kB / 0.6205 GB, free: 86.91 MB / 362.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 3.368e-05/0.3968, allocations: 13.78 kB / 0.6205 GB, free: 86.91 MB / 362.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0005693/0.3974, allocations: 242.7 kB / 0.6207 GB, free: 86.75 MB / 362.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 1.543e-05/0.3974, allocations: 1.219 kB / 0.6207 GB, free: 86.75 MB / 362.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 4.123e-05/0.3975, allocations: 6.469 kB / 0.6208 GB, free: 86.75 MB / 362.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.15e-05/0.3975, allocations: 3.906 kB / 0.6208 GB, free: 86.75 MB / 362.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0005218/0.398, allocations: 242.4 kB / 0.621 GB, free: 86.69 MB / 362.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.001641/0.3997, allocations: 1.37 MB / 0.6223 GB, free: 85.39 MB / 362.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.0002969/0.4, allocations: 90.25 kB / 0.6224 GB, free: 85.34 MB / 362.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0001061/0.4001, allocations: 45.36 kB / 0.6225 GB, free: 85.32 MB / 362.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.002653/0.4028, allocations: 2.656 MB / 0.6251 GB, free: 82.45 MB / 362.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0003398/0.4032, allocations: 164.8 kB / 0.6252 GB, free: 82.3 MB / 362.7 MB
Notification: Performance of pre-optimization done (n=18): time 3.597e-06/0.4032, allocations: 1.375 kB / 0.6252 GB, free: 82.3 MB / 362.7 MB
Notification: Performance of matching and sorting (n=19): time 0.001412/0.4046, allocations: 355.8 kB / 0.6255 GB, free: 82.12 MB / 362.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.088e-05/0.4047, allocations: 262.7 kB / 0.6258 GB, free: 81.81 MB / 362.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0001791/0.4049, allocations: 155.8 kB / 0.6259 GB, free: 81.69 MB / 362.7 MB
Notification: Performance of collectPreVariables (initialization): time 3.027e-05/0.405, allocations: 30.95 kB / 0.626 GB, free: 81.66 MB / 362.7 MB
Notification: Performance of collectInitialEqns (initialization): time 8.429e-05/0.4051, allocations: 143.6 kB / 0.6261 GB, free: 81.53 MB / 362.7 MB
Notification: Performance of collectInitialBindings (initialization): time 6.55e-05/0.4051, allocations: 66.98 kB / 0.6262 GB, free: 81.48 MB / 362.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 1.812e-05/0.4052, allocations: 6.281 kB / 0.6262 GB, free: 81.48 MB / 362.7 MB
Notification: Performance of setup shared object (initialization): time 7.931e-05/0.4053, allocations: 330.2 kB / 0.6265 GB, free: 81.15 MB / 362.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0001282/0.4054, allocations: 42.97 kB / 0.6265 GB, free: 81.14 MB / 362.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0002009/0.4056, allocations: 183.8 kB / 0.6267 GB, free: 80.95 MB / 362.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0001969/0.4058, allocations: 75.08 kB / 0.6268 GB, free: 80.92 MB / 362.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.29e-06/0.4058, allocations: 1.688 kB / 0.6268 GB, free: 80.92 MB / 362.7 MB
Notification: Performance of matching and sorting (n=35) (initialization): time 0.000669/0.4065, allocations: 262.2 kB / 0.627 GB, free: 80.81 MB / 362.7 MB
Notification: Performance of prepare postOptimizeDAE: time 2.546e-05/0.4066, allocations: 7.844 kB / 0.627 GB, free: 80.81 MB / 362.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.493e-05/0.4066, allocations: 13.88 kB / 0.6271 GB, free: 80.8 MB / 362.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 3.054e-05/0.4066, allocations: 7.281 kB / 0.6271 GB, free: 80.8 MB / 362.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0008528/0.4075, allocations: 103.5 kB / 0.6272 GB, free: 80.8 MB / 362.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0003183/0.4078, allocations: 0.5924 MB / 0.6277 GB, free: 80.2 MB / 362.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0002735/0.4081, allocations: 22.06 kB / 0.6278 GB, free: 80.19 MB / 362.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.823e-05/0.4082, allocations: 20.09 kB / 0.6278 GB, free: 80.19 MB / 362.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 22
 * Number of states: 0 ()
 * Number of discrete variables: 1 ($whenCondition1)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (35):
 * Single equations (assignments): 34
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 1
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details:
 * Constant Jacobian: 0
 * Linear Jacobian (size,density): 0
 * Non-linear Jacobian: 1 {1}
 * Without analytic Jacobian: 0
Notification: Performance of prepare postOptimizeDAE: time 0.0001806/0.4084, allocations: 139.5 kB / 0.6279 GB, free: 80.05 MB / 362.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 6.152e-05/0.4085, allocations: 15.17 kB / 0.6279 GB, free: 80.05 MB / 362.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0008055/0.4093, allocations: 237.8 kB / 0.6282 GB, free: 79.9 MB / 362.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 7.344e-06/0.4093, allocations: 1.766 kB / 0.6282 GB, free: 79.9 MB / 362.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.269e-06/0.4093, allocations: 2.109 kB / 0.6282 GB, free: 79.9 MB / 362.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.000147/0.4095, allocations: 123.9 kB / 0.6283 GB, free: 79.78 MB / 362.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 5.172e-05/0.4095, allocations: 1.25 kB / 0.6283 GB, free: 79.78 MB / 362.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0002448/0.4098, allocations: 13.42 kB / 0.6283 GB, free: 79.77 MB / 362.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 4.11e-05/0.4098, allocations: 8.281 kB / 0.6283 GB, free: 79.77 MB / 362.7 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.000525/0.4104, allocations: 358.5 kB / 0.6286 GB, free: 79.48 MB / 362.7 MB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.0004401/0.4108, allocations: 470.2 kB / 0.6291 GB, free: 79.07 MB / 362.7 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 8.038e-05/0.4109, allocations: 26.48 kB / 0.6291 GB, free: 79.07 MB / 362.7 MB
Notification: Performance of sorting global known variables: time 0.0001354/0.4111, allocations: 125.3 kB / 0.6292 GB, free: 78.98 MB / 362.7 MB
Notification: Performance of Backend: time 4.91e-07/0.4111, allocations: 0 / 0.6292 GB, free: 78.98 MB / 362.7 MB
Notification: Performance of simCode: created initialization part: time 0.002968/0.4141, allocations: 0.5539 MB / 0.6298 GB, free: 78.81 MB / 362.7 MB
Notification: Performance of SimCode: time 0.001046/0.4152, allocations: 0.8613 MB / 0.6306 GB, free: 78.08 MB / 362.7 MB
Notification: Performance of Templates: time 0.01992/0.4351, allocations: 6.893 MB / 0.6373 GB, free: 76.36 MB / 362.7 MB