Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ModelicaTest_3.2.1_ModelicaTest.Media.TestsWithFluid.MediaTestModels.Air.SimpleAir.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.SimpleAir,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.SimpleAir")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.1+maint.om/package.mo): time 0.004037/0.004043, allocations: 351.3 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.585/3.585, allocations: 341.5 MB / 358.2 MB, free: 12.63 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.003675/0.003675, allocations: 229.1 kB / 397.9 MB, free: 4.977 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.461/0.461, allocations: 76.1 MB / 0.5014 GB, free: 112.6 MB / 362.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0006235/0.0006237, allocations: 16 kB / 0.5592 GB, free: 53.45 MB / 362.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1173/0.1179, allocations: 48.7 MB / 0.6068 GB, free: 4.645 MB / 362.7 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Media.TestsWithFluid.MediaTestModels.Air.SimpleAir): time 0.4622/0.5802, allocations: 134.2 MB / 0.7378 GB, free: 10.55 MB / 394.7 MB
Notification: Performance of NFInst.instExpressions: time 0.01558/0.5958, allocations: 5.328 MB / 0.743 GB, free: 5.234 MB / 394.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001313/0.5972, allocations: 27.75 kB / 0.743 GB, free: 5.207 MB / 394.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.001963/0.5992, allocations: 262.4 kB / 0.7433 GB, free: 4.949 MB / 394.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.005136/0.6044, allocations: 0.8517 MB / 0.7441 GB, free: 4.094 MB / 394.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.005428/0.6099, allocations: 0.8068 MB / 0.7449 GB, free: 3.305 MB / 394.7 MB
Notification: Performance of NFFlatten.flatten: time 0.005359/0.6153, allocations: 2.187 MB / 0.747 GB, free: 1.113 MB / 394.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.001513/0.6169, allocations: 369.8 kB / 0.7474 GB, free: 0.7617 MB / 394.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.002609/0.6195, allocations: 0.6226 MB / 0.748 GB, free: 140 kB / 394.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.002575/0.6222, allocations: 0.6996 MB / 0.7487 GB, free: 15.43 MB / 410.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0003853/0.6226, allocations: 32 kB / 0.7487 GB, free: 15.4 MB / 410.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.002671/0.6253, allocations: 415.2 kB / 0.7491 GB, free: 15 MB / 410.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.0007486/0.6261, allocations: 227.3 kB / 0.7493 GB, free: 14.77 MB / 410.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.0004937/0.6267, allocations: 169.3 kB / 0.7495 GB, free: 14.6 MB / 410.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.002606/0.6293, allocations: 0.8026 MB / 0.7503 GB, free: 13.8 MB / 410.7 MB
Notification: Performance of FrontEnd - DAE generated: time 7.554e-06/0.6294, allocations: 4 kB / 0.7503 GB, free: 13.8 MB / 410.7 MB
Notification: Performance of FrontEnd: time 3.567e-06/0.6294, allocations: 0 / 0.7503 GB, free: 13.8 MB / 410.7 MB
Notification: Performance of Transformations before backend: time 3.632e-05/0.6295, allocations: 0 / 0.7503 GB, free: 13.8 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.004118/0.6336, allocations: 0.9191 MB / 0.7512 GB, free: 12.83 MB / 410.7 MB
Notification: Performance of prepare preOptimizeDAE: time 6.938e-05/0.6337, allocations: 8.031 kB / 0.7512 GB, free: 12.82 MB / 410.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0008523/0.6346, allocations: 99.03 kB / 0.7513 GB, free: 12.72 MB / 410.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001687/0.6363, allocations: 0.4922 MB / 0.7517 GB, free: 12.2 MB / 410.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001685/0.6365, allocations: 108.4 kB / 0.7519 GB, free: 12.08 MB / 410.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001339/0.6366, allocations: 44 kB / 0.7519 GB, free: 12.04 MB / 410.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002287/0.6389, allocations: 0.8111 MB / 0.7527 GB, free: 11.16 MB / 410.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 3.532e-05/0.639, allocations: 3.938 kB / 0.7527 GB, free: 11.16 MB / 410.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001261/0.6392, allocations: 31.94 kB / 0.7527 GB, free: 11.13 MB / 410.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001092/0.6393, allocations: 40.41 kB / 0.7528 GB, free: 11.09 MB / 410.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001942/0.6412, allocations: 0.6479 MB / 0.7534 GB, free: 10.45 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.007889/0.6492, allocations: 3.932 MB / 0.7572 GB, free: 6.234 MB / 410.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.001334/0.6505, allocations: 421.3 kB / 0.7576 GB, free: 5.816 MB / 410.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0006019/0.6512, allocations: 205.4 kB / 0.7578 GB, free: 5.613 MB / 410.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.003283/0.6545, allocations: 1.64 MB / 0.7594 GB, free: 3.781 MB / 410.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 5.495e-05/0.6546, allocations: 34.56 kB / 0.7595 GB, free: 3.738 MB / 410.7 MB
Notification: Performance of pre-optimization done (n=37): time 3.707e-06/0.6546, allocations: 4 kB / 0.7595 GB, free: 3.734 MB / 410.7 MB
Notification: Performance of matching and sorting (n=42): time 0.005374/0.66, allocations: 1.451 MB / 0.7609 GB, free: 2.223 MB / 410.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001054/0.6602, allocations: 140.3 kB / 0.761 GB, free: 2.055 MB / 410.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.00109/0.6613, allocations: 0.5614 MB / 0.7616 GB, free: 1.484 MB / 410.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0001301/0.6614, allocations: 33.7 kB / 0.7616 GB, free: 1.445 MB / 410.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0004269/0.6619, allocations: 379.2 kB / 0.762 GB, free: 1.066 MB / 410.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0002162/0.6621, allocations: 157.8 kB / 0.7621 GB, free: 0.9102 MB / 410.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 5.347e-05/0.6622, allocations: 16 kB / 0.7621 GB, free: 0.8945 MB / 410.7 MB
Notification: Performance of setup shared object (initialization): time 0.0002444/0.6624, allocations: 370.8 kB / 0.7625 GB, free: 0.5234 MB / 410.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0006889/0.6631, allocations: 205.9 kB / 0.7627 GB, free: 332 kB / 410.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.2766/0.9398, allocations: 0.5397 MB / 0.7632 GB, free: 134.6 MB / 410.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001247/0.9411, allocations: 313.5 kB / 0.7635 GB, free: 134.6 MB / 410.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.309e-05/0.9411, allocations: 3 kB / 0.7635 GB, free: 134.6 MB / 410.7 MB
Notification: Performance of matching and sorting (n=92) (initialization): time 0.003483/0.9446, allocations: 0.8952 MB / 0.7644 GB, free: 134.5 MB / 410.7 MB
Notification: Performance of prepare postOptimizeDAE: time 3.83e-05/0.9447, allocations: 11.62 kB / 0.7644 GB, free: 134.5 MB / 410.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.962e-05/0.9448, allocations: 11.62 kB / 0.7644 GB, free: 134.5 MB / 410.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002908/0.9477, allocations: 267.4 kB / 0.7647 GB, free: 134.5 MB / 410.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001147/0.9489, allocations: 135.6 kB / 0.7648 GB, free: 134.5 MB / 410.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001923/0.9508, allocations: 0.8431 MB / 0.7656 GB, free: 133.9 MB / 410.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001338/0.9522, allocations: 46 kB / 0.7657 GB, free: 133.9 MB / 410.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001353/0.9523, allocations: 38.36 kB / 0.7657 GB, free: 133.9 MB / 410.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 (77):
 * Single equations (assignments): 76
 * 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 14}
