Running: ./testmodel.py --libraries=/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/./OMCompiler/build/lib/omlibrary/ --ompython_omhome=/usr ModelicaTest_3.2.2_ModelicaTest.Media.TestAllProperties.MoistAir.conf.json
Using package ModelicaTest with version 3.2.2 (/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/ModelicaTest 3.2.2/package.mo)
Using package Modelica with version 3.2.2 (/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/Modelica 3.2.2/package.mo)
Using package Complex with version 3.2.2 (/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/Complex 3.2.2.mo)
Using package ModelicaServices with version 3.2.2 (/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/ModelicaServices 3.2.2/package.mo)
Running command: "" <> buildModelFMU(ModelicaTest.Media.TestAllProperties.MoistAir,fileNamePrefix="ModelicaTest_3_2_2_ModelicaTest_Media_TestAllProperties_MoistAir",fmuType="me",version="2.0",platforms={"static"})
Notification: Performance of loadFile(/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/ModelicaServices 3.2.2/package.mo): time 0.01531/0.01531, allocations: 108.7 kB / 15.06 MB, free: 5.555 MB / 13.93 MB
Notification: Performance of loadFile(/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/Complex 3.2.2.mo): time 0.001829/0.001829, allocations: 180.5 kB / 15.95 MB, free: 5.52 MB / 13.93 MB
Notification: Performance of loadFile(/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/Modelica 3.2.2/package.mo): time 2.095/2.095, allocations: 194.5 MB / 211.3 MB, free: 10.95 MB / 170.7 MB
Notification: Performance of loadFile(/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/ModelicaTest 3.2.2/package.mo): time 0.2725/0.2725, allocations: 40.05 MB / 296.5 MB, free: 6.215 MB / 250.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0006685/0.0006685, allocations: 16 kB / 361.1 MB, free: 9.523 MB / 298.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1212/0.1219, allocations: 54.88 MB / 416 MB, free: 2.551 MB / 346.7 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Media.TestAllProperties.MoistAir): time 0.6331/0.7551, allocations: 127.9 MB / 0.5311 GB, free: 0.5547 MB / 394.7 MB
Notification: Performance of NFInst.instExpressions: time 0.02149/0.7844, allocations: 11.28 MB / 0.5422 GB, free: 8.754 MB / 410.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0003176/0.7847, allocations: 0 / 0.5422 GB, free: 8.754 MB / 410.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.0003787/0.7851, allocations: 61.25 kB / 0.5422 GB, free: 8.723 MB / 410.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.01033/0.7955, allocations: 2.505 MB / 0.5447 GB, free: 7.391 MB / 410.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.0006641/0.7961, allocations: 148.4 kB / 0.5448 GB, free: 7.316 MB / 410.7 MB
Notification: Performance of NFFlatten.flatten: time 0.0006941/0.7969, allocations: 337.3 kB / 0.5451 GB, free: 7.156 MB / 410.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 7.946e-05/0.7969, allocations: 18.44 kB / 0.5451 GB, free: 7.148 MB / 410.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0005196/0.7975, allocations: 223.1 kB / 0.5453 GB, free: 7.062 MB / 410.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0008757/0.7984, allocations: 316.6 kB / 0.5457 GB, free: 6.965 MB / 410.7 MB
Notification: Performance of NFPackage.collectConstants: time 4.973e-05/0.7984, allocations: 14.28 kB / 0.5457 GB, free: 6.961 MB / 410.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.01236/0.8108, allocations: 4.246 MB / 0.5498 GB, free: 4.855 MB / 410.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.0001816/0.811, allocations: 83.75 kB / 0.5499 GB, free: 4.773 MB / 410.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.0001774/0.8112, allocations: 89.58 kB / 0.55 GB, free: 4.68 MB / 410.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.005447/0.8167, allocations: 1.586 MB / 0.5515 GB, free: 3.105 MB / 410.7 MB
Notification: Performance of FrontEnd - DAE generated: time 3.406e-06/0.8168, allocations: 0 / 0.5515 GB, free: 3.105 MB / 410.7 MB
Notification: Performance of FrontEnd: time 2.966e-06/0.8168, allocations: 0 / 0.5515 GB, free: 3.105 MB / 410.7 MB
Notification: Performance of Transformations before backend: time 7.634e-06/0.8168, allocations: 0 / 0.5515 GB, free: 3.105 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: 81
 * Number of variables: 81
Notification: Performance of Generate backend data structure: time 0.003922/0.8207, allocations: 1.055 MB / 0.5526 GB, free: 2.008 MB / 410.7 MB
Notification: Performance of prepare preOptimizeDAE: time 5.211e-05/0.8208, allocations: 8.031 kB / 0.5526 GB, free: 2 MB / 410.7 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.00015/0.821, allocations: 78.52 kB / 0.5526 GB, free: 1.914 MB / 410.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0002247/0.8212, allocations: 31.72 kB / 0.5527 GB, free: 1.883 MB / 410.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0004333/0.8216, allocations: 250.6 kB / 0.5529 GB, free: 1.598 MB / 410.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002041/0.8219, allocations: 133.2 kB / 0.553 GB, free: 1.445 MB / 410.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 9.442e-05/0.822, allocations: 28 kB / 0.5531 GB, free: 1.418 MB / 410.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001428/0.8234, allocations: 0.572 MB / 0.5536 GB, free: 0.8125 MB / 410.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 2.169e-05/0.8235, allocations: 0 / 0.5536 GB, free: 0.8125 MB / 410.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 7.604e-05/0.8236, allocations: 23.94 kB / 0.5536 GB, free: 0.7891 MB / 410.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 8.764e-05/0.8237, allocations: 32.48 kB / 0.5537 GB, free: 0.7578 MB / 410.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002983/0.8267, allocations: 1.255 MB / 0.5549 GB, free: 15.5 MB / 426.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.006197/0.833, allocations: 2.053 MB / 0.5569 GB, free: 13.31 MB / 426.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.001696/0.8347, allocations: 264.2 kB / 0.5572 GB, free: 13.04 MB / 426.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.008437/0.8432, allocations: 3.063 MB / 0.5601 GB, free: 9.488 MB / 426.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 6.002e-05/0.8433, allocations: 42.5 kB / 0.5602 GB, free: 9.438 MB / 426.7 MB
Notification: Performance of pre-optimization done (n=42): time 8.296e-06/0.8434, allocations: 3.984 kB / 0.5602 GB, free: 9.434 MB / 426.7 MB
Notification: Performance of matching and sorting (n=44): time 0.003475/0.8469, allocations: 0.809 MB / 0.561 GB, free: 8.586 MB / 426.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.216e-05/0.847, allocations: 59.34 kB / 0.561 GB, free: 8.516 MB / 426.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0003019/0.8473, allocations: 202.1 kB / 0.5612 GB, free: 8.309 MB / 426.7 MB
Notification: Performance of collectPreVariables (initialization): time 5.839e-05/0.8474, allocations: 33.7 kB / 0.5613 GB, free: 8.27 MB / 426.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0001641/0.8475, allocations: 199.7 kB / 0.5615 GB, free: 8.07 MB / 426.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0001734/0.8477, allocations: 153.8 kB / 0.5616 GB, free: 7.918 MB / 426.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 4.473e-05/0.8478, allocations: 12 kB / 0.5616 GB, free: 7.906 MB / 426.7 MB
Notification: Performance of setup shared object (initialization): time 0.0001673/0.848, allocations: 342.8 kB / 0.5619 GB, free: 7.562 MB / 426.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0003342/0.8483, allocations: 105.2 kB / 0.562 GB, free: 7.457 MB / 426.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0005955/0.8489, allocations: 409.6 kB / 0.5624 GB, free: 6.914 MB / 426.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0004936/0.8494, allocations: 172.7 kB / 0.5626 GB, free: 6.746 MB / 426.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 9.838e-06/0.8495, allocations: 8 kB / 0.5626 GB, free: 6.738 MB / 426.7 MB
Notification: Performance of matching and sorting (n=74) (initialization): time 0.001596/0.8511, allocations: 0.5542 MB / 0.5631 GB, free: 6.18 MB / 426.7 MB
Notification: Performance of prepare postOptimizeDAE: time 6.196e-05/0.8512, allocations: 16.25 kB / 0.5632 GB, free: 6.164 MB / 426.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.541e-05/0.8512, allocations: 8 kB / 0.5632 GB, free: 6.156 MB / 426.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 4.088e-05/0.8512, allocations: 16 kB / 0.5632 GB, free: 6.141 MB / 426.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001344/0.8526, allocations: 195.7 kB / 0.5634 GB, free: 5.949 MB / 426.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0008999/0.8535, allocations: 1.198 MB / 0.5645 GB, free: 4.707 MB / 426.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0006479/0.8542, allocations: 31.84 kB / 0.5646 GB, free: 4.676 MB / 426.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001735/0.8544, allocations: 63.97 kB / 0.5646 GB, free: 4.613 MB / 426.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 48
 * Number of states: 0 ()
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (73):
 * Single equations (assignments): 70
 * Array equations: 1
 * 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.0003088/0.8547, allocations: 173.6 kB / 0.5648 GB, free: 4.434 MB / 426.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001061/0.8548, allocations: 23.72 kB / 0.5648 GB, free: 4.41 MB / 426.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.00229/0.8571, allocations: 0.6519 MB / 0.5655 GB, free: 3.723 MB / 426.7 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.786e-05/0.8572, allocations: 8 kB / 0.5655 GB, free: 3.715 MB / 426.7 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 8.466e-06/0.8572, allocations: 1.312 kB / 0.5655 GB, free: 3.715 MB / 426.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.047e-05/0.8572, allocations: 7.922 kB / 0.5655 GB, free: 3.707 MB / 426.7 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.001469/0.8587, allocations: 0.6504 MB / 0.5661 GB, free: 3 MB / 426.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.949e-06/0.8587, allocations: 4.031 kB / 0.5661 GB, free: 2.996 MB / 426.7 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0008588/0.8596, allocations: 103.8 kB / 0.5662 GB, free: 2.895 MB / 426.7 MB
Notification: Performance of postOpt tearingSystem (simulation): time 1.075e-05/0.8596, allocations: 4 kB / 0.5662 GB, free: 2.891 MB / 426.7 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 3.729e-05/0.8597, allocations: 11.98 kB / 0.5662 GB, free: 2.879 MB / 426.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0007137/0.8604, allocations: 1.171 MB / 0.5674 GB, free: 1.664 MB / 426.7 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.691e-06/0.8604, allocations: 3.953 kB / 0.5674 GB, free: 1.66 MB / 426.7 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.0007463/0.8612, allocations: 350.3 kB / 0.5677 GB, free: 1.293 MB / 426.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0002569/0.8614, allocations: 160.6 kB / 0.5679 GB, free: 1.117 MB / 426.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 8.226e-05/0.8615, allocations: 4 kB / 0.5679 GB, free: 1.113 MB / 426.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.000508/0.8621, allocations: 24.03 kB / 0.5679 GB, free: 1.09 MB / 426.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 8.035e-05/0.8622, allocations: 20.25 kB / 0.5679 GB, free: 1.07 MB / 426.7 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 7.056e-05/0.8622, allocations: 27.98 kB / 0.5679 GB, free: 1.043 MB / 426.7 MB
Notification: Performance of sorting global known variables: time 0.0002616/0.8625, allocations: 172.4 kB / 0.5681 GB, free: 0.875 MB / 426.7 MB
Notification: Performance of sort global known variables: time 3.81e-07/0.8625, allocations: 3.938 kB / 0.5681 GB, free: 0.8711 MB / 426.7 MB
Notification: Performance of remove unused functions: time 0.002382/0.8649, allocations: 0.5426 MB / 0.5686 GB, free: 336 kB / 426.7 MB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 2
 * Number of states: 0 ()
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (35):
 * Single equations (assignments): 32
 * Array equations: 1
 * 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 Backend phase and start with SimCode phase: time 0.004902/0.8698, allocations: 1.694 MB / 0.5703 GB, free: 14.61 MB / 442.7 MB
Notification: Performance of simCode: created initialization part: time 0.001599/0.8715, allocations: 369.2 kB / 0.5706 GB, free: 14.25 MB / 442.7 MB
Notification: Performance of simCode: created event and clocks part: time 4.96e-06/0.8715, allocations: 1.75 kB / 0.5706 GB, free: 14.25 MB / 442.7 MB
Notification: Performance of simCode: created simulation system equations: time 0.0006521/0.8722, allocations: 151.5 kB / 0.5708 GB, free: 14.1 MB / 442.7 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.0009897/0.8732, allocations: 86.05 kB / 0.5709 GB, free: 14.01 MB / 442.7 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.00832/0.8815, allocations: 9.075 MB / 0.5797 GB, free: 4.684 MB / 442.7 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0004584/0.882, allocations: 0.7737 MB / 0.5805 GB, free: 3.883 MB / 442.7 MB
Notification: Performance of simCode: alias equations: time 0.001472/0.8835, allocations: 187.9 kB / 0.5807 GB, free: 3.703 MB / 442.7 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0004942/0.884, allocations: 123.4 kB / 0.5808 GB, free: 3.582 MB / 442.7 MB
Notification: Performance of SimCode: time 1.112e-06/0.8841, allocations: 4 kB / 0.5808 GB, free: 3.578 MB / 442.7 MB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.06906/0.9531, allocations: 19.02 MB / 0.5994 GB, free: 0.7148 MB / 458.7 MB
Notification: Performance of buildModelFMU: configured platform static using cached values: time 0.0004134/0.9536, allocations: 259.9 kB / 0.5996 GB, free: 384 kB / 458.7 MB
Notification: Performance of buildModelFMU: Generate platform static: time 3.825/4.778, allocations: 0 / 0.5996 GB, free: 384 kB / 458.7 MB
TODO: How the !@#!# did the simulation report success but simulation result ModelicaTest_3.2.2_ModelicaTest.Media.TestAllProperties.MoistAir_res.mat does not exist to compare? outputFormat=mat