Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_trunk_Modelica.Media.Examples.PsychrometricData.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo", uses=false)
Using package Modelica with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo)
Using package Complex with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo)
Using package ModelicaServices with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo)
Running command: translateModel(Modelica.Media.Examples.PsychrometricData,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2000,variableFilter="time|hx_h.1.|hx_h.2.|hx_h.3.|hx_h.4.|hx_h.5.|hx_h.6.|hx_h.7.|hx_h.8.|hx_h.9.|hx_h.10.|hx_h.11.|hx_h.12.|hx_h.13.|hx_h.14.|hx_h.15.|hx_h.16.|x",fileNamePrefix="Modelica_trunk_Modelica.Media.Examples.PsychrometricData")
translateModel(Modelica.Media.Examples.PsychrometricData,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2000,variableFilter="time|hx_h.1.|hx_h.2.|hx_h.3.|hx_h.4.|hx_h.5.|hx_h.6.|hx_h.7.|hx_h.8.|hx_h.9.|hx_h.10.|hx_h.11.|hx_h.12.|hx_h.13.|hx_h.14.|hx_h.15.|hx_h.16.|x",fileNamePrefix="Modelica_trunk_Modelica.Media.Examples.PsychrometricData")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.001084/0.001084, allocations: 117 kB / 18.41 MB, free: 4.559 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.001134/0.001134, allocations: 204.5 kB / 19.36 MB, free: 3.617 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 1.333/1.333, allocations: 227.4 MB / 247.5 MB, free: 10.34 MB / 206.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001141/0.001141, allocations: 59.7 kB / 308.4 MB, free: 15.89 MB / 254.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.09802/0.09918, allocations: 50.53 MB / 358.9 MB, free: 13.34 MB / 302.1 MB
Notification: Performance of NFInst.instantiate(Modelica.Media.Examples.PsychrometricData): time 0.3532/0.4524, allocations: 154.8 MB / 0.5016 GB, free: 15.86 MB / 430.1 MB
Notification: Performance of NFInst.instExpressions: time 0.001159/0.4536, allocations: 0.688 MB / 0.5023 GB, free: 15.19 MB / 430.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 8.081e-05/0.4537, allocations: 0 / 0.5023 GB, free: 15.19 MB / 430.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0003497/0.4541, allocations: 79.48 kB / 0.5024 GB, free: 15.11 MB / 430.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.0005795/0.4547, allocations: 294.9 kB / 0.5026 GB, free: 14.83 MB / 430.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.00273/0.4574, allocations: 1.132 MB / 0.5037 GB, free: 13.71 MB / 430.1 MB
Notification: Performance of NFFlatten.flatten: time 0.00473/0.4622, allocations: 5.601 MB / 0.5092 GB, free: 8.086 MB / 430.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0003596/0.4625, allocations: 255.5 kB / 0.5095 GB, free: 7.816 MB / 430.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.003003/0.4656, allocations: 2.179 MB / 0.5116 GB, free: 5.633 MB / 430.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.002789/0.4684, allocations: 1.959 MB / 0.5135 GB, free: 3.668 MB / 430.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0005192/0.4689, allocations: 236 kB / 0.5137 GB, free: 3.438 MB / 430.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.003583/0.4725, allocations: 1.779 MB / 0.5155 GB, free: 1.656 MB / 430.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.00133/0.4738, allocations: 1.224 MB / 0.5167 GB, free: 440 kB / 430.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.002262/0.4761, allocations: 1.565 MB / 0.5182 GB, free: 14.86 MB / 446.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.004943/0.4811, allocations: 4.55 MB / 0.5226 GB, free: 10.3 MB / 446.1 MB
Notification: Performance of FrontEnd - DAE generated: time 5.17e-06/0.4811, allocations: 0 / 0.5226 GB, free: 10.3 MB / 446.1 MB
Notification: Performance of FrontEnd: time 2.044e-06/0.4811, allocations: 0 / 0.5226 GB, free: 10.3 MB / 446.1 MB
Notification: Performance of Transformations before backend: time 7.458e-05/0.4812, allocations: 0 / 0.5226 GB, free: 10.3 MB / 446.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 621
 * Number of variables: 621