Notification: Performance of prepare postOptimizeDAE: time 0.000654/0.953, allocations: 258.8 kB / 0.7659 GB, free: 133.8 MB / 410.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002186/0.9532, allocations: 68.3 kB / 0.766 GB, free: 133.8 MB / 410.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002525/0.9558, allocations: 0.7297 MB / 0.7667 GB, free: 133.6 MB / 410.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.592e-05/0.9559, allocations: 2.625 kB / 0.7667 GB, free: 133.6 MB / 410.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.681e-06/0.9559, allocations: 1.281 kB / 0.7667 GB, free: 133.6 MB / 410.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.000583/0.9565, allocations: 195.2 kB / 0.7669 GB, free: 133.5 MB / 410.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002236/0.9567, allocations: 10.17 kB / 0.7669 GB, free: 133.5 MB / 410.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0008926/0.9576, allocations: 26.64 kB / 0.7669 GB, free: 133.5 MB / 410.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001384/0.9578, allocations: 28.53 kB / 0.767 GB, free: 133.5 MB / 410.7 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.00375/0.9615, allocations: 0.6529 MB / 0.7676 GB, free: 133.4 MB / 410.7 MB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.002679/0.9643, allocations: 0.8681 MB / 0.7685 GB, free: 133.1 MB / 410.7 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0007236/0.9651, allocations: 204.8 kB / 0.7686 GB, free: 133.1 MB / 410.7 MB
Notification: Performance of sorting global known variables: time 0.001134/0.9662, allocations: 400.2 kB / 0.769 GB, free: 133 MB / 410.7 MB
Notification: Performance of Backend: time 1.082e-06/0.9663, allocations: 0 / 0.769 GB, free: 133 MB / 410.7 MB
Notification: Performance of simCode: created initialization part: time 0.003935/0.9702, allocations: 0.6529 MB / 0.7697 GB, free: 133 MB / 410.7 MB
Notification: Performance of SimCode: time 0.006265/0.9765, allocations: 2.098 MB / 0.7717 GB, free: 131.8 MB / 410.7 MB
Notification: Performance of Templates: time 0.04429/1.021, allocations: 12.32 MB / 0.7838 GB, free: 129.1 MB / 410.7 MB