Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ModelicaTest_3.2.1_ModelicaTest.Media.TestsWithFluid.MediaTestModels.Air.DryAirNasa.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.TestsWithFluid.MediaTestModels.Air.DryAirNasa,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|volume.medium.T|volume.medium.p",fileNamePrefix="ModelicaTest_3.2.1_ModelicaTest.Media.TestsWithFluid.MediaTestModels.Air.DryAirNasa")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.1+maint.om/package.mo): time 0.002783/0.002789, allocations: 350.9 kB / 15.95 MB, free: 6.215 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.793/3.793, allocations: 341.5 MB / 358.2 MB, free: 12.64 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.003454/0.003454, allocations: 217.2 kB / 397.9 MB, free: 4.988 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.5033/0.5033, allocations: 76.09 MB / 0.5014 GB, free: 112.6 MB / 362.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0007591/0.0007594, allocations: 8 kB / 0.5592 GB, free: 53.47 MB / 362.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.107/0.1078, allocations: 48.7 MB / 0.6068 GB, free: 4.66 MB / 362.7 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Media.TestsWithFluid.MediaTestModels.Air.DryAirNasa): time 0.9245/1.032, allocations: 163.7 MB / 0.7666 GB, free: 4.824 MB / 410.7 MB
Notification: Performance of NFInst.instExpressions: time 0.01514/1.048, allocations: 7.624 MB / 0.774 GB, free: 4.738 MB / 410.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001321/1.049, allocations: 27.31 kB / 0.7741 GB, free: 4.738 MB / 410.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.001255/1.05, allocations: 249.3 kB / 0.7743 GB, free: 4.73 MB / 410.7 MB
[/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.1+maint.om/Fluid/Sources.mo:826:36-827:54:writable] Warning: 'each' used when modifying non-array element m_flow.
[/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.1+maint.om/Fluid/Sources.mo:824:36-825:54:writable] Warning: 'each' used when modifying non-array element m_flow.
[/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.1+maint.om/Fluid/Sources.mo:772:36-773:54:writable] Warning: 'each' used when modifying non-array element m_flow.
[/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.1+maint.om/Fluid/Sources.mo:770:36-771:54:writable] Warning: 'each' used when modifying non-array element m_flow.
Notification: Performance of NFTyping.typeBindings: time 0.006615/1.057, allocations: 1.325 MB / 0.7756 GB, free: 4.668 MB / 410.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.005195/1.062, allocations: 0.8856 MB / 0.7765 GB, free: 4.645 MB / 410.7 MB
Notification: Performance of NFFlatten.flatten: time 0.004839/1.067, allocations: 2.237 MB / 0.7786 GB, free: 4.641 MB / 410.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.001216/1.068, allocations: 378.5 kB / 0.779 GB, free: 4.621 MB / 410.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.004525/1.073, allocations: 1.006 MB / 0.78 GB, free: 4.605 MB / 410.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.001985/1.075, allocations: 0.6526 MB / 0.7806 GB, free: 4.602 MB / 410.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0002321/1.075, allocations: 31.06 kB / 0.7807 GB, free: 4.602 MB / 410.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.003005/1.078, allocations: 0.6006 MB / 0.7812 GB, free: 4.59 MB / 410.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.0005247/1.079, allocations: 234.7 kB / 0.7815 GB, free: 4.59 MB / 410.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.0004023/1.079, allocations: 163.5 kB / 0.7816 GB, free: 4.559 MB / 410.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.002499/1.081, allocations: 0.9877 MB / 0.7826 GB, free: 4.488 MB / 410.7 MB
Notification: Performance of FrontEnd - DAE generated: time 5.57e-06/1.082, allocations: 2.25 kB / 0.7826 GB, free: 4.488 MB / 410.7 MB
Notification: Performance of FrontEnd: time 2.184e-06/1.082, allocations: 0 / 0.7826 GB, free: 4.488 MB / 410.7 MB
Notification: Performance of Transformations before backend: time 1.339e-05/1.082, allocations: 2.938 kB / 0.7826 GB, free: 4.488 MB / 410.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 130
 * Number of variables: 130
Notification: Performance of Generate backend data structure: time 0.003797/1.085, allocations: 0.9861 MB / 0.7836 GB, free: 3.875 MB / 410.7 MB
Notification: Performance of prepare preOptimizeDAE: time 6.011e-05/1.085, allocations: 9.406 kB / 0.7836 GB, free: 3.875 MB / 410.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001665/1.087, allocations: 132.3 kB / 0.7837 GB, free: 3.84 MB / 410.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001573/1.089, allocations: 0.4991 MB / 0.7842 GB, free: 3.594 MB / 410.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001954/1.089, allocations: 101 kB / 0.7843 GB, free: 3.527 MB / 410.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002002/1.089, allocations: 47.59 kB / 0.7843 GB, free: 3.527 MB / 410.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002633/1.092, allocations: 0.8177 MB / 0.7851 GB, free: 3.305 MB / 410.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 3.542e-05/1.092, allocations: 4.125 kB / 0.7851 GB, free: 3.305 MB / 410.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001525/1.092, allocations: 23.94 kB / 0.7851 GB, free: 3.305 MB / 410.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001178/1.092, allocations: 34.67 kB / 0.7852 GB, free: 3.305 MB / 410.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002323/1.094, allocations: 0.6248 MB / 0.7858 GB, free: 3.297 MB / 410.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.008801/1.103, allocations: 3.944 MB / 0.7896 GB, free: 16.69 MB / 426.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.001195/1.105, allocations: 346.6 kB / 0.79 GB, free: 16.67 MB / 426.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0005952/1.105, allocations: 169.9 kB / 0.7901 GB, free: 16.66 MB / 426.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0007724/1.106, allocations: 369.7 kB / 0.7905 GB, free: 16.37 MB / 426.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 5.134e-05/1.106, allocations: 37.03 kB / 0.7905 GB, free: 16.33 MB / 426.7 MB
Notification: Performance of pre-optimization done (n=34): time 5.07e-06/1.106, allocations: 1.031 kB / 0.7905 GB, free: 16.33 MB / 426.7 MB
Notification: Performance of matching and sorting (n=39): time 0.01184/1.118, allocations: 1.651 MB / 0.7921 GB, free: 15.82 MB / 426.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001027/1.118, allocations: 135.4 kB / 0.7923 GB, free: 15.67 MB / 426.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001382/1.119, allocations: 0.5883 MB / 0.7928 GB, free: 15.53 MB / 426.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0001048/1.12, allocations: 35.11 kB / 0.7929 GB, free: 15.5 MB / 426.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0004788/1.12, allocations: 384.4 kB / 0.7932 GB, free: 15.3 MB / 426.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0002294/1.12, allocations: 144.6 kB / 0.7934 GB, free: 15.21 MB / 426.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 8.216e-05/1.12, allocations: 14.88 kB / 0.7934 GB, free: 15.21 MB / 426.7 MB
Notification: Performance of setup shared object (initialization): time 0.0002732/1.121, allocations: 377.3 kB / 0.7937 GB, free: 14.89 MB / 426.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0008512/1.122, allocations: 201 kB / 0.7939 GB, free: 14.89 MB / 426.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001153/1.123, allocations: 0.5372 MB / 0.7945 GB, free: 14.46 MB / 426.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001096/1.124, allocations: 300.6 kB / 0.7947 GB, free: 14.45 MB / 426.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.507e-05/1.124, allocations: 3.844 kB / 0.7948 GB, free: 14.45 MB / 426.7 MB
Notification: Performance of matching and sorting (n=89) (initialization): time 0.003426/1.127, allocations: 0.8856 MB / 0.7956 GB, free: 14.36 MB / 426.7 MB
Notification: Performance of prepare postOptimizeDAE: time 3.381e-05/1.127, allocations: 9.406 kB / 0.7956 GB, free: 14.36 MB / 426.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.538e-05/1.127, allocations: 11.86 kB / 0.7956 GB, free: 14.36 MB / 426.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002525/1.13, allocations: 308.8 kB / 0.7959 GB, free: 14.34 MB / 426.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0007801/1.131, allocations: 134.8 kB / 0.7961 GB, free: 14.34 MB / 426.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.00167/1.132, allocations: 0.9054 MB / 0.7969 GB, free: 13.81 MB / 426.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0009712/1.133, allocations: 46.56 kB / 0.797 GB, free: 13.81 MB / 426.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001505/1.134, allocations: 68.36 kB / 0.7971 GB, free: 13.81 MB / 426.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 49
 * Number of states: 0 ()
 * Number of discrete variables: 4 (volume.regularFlow[1],volume.regularFlow[2],volume.inFlow[2],volume.inFlow[1])
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (72):
 * Single equations (assignments): 71
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 1 {2 16}
Notification: Performance of prepare postOptimizeDAE: time 0.0005236/1.134, allocations: 252.2 kB / 0.7973 GB, free: 13.69 MB / 426.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.000152/1.134, allocations: 69.06 kB / 0.7974 GB, free: 13.65 MB / 426.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002131/1.136, allocations: 0.6775 MB / 0.798 GB, free: 13.54 MB / 426.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.019e-05/1.136, allocations: 6.812 kB / 0.798 GB, free: 13.53 MB / 426.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.347e-06/1.136, allocations: 0 / 0.798 GB, free: 13.53 MB / 426.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003678/1.137, allocations: 182.5 kB / 0.7982 GB, free: 13.41 MB / 426.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001787/1.137, allocations: 9.156 kB / 0.7982 GB, free: 13.41 MB / 426.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0006035/1.138, allocations: 28.59 kB / 0.7982 GB, free: 13.4 MB / 426.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 9.851e-05/1.138, allocations: 35.69 kB / 0.7983 GB, free: 13.4 MB / 426.7 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.002496/1.14, allocations: 0.6197 MB / 0.7989 GB, free: 13.27 MB / 426.7 MB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.001622/1.142, allocations: 0.7975 MB / 0.7997 GB, free: 13.01 MB / 426.7 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0004515/1.142, allocations: 183.2 kB / 0.7998 GB, free: 13 MB / 426.7 MB
Notification: Performance of sorting global known variables: time 0.0007857/1.143, allocations: 416.6 kB / 0.8002 GB, free: 12.91 MB / 426.7 MB
Notification: Performance of Backend: time 6.91e-07/1.143, allocations: 0 / 0.8002 GB, free: 12.91 MB / 426.7 MB
Notification: Performance of simCode: created initialization part: time 0.003623/1.147, allocations: 0.8216 MB / 0.801 GB, free: 12.78 MB / 426.7 MB
Notification: Performance of SimCode: time 0.004288/1.151, allocations: 2.113 MB / 0.8031 GB, free: 11.59 MB / 426.7 MB
Notification: Performance of Templates: time 0.04351/1.195, allocations: 17.28 MB / 0.82 GB, free: 3.578 MB / 426.7 MB