Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ModelicaTest_3.2.1_ModelicaTest.Media.TestAllProperties.IncompleteMedia.ReferenceMoistAir.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.ReferenceMoistAir,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|eps_h_is|eps|eta|lambda|Pr|p|T|d|h|u|s|g|f|cp|cp2|cv|cv2|h_is|a|MM|h2|d2|err_T|err_d|err_u|s_is|err_h_is",fileNamePrefix="ModelicaTest_3.2.1_ModelicaTest.Media.TestAllProperties.IncompleteMedia.ReferenceMoistAir")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.1+maint.om/package.mo): time 0.002568/0.002568, allocations: 351.5 kB / 15.95 MB, free: 6.219 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.286/3.286, allocations: 341.5 MB / 358.2 MB, free: 28.76 MB / 170.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.1+maint.om/package.mo): time 0.00355/0.00355, allocations: 221.6 kB / 397.9 MB, free: 6.164 MB / 186.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.1+maint.om/package.mo): time 0.553/0.553, allocations: 76.09 MB / 0.5014 GB, free: 0.8203 MB / 250.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0006286/0.0006288, allocations: 8 kB / 0.5592 GB, free: 60.26 MB / 282.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.0848/0.08546, allocations: 48.7 MB / 0.6067 GB, free: 11.54 MB / 282.7 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Media.TestAllProperties.IncompleteMedia.ReferenceMoistAir): time 0.05138/0.1369, allocations: 25.06 MB / 0.6312 GB, free: 2.414 MB / 298.7 MB
Notification: Performance of NFInst.instExpressions: time 0.04221/0.1792, allocations: 11.61 MB / 0.6425 GB, free: 6.777 MB / 314.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0002591/0.1795, allocations: 4 kB / 0.6426 GB, free: 6.773 MB / 314.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.0004185/0.1799, allocations: 55.64 kB / 0.6426 GB, free: 6.719 MB / 314.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.3119/0.4918, allocations: 6.215 MB / 0.6487 GB, free: 15.41 MB / 314.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.0009434/0.4928, allocations: 208.3 kB / 0.6489 GB, free: 15.41 MB / 314.7 MB
Notification: Performance of NFFlatten.flatten: time 0.001123/0.4939, allocations: 0.5699 MB / 0.6494 GB, free: 15.41 MB / 314.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 8.611e-05/0.494, allocations: 14.8 kB / 0.6494 GB, free: 15.41 MB / 314.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0004679/0.4945, allocations: 180.9 kB / 0.6496 GB, free: 15.41 MB / 314.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.02552/0.5201, allocations: 11.35 MB / 0.6607 GB, free: 14.77 MB / 314.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0001133/0.5202, allocations: 9.062 kB / 0.6607 GB, free: 14.77 MB / 314.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.02866/0.5489, allocations: 10.95 MB / 0.6714 GB, free: 12.17 MB / 314.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.0001611/0.5491, allocations: 88.42 kB / 0.6715 GB, free: 12.11 MB / 314.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.0001599/0.5493, allocations: 75.14 kB / 0.6716 GB, free: 12.05 MB / 314.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.01096/0.5602, allocations: 4.086 MB / 0.6756 GB, free: 8.617 MB / 314.7 MB
Notification: Performance of FrontEnd - DAE generated: time 5.059e-06/0.5603, allocations: 0 / 0.6756 GB, free: 8.617 MB / 314.7 MB
Notification: Performance of FrontEnd: time 1.924e-06/0.5603, allocations: 3.562 kB / 0.6756 GB, free: 8.617 MB / 314.7 MB
Notification: Performance of Transformations before backend: time 1.732e-05/0.5604, allocations: 0 / 0.6756 GB, free: 8.617 MB / 314.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 73
 * Number of variables: 73
Notification: Performance of Generate backend data structure: time 0.005078/0.5654, allocations: 1.453 MB / 0.677 GB, free: 7.18 MB / 314.7 MB
Notification: Performance of prepare preOptimizeDAE: time 4.731e-05/0.5655, allocations: 12.03 kB / 0.677 GB, free: 7.168 MB / 314.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0002179/0.5657, allocations: 31.72 kB / 0.677 GB, free: 7.137 MB / 314.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0003326/0.5661, allocations: 244.4 kB / 0.6773 GB, free: 6.887 MB / 314.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 3.171e-05/0.5661, allocations: 20.19 kB / 0.6773 GB, free: 6.875 MB / 314.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 5.284e-05/0.5662, allocations: 23.31 kB / 0.6773 GB, free: 6.859 MB / 314.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001126/0.5673, allocations: 0.4969 MB / 0.6778 GB, free: 6.465 MB / 314.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 1.793e-05/0.5674, allocations: 0 / 0.6778 GB, free: 6.465 MB / 314.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 5.405e-05/0.5674, allocations: 16.89 kB / 0.6778 GB, free: 6.457 MB / 314.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.112e-05/0.5675, allocations: 27.17 kB / 0.6778 GB, free: 6.434 MB / 314.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001483/0.569, allocations: 0.8838 MB / 0.6787 GB, free: 5.727 MB / 314.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.00265/0.5717, allocations: 1.821 MB / 0.6805 GB, free: 4.031 MB / 314.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.0009456/0.5726, allocations: 331.6 kB / 0.6808 GB, free: 3.754 MB / 314.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0002203/0.5729, allocations: 101.2 kB / 0.6809 GB, free: 3.684 MB / 314.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0251/0.598, allocations: 13.28 MB / 0.6938 GB, free: 4.246 MB / 330.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0006548/0.5987, allocations: 241 kB / 0.6941 GB, free: 4.012 MB / 330.7 MB
Notification: Performance of pre-optimization done (n=33): time 3.537e-06/0.5987, allocations: 0 / 0.6941 GB, free: 4.012 MB / 330.7 MB
Notification: Performance of matching and sorting (n=35): time 0.003209/0.602, allocations: 0.7773 MB / 0.6948 GB, free: 3.34 MB / 330.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001786/0.6022, allocations: 265 kB / 0.6951 GB, free: 3.02 MB / 330.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0003148/0.6025, allocations: 202.1 kB / 0.6953 GB, free: 2.844 MB / 330.7 MB
Notification: Performance of collectPreVariables (initialization): time 5.222e-05/0.6026, allocations: 28.95 kB / 0.6953 GB, free: 2.812 MB / 330.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0001822/0.6028, allocations: 198.6 kB / 0.6955 GB, free: 2.629 MB / 330.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0001438/0.6029, allocations: 124.8 kB / 0.6956 GB, free: 2.527 MB / 330.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 3.187e-05/0.603, allocations: 9.938 kB / 0.6956 GB, free: 2.523 MB / 330.7 MB
Notification: Performance of setup shared object (initialization): time 0.0001616/0.6031, allocations: 338.3 kB / 0.6959 GB, free: 2.195 MB / 330.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0002614/0.6034, allocations: 91.5 kB / 0.696 GB, free: 2.129 MB / 330.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0007099/0.6041, allocations: 361.8 kB / 0.6964 GB, free: 1.688 MB / 330.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0005335/0.6047, allocations: 153.7 kB / 0.6965 GB, free: 1.586 MB / 330.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 9.658e-06/0.6047, allocations: 4 kB / 0.6965 GB, free: 1.582 MB / 330.7 MB
Notification: Performance of matching and sorting (n=66) (initialization): time 0.001759/0.6065, allocations: 0.4905 MB / 0.697 GB, free: 1.23 MB / 330.7 MB
Notification: Performance of prepare postOptimizeDAE: time 3.049e-05/0.6065, allocations: 8 kB / 0.697 GB, free: 1.223 MB / 330.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.899e-05/0.6066, allocations: 8 kB / 0.697 GB, free: 1.215 MB / 330.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 4.906e-05/0.6066, allocations: 16 kB / 0.697 GB, free: 1.199 MB / 330.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001232/0.6079, allocations: 179.7 kB / 0.6972 GB, free: 1.043 MB / 330.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0008982/0.6088, allocations: 1.191 MB / 0.6984 GB, free: 15.82 MB / 346.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0005383/0.6093, allocations: 27.16 kB / 0.6984 GB, free: 15.8 MB / 346.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001194/0.6095, allocations: 50.11 kB / 0.6984 GB, free: 15.76 MB / 346.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 42
 * 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 (66):
 * Single equations (assignments): 64
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 2
 * 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: 2 {1,1}
 * Without analytic Jacobian: 0
Notification: Performance of prepare postOptimizeDAE: time 0.000271/0.6098, allocations: 165.7 kB / 0.6986 GB, free: 15.62 MB / 346.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002603/0.61, allocations: 30.09 kB / 0.6986 GB, free: 15.59 MB / 346.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001663/0.6117, allocations: 477.2 kB / 0.6991 GB, free: 15.19 MB / 346.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 7.925e-06/0.6118, allocations: 0 / 0.6991 GB, free: 15.19 MB / 346.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.995e-06/0.6118, allocations: 7.891 kB / 0.6991 GB, free: 15.19 MB / 346.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0001624/0.6119, allocations: 118.2 kB / 0.6992 GB, free: 15.06 MB / 346.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 8.716e-05/0.612, allocations: 3.875 kB / 0.6992 GB, free: 15.06 MB / 346.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0004032/0.6125, allocations: 22.73 kB / 0.6992 GB, free: 15.05 MB / 346.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 6.074e-05/0.6125, allocations: 18.5 kB / 0.6993 GB, free: 15.03 MB / 346.7 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.000993/0.6135, allocations: 374.2 kB / 0.6996 GB, free: 14.7 MB / 346.7 MB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.001065/0.6146, allocations: 490.8 kB / 0.7001 GB, free: 14.26 MB / 346.7 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0002132/0.6149, allocations: 59.97 kB / 0.7001 GB, free: 14.22 MB / 346.7 MB
Notification: Performance of sorting global known variables: time 0.0002567/0.6151, allocations: 164.9 kB / 0.7003 GB, free: 14.08 MB / 346.7 MB
Notification: Performance of Backend: time 7.41e-07/0.6152, allocations: 0 / 0.7003 GB, free: 14.08 MB / 346.7 MB
Notification: Performance of simCode: created initialization part: time 0.015/0.6302, allocations: 2.63 MB / 0.7029 GB, free: 11.79 MB / 346.7 MB
Notification: Performance of SimCode: time 0.001728/0.6319, allocations: 1.048 MB / 0.7039 GB, free: 10.74 MB / 346.7 MB
Notification: Performance of Templates: time 0.1266/0.7586, allocations: 53.73 MB / 0.7564 GB, free: 5.172 MB / 394.7 MB