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) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.0013/0.0013, allocations: 120.1 kB / 18.49 MB, free: 4.59 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.001339/0.001339, allocations: 214.2 kB / 21.45 MB, free: 1.637 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 1.399/1.399, allocations: 230.4 MB / 254.7 MB, free: 15.02 MB / 206.1 MB
"
[Timeout remaining time 178]
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: "" <> buildModelFMU(Modelica.Media.Examples.PsychrometricData,fileNamePrefix="Modelica_trunk_Modelica_Media_Examples_PsychrometricData",fmuType="cs",version="2.0",platforms={"static"})
"" <> buildModelFMU(Modelica.Media.Examples.PsychrometricData,fileNamePrefix="Modelica_trunk_Modelica_Media_Examples_PsychrometricData",fmuType="cs",version="2.0",platforms={"static"}) [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 0.001925/0.001925, allocations: 59.91 kB / 373.7 MB, free: 10.09 MB / 302.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.09547/0.09739, allocations: 53.38 MB / 427.1 MB, free: 4.609 MB / 350.1 MB
Notification: Performance of NFInst.instantiate(Modelica.Media.Examples.PsychrometricData): time 0.3575/0.4549, allocations: 155.2 MB / 0.5686 GB, free: 5 MB / 478.1 MB
Notification: Performance of NFInst.instExpressions: time 0.001166/0.4561, allocations: 0.6913 MB / 0.5693 GB, free: 4.309 MB / 478.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 6.965e-05/0.4562, allocations: 7.938 kB / 0.5693 GB, free: 4.301 MB / 478.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0003387/0.4565, allocations: 79.48 kB / 0.5694 GB, free: 4.223 MB / 478.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.0005846/0.4571, allocations: 298.6 kB / 0.5697 GB, free: 3.93 MB / 478.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.002951/0.46, allocations: 1.111 MB / 0.5707 GB, free: 2.824 MB / 478.1 MB
Notification: Performance of NFFlatten.flatten: time 0.005311/0.4653, allocations: 5.616 MB / 0.5762 GB, free: 13.19 MB / 494.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.000288/0.4656, allocations: 188 kB / 0.5764 GB, free: 12.98 MB / 494.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.003355/0.469, allocations: 2.253 MB / 0.5786 GB, free: 10.72 MB / 494.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.003103/0.4721, allocations: 2.05 MB / 0.5806 GB, free: 8.668 MB / 494.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0006108/0.4727, allocations: 240 kB / 0.5808 GB, free: 8.434 MB / 494.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.003914/0.4766, allocations: 1.81 MB / 0.5826 GB, free: 6.621 MB / 494.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.001678/0.4783, allocations: 1.235 MB / 0.5838 GB, free: 5.383 MB / 494.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.00345/0.4817, allocations: 1.561 MB / 0.5853 GB, free: 3.816 MB / 494.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.007497/0.4892, allocations: 4.564 MB / 0.5898 GB, free: 15.24 MB / 0.4981 GB
Notification: Performance of FrontEnd - DAE generated: time 5.841e-06/0.4892, allocations: 0 / 0.5898 GB, free: 15.24 MB / 0.4981 GB
Notification: Performance of FrontEnd: time 1.833e-06/0.4892, allocations: 4 kB / 0.5898 GB, free: 15.23 MB / 0.4981 GB
Notification: Performance of Transformations before backend: time 9.457e-05/0.4893, allocations: 0 / 0.5898 GB, free: 15.23 MB / 0.4981 GB
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.009486/0.4988, allocations: 3.557 MB / 0.5933 GB, free: 11.61 MB / 0.4981 GB
Notification: Performance of prepare preOptimizeDAE: time 4.222e-05/0.4989, allocations: 8.031 kB / 0.5933 GB, free: 11.6 MB / 0.4981 GB
Notification: Performance of preOpt introduceOutputRealDerivatives (simulation): time 6.974e-05/0.4989, allocations: 65.06 kB / 0.5933 GB, free: 11.54 MB / 0.4981 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0005601/0.4995, allocations: 374 kB / 0.5937 GB, free: 11.16 MB / 0.4981 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001801/0.5013, allocations: 343.2 kB / 0.594 GB, free: 10.82 MB / 0.4981 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002581/0.5039, allocations: 1.339 MB / 0.5953 GB, free: 9.441 MB / 0.4981 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001466/0.504, allocations: 180.9 kB / 0.5955 GB, free: 9.262 MB / 0.4981 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003927/0.5044, allocations: 244 kB / 0.5957 GB, free: 9.023 MB / 0.4981 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.006374/0.5108, allocations: 3.823 MB / 0.5995 GB, free: 5.148 MB / 0.4981 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.837e-05/0.5108, allocations: 0 / 0.5995 GB, free: 5.148 MB / 0.4981 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003691/0.5112, allocations: 116 kB / 0.5996 GB, free: 5.035 MB / 0.4981 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.779e-05/0.5112, allocations: 56 kB / 0.5996 GB, free: 4.98 MB / 0.4981 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.009239/0.5205, allocations: 5.994 MB / 0.6055 GB, free: 14.97 MB / 0.5137 GB
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.02302/0.5435, allocations: 11.23 MB / 0.6165 GB, free: 2.895 MB / 0.5137 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.196/0.7395, allocations: 4.771 MB / 0.6211 GB, free: 177.1 MB / 0.5137 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.003649/0.7432, allocations: 2.241 MB / 0.6233 GB, free: 176.6 MB / 0.5137 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0005004/0.7437, allocations: 442.2 kB / 0.6237 GB, free: 176.2 MB / 0.5137 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 8.008e-05/0.7438, allocations: 90.44 kB / 0.6238 GB, free: 176.1 MB / 0.5137 GB
Notification: Performance of pre-optimization done (n=390): time 5.21e-06/0.7438, allocations: 0 / 0.6238 GB, free: 176.1 MB / 0.5137 GB
Notification: Performance of matching and sorting (n=390): time 0.009881/0.7537, allocations: 5.828 MB / 0.6295 GB, free: 174.6 MB / 0.5137 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.905e-05/0.7537, allocations: 92.64 kB / 0.6296 GB, free: 174.6 MB / 0.5137 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001059/0.7548, allocations: 0.875 MB / 0.6305 GB, free: 174.2 MB / 0.5137 GB
Notification: Performance of collectPreVariables (initialization): time 0.0004007/0.7552, allocations: 105.3 kB / 0.6306 GB, free: 174.2 MB / 0.5137 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0002658/0.7554, allocations: 0.5236 MB / 0.6311 GB, free: 173.8 MB / 0.5137 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0009175/0.7564, allocations: 1.37 MB / 0.6324 GB, free: 172.9 MB / 0.5137 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0008753/0.7572, allocations: 0.6277 MB / 0.633 GB, free: 172.6 MB / 0.5137 GB
Notification: Performance of setup shared object (initialization): time 0.0001074/0.7573, allocations: 359.5 kB / 0.6334 GB, free: 172.3 MB / 0.5137 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002756/0.7601, allocations: 1.741 MB / 0.6351 GB, free: 171.9 MB / 0.5137 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003088/0.7632, allocations: 2.258 MB / 0.6373 GB, free: 171 MB / 0.5137 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.005863/0.7691, allocations: 4.332 MB / 0.6415 GB, free: 169.4 MB / 0.5137 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.375e-05/0.7691, allocations: 7.344 kB / 0.6415 GB, free: 169.4 MB / 0.5137 GB
Notification: Performance of matching and sorting (n=450) (initialization): time 0.007188/0.7763, allocations: 4.599 MB / 0.646 GB, free: 168 MB / 0.5137 GB
Notification: Performance of prepare postOptimizeDAE: time 3.056e-05/0.7763, allocations: 12.81 kB / 0.646 GB, free: 168 MB / 0.5137 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.525e-05/0.7763, allocations: 11.61 kB / 0.646 GB, free: 168 MB / 0.5137 GB
Notification: Performance of postOpt tearingSystem (initialization): time 4.532e-05/0.7764, allocations: 27.47 kB / 0.646 GB, free: 168 MB / 0.5137 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003413/0.7798, allocations: 0.7885 MB / 0.6468 GB, free: 167.9 MB / 0.5137 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 6.146e-05/0.7798, allocations: 37.98 kB / 0.6468 GB, free: 167.9 MB / 0.5137 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002265/0.7821, allocations: 377.1 kB / 0.6472 GB, free: 167.7 MB / 0.5137 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000288/0.7824, allocations: 143.9 kB / 0.6473 GB, free: 167.6 MB / 0.5137 GB
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.001245/0.7836, allocations: 0.76 MB / 0.6481 GB, free: 167.1 MB / 0.5137 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0005548/0.7842, allocations: 221.1 kB / 0.6483 GB, free: 167 MB / 0.5137 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.007406/0.7916, allocations: 5.173 MB / 0.6533 GB, free: 164.3 MB / 0.5137 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.545e-05/0.7916, allocations: 42.06 kB / 0.6534 GB, free: 164.3 MB / 0.5137 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.168e-05/0.7916, allocations: 0 / 0.6534 GB, free: 164.3 MB / 0.5137 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 2.942e-05/0.7917, allocations: 23.86 kB / 0.6534 GB, free: 164.3 MB / 0.5137 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.003497/0.7952, allocations: 2.825 MB / 0.6562 GB, free: 162.5 MB / 0.5137 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 9.628e-06/0.7952, allocations: 0 / 0.6562 GB, free: 162.5 MB / 0.5137 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003042/0.7982, allocations: 0.7289 MB / 0.6569 GB, free: 161.7 MB / 0.5137 GB
Notification: Performance of postOpt tearingSystem (simulation): time 2.021e-05/0.7982, allocations: 17.5 kB / 0.6569 GB, free: 161.7 MB / 0.5137 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001964/0.7984, allocations: 94.98 kB / 0.657 GB, free: 161.6 MB / 0.5137 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.313e-05/0.7984, allocations: 16 kB / 0.657 GB, free: 161.6 MB / 0.5137 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.114e-06/0.7984, allocations: 1.562 kB / 0.657 GB, free: 161.6 MB / 0.5137 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.008009/0.8064, allocations: 7.226 MB / 0.6641 GB, free: 154.3 MB / 0.5137 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003713/0.8068, allocations: 326.9 kB / 0.6644 GB, free: 154 MB / 0.5137 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000301/0.8071, allocations: 87.88 kB / 0.6645 GB, free: 153.9 MB / 0.5137 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002673/0.8098, allocations: 223.6 kB / 0.6647 GB, free: 153.7 MB / 0.5137 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0005088/0.8103, allocations: 310.8 kB / 0.665 GB, free: 153.4 MB / 0.5137 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002979/0.8106, allocations: 179.9 kB / 0.6651 GB, free: 153.2 MB / 0.5137 GB
Notification: Performance of sorting global known variables: time 0.0006206/0.8112, allocations: 0.6785 MB / 0.6658 GB, free: 152.6 MB / 0.5137 GB
Notification: Performance of sort global known variables: time 9e-08/0.8112, allocations: 3.875 kB / 0.6658 GB, free: 152.6 MB / 0.5137 GB
Notification: Performance of remove unused functions: time 0.001975/0.8132, allocations: 1.097 MB / 0.6669 GB, free: 151.5 MB / 0.5137 GB
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.008898/0.8221, allocations: 8.124 MB / 0.6748 GB, free: 143.3 MB / 0.5137 GB
Notification: Performance of simCode: created initialization part: time 0.005323/0.8274, allocations: 4.118 MB / 0.6788 GB, free: 139.2 MB / 0.5137 GB
Notification: Performance of simCode: created event and clocks part: time 8.406e-06/0.8274, allocations: 9 kB / 0.6788 GB, free: 139.2 MB / 0.5137 GB
Notification: Performance of simCode: created simulation system equations: time 0.002456/0.8299, allocations: 2.107 MB / 0.6809 GB, free: 137.1 MB / 0.5137 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.004892/0.8348, allocations: 1.244 MB / 0.6821 GB, free: 135.9 MB / 0.5137 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.02932/0.8641, allocations: 24.66 MB / 0.7062 GB, free: 110.6 MB / 0.5137 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0008933/0.865, allocations: 1.852 MB / 0.708 GB, free: 108.7 MB / 0.5137 GB
Notification: Performance of simCode: alias equations: time 0.003898/0.8689, allocations: 1.764 MB / 0.7097 GB, free: 107 MB / 0.5137 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001358/0.8702, allocations: 0.8936 MB / 0.7106 GB, free: 106.1 MB / 0.5137 GB
Notification: Performance of SimCode: time 1.163e-06/0.8702, allocations: 0 / 0.7106 GB, free: 106.1 MB / 0.5137 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.09813/0.9684, allocations: 83.85 MB / 0.7925 GB, free: 22.42 MB / 0.5137 GB
Notification: Performance of buildModelFMU: Generate platform static: time 13.35/14.32, allocations: 4.062 kB / 0.7925 GB, free: 22.41 MB / 0.5137 GB
"
[Timeout remaining time 646]
(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 & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator -r=Modelica_trunk_Modelica.Media.Examples.PsychrometricData_res.mat --tempDir=temp_Modelica_trunk_Modelica_Media_Examples_PsychrometricData_fmu --startTime=0 --stopTime=1 --stepSize=0.001 --timeout=50 --tolerance=1e-06 Modelica_trunk_Modelica_Media_Examples_PsychrometricData.fmu > Modelica_trunk_Modelica.Media.Examples.PsychrometricData.pipe 2>&1) [Timeout 52.5]
diffSimulationResults("Modelica_trunk_Modelica.Media.Examples.PsychrometricData_res.mat","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/Reference-modelica.org/ReferenceResults/MAP-LIB_ReferenceResults/v4.1.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) [Timeout 660]
""
[Timeout remaining time 660]
Reference file matches
[Calling sys.exit(0), Time elapsed: 17.147934031963814]