Notification: Performance of Generate backend data structure: time 0.009434/0.4906, allocations: 3.503 MB / 0.526 GB, free: 6.734 MB / 446.1 MB
Notification: Performance of prepare preOptimizeDAE: time 4.793e-05/0.4907, allocations: 15.97 kB / 0.5261 GB, free: 6.719 MB / 446.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001852/0.4925, allocations: 326.5 kB / 0.5264 GB, free: 6.398 MB / 446.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.00326/0.4958, allocations: 1.339 MB / 0.5277 GB, free: 5.012 MB / 446.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001481/0.496, allocations: 184.9 kB / 0.5279 GB, free: 4.828 MB / 446.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0004465/0.4964, allocations: 239.9 kB / 0.5281 GB, free: 4.594 MB / 446.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.006385/0.5028, allocations: 3.819 MB / 0.5318 GB, free: 0.7227 MB / 446.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 3.905e-05/0.5029, allocations: 0 / 0.5318 GB, free: 0.7227 MB / 446.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003616/0.5033, allocations: 116 kB / 0.5319 GB, free: 0.6094 MB / 446.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.079e-05/0.5033, allocations: 60 kB / 0.532 GB, free: 0.5508 MB / 446.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.1531/0.6564, allocations: 5.981 MB / 0.5378 GB, free: 158.4 MB / 446.1 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.02173/0.6782, allocations: 11.21 MB / 0.5488 GB, free: 152 MB / 446.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.007144/0.6853, allocations: 5.036 MB / 0.5537 GB, free: 149.3 MB / 446.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.003142/0.6885, allocations: 2.406 MB / 0.556 GB, free: 148.2 MB / 446.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0005742/0.6891, allocations: 443.9 kB / 0.5565 GB, free: 147.8 MB / 446.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 9.004e-05/0.6892, allocations: 97.81 kB / 0.5566 GB, free: 147.7 MB / 446.1 MB
Notification: Performance of pre-optimization done (n=390): time 5.741e-06/0.6892, allocations: 0 / 0.5566 GB, free: 147.7 MB / 446.1 MB
Notification: Performance of matching and sorting (n=390): time 0.008242/0.6975, allocations: 5.813 MB / 0.5622 GB, free: 142.7 MB / 446.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.78e-05/0.6976, allocations: 90.47 kB / 0.5623 GB, free: 142.6 MB / 446.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001116/0.6988, allocations: 0.8711 MB / 0.5632 GB, free: 141.8 MB / 446.1 MB
Notification: Performance of collectPreVariables (initialization): time 0.0005652/0.6993, allocations: 105.7 kB / 0.5633 GB, free: 141.7 MB / 446.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0002925/0.6996, allocations: 0.5155 MB / 0.5638 GB, free: 141.1 MB / 446.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0009201/0.7006, allocations: 1.304 MB / 0.565 GB, free: 139.8 MB / 446.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.000846/0.7014, allocations: 0.6225 MB / 0.5657 GB, free: 139.2 MB / 446.1 MB
Notification: Performance of setup shared object (initialization): time 9.442e-05/0.7015, allocations: 357.9 kB / 0.566 GB, free: 138.8 MB / 446.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002131/0.7037, allocations: 1.745 MB / 0.5677 GB, free: 137.1 MB / 446.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002439/0.7061, allocations: 2.269 MB / 0.5699 GB, free: 134.7 MB / 446.1 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.004928/0.711, allocations: 4.319 MB / 0.5741 GB, free: 130.2 MB / 446.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.169e-05/0.7111, allocations: 4 kB / 0.5741 GB, free: 130.2 MB / 446.1 MB
Notification: Performance of matching and sorting (n=450) (initialization): time 0.006757/0.7178, allocations: 4.595 MB / 0.5786 GB, free: 125.6 MB / 446.1 MB
Notification: Performance of prepare postOptimizeDAE: time 2.803e-05/0.7179, allocations: 16 kB / 0.5786 GB, free: 125.6 MB / 446.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.971e-05/0.7179, allocations: 8 kB / 0.5786 GB, free: 125.6 MB / 446.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 3.326e-05/0.718, allocations: 28.66 kB / 0.5787 GB, free: 125.5 MB / 446.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003333/0.7213, allocations: 0.7917 MB / 0.5794 GB, free: 124.8 MB / 446.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 4.822e-05/0.7214, allocations: 31.94 kB / 0.5795 GB, free: 124.7 MB / 446.1 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002154/0.7235, allocations: 360.5 kB / 0.5798 GB, free: 124.4 MB / 446.1 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000256/0.7238, allocations: 143.9 kB / 0.58 GB, free: 124.2 MB / 446.1 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 50
 * Number of states: 0 ()
 * Number of discrete variables: 11 (fog[11],fog[10],fog[9],fog[8],fog[7],fog[6],fog[5],fog[4],fog[3],fog[2],fog[1])
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (450):
 * Single equations (assignments): 450
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.001184/0.725, allocations: 0.7699 MB / 0.5807 GB, free: 123.4 MB / 446.1 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0004966/0.7255, allocations: 212 kB / 0.5809 GB, free: 123.2 MB / 446.1 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.007038/0.7325, allocations: 5.164 MB / 0.586 GB, free: 118 MB / 446.1 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.402e-05/0.7326, allocations: 40 kB / 0.586 GB, free: 118 MB / 446.1 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.252e-05/0.7326, allocations: 0.9375 kB / 0.586 GB, free: 118 MB / 446.1 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 3.197e-05/0.7326, allocations: 23.91 kB / 0.586 GB, free: 118 MB / 446.1 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.003449/0.7361, allocations: 2.82 MB / 0.5888 GB, free: 115.1 MB / 446.1 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 9.488e-06/0.7361, allocations: 3.938 kB / 0.5888 GB, free: 115.1 MB / 446.1 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003149/0.7393, allocations: 0.7294 MB / 0.5895 GB, free: 114.4 MB / 446.1 MB
Notification: Performance of postOpt tearingSystem (simulation): time 1.927e-05/0.7393, allocations: 16 kB / 0.5895 GB, free: 114.4 MB / 446.1 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0002061/0.7395, allocations: 96.83 kB / 0.5896 GB, free: 114.3 MB / 446.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.646e-05/0.7395, allocations: 12 kB / 0.5896 GB, free: 114.2 MB / 446.1 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.924e-06/0.7396, allocations: 4 kB / 0.5896 GB, free: 114.2 MB / 446.1 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.00827/0.7478, allocations: 7.222 MB / 0.5967 GB, free: 107 MB / 446.1 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0004755/0.7483, allocations: 317.9 kB / 0.597 GB, free: 106.6 MB / 446.1 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003449/0.7487, allocations: 87.83 kB / 0.5971 GB, free: 106.6 MB / 446.1 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002594/0.7513, allocations: 226.6 kB / 0.5973 GB, free: 106.3 MB / 446.1 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0004853/0.7518, allocations: 314.9 kB / 0.5976 GB, free: 106 MB / 446.1 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0003177/0.7521, allocations: 175.9 kB / 0.5977 GB, free: 105.9 MB / 446.1 MB
Notification: Performance of sorting global known variables: time 0.0006562/0.7528, allocations: 0.6863 MB / 0.5984 GB, free: 105.2 MB / 446.1 MB
Notification: Performance of sort global known variables: time 1.71e-07/0.7528, allocations: 0 / 0.5984 GB, free: 105.2 MB / 446.1 MB
Notification: Performance of remove unused functions: time 0.002073/0.7549, allocations: 1.086 MB / 0.5995 GB, free: 104.1 MB / 446.1 MB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 17 (x,hx_h[1],hx_h[2],hx_h[3],hx_h[4],hx_h[5],hx_h[6],hx_h[7],hx_h[8],hx_h[9],hx_h[10],hx_h[11],hx_h[12],hx_h[13],hx_h[14],hx_h[15],hx_h[16])
 * Number of discrete variables: 11 (fog[1],fog[2],fog[3],fog[4],fog[5],fog[6],fog[7],fog[8],fog[9],fog[10],fog[11])
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (431):
 * Single equations (assignments): 431
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.001007/0.7559, allocations: 443.5 kB / 0.5999 GB, free: 103.7 MB / 446.1 MB
Notification: Performance of simCode: created initialization part: time 0.005318/0.7612, allocations: 4.305 MB / 0.6041 GB, free: 99.38 MB / 446.1 MB
Notification: Performance of simCode: created event and clocks part: time 7.053e-06/0.7612, allocations: 5 kB / 0.6041 GB, free: 99.38 MB / 446.1 MB
Notification: Performance of simCode: created simulation system equations: time 0.002491/0.7637, allocations: 2.263 MB / 0.6063 GB, free: 97.12 MB / 446.1 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.004471/0.7682, allocations: 1.259 MB / 0.6075 GB, free: 95.86 MB / 446.1 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.008829/0.7771, allocations: 6.644 MB / 0.614 GB, free: 89.18 MB / 446.1 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0008603/0.7779, allocations: 1.842 MB / 0.6158 GB, free: 87.3 MB / 446.1 MB
Notification: Performance of simCode: alias equations: time 0.003912/0.7819, allocations: 1.771 MB / 0.6176 GB, free: 85.52 MB / 446.1 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0009267/0.7828, allocations: 299.3 kB / 0.6178 GB, free: 85.23 MB / 446.1 MB
Notification: Performance of SimCode: time 5.91e-07/0.7828, allocations: 0 / 0.6178 GB, free: 85.23 MB / 446.1 MB
Notification: Performance of Templates: time 0.06858/0.8514, allocations: 63.59 MB / 0.6799 GB, free: 21.88 MB / 446.1 MB
make -j1 -f Modelica_trunk_Modelica.Media.Examples.PsychrometricData.makefile
(rm -f Modelica_trunk_Modelica.Media.Examples.PsychrometricData.pipe ; mkfifo Modelica_trunk_Modelica.Media.Examples.PsychrometricData.pipe ; head -c 1048576 < Modelica_trunk_Modelica.Media.Examples.PsychrometricData.pipe >> ../files/Modelica_trunk_Modelica.Media.Examples.PsychrometricData.sim & ./Modelica_trunk_Modelica.Media.Examples.PsychrometricData  -abortSlowSimulation -alarm=480 -s cvode -emit_protected -lv LOG_STATS > Modelica_trunk_Modelica.Media.Examples.PsychrometricData.pipe 2>&1)
diffSimulationResults("Modelica_trunk_Modelica.Media.Examples.PsychrometricData_res.mat","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/Reference-modelica.org/ReferenceResults/MAP-LIB_ReferenceResults/v4.0.0/Modelica/Media/Examples/PsychrometricData/PsychrometricData.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Modelica_trunk_Modelica.Media.Examples.PsychrometricData.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches