Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_9_Buildings.Fluid.Sensors.Examples.PPM.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.1.3-maint.9.1.x/package.mo", uses=false)
Using package Buildings with version 9.1.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.1.3-maint.9.1.x/package.mo)
Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo)
Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Running command: translateModel(Buildings.Fluid.Sensors.Examples.PPM,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|senPPMTwoPort.ppm|senPPMNoRev.ppm|senPPMVol.ppm|senPPMRev.ppm|senPPMSta.ppm|senPPMIn.ppm|senPPMVol2.ppm",fileNamePrefix="Buildings_9_Buildings.Fluid.Sensors.Examples.PPM")
translateModel(Buildings.Fluid.Sensors.Examples.PPM,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|senPPMTwoPort.ppm|senPPMNoRev.ppm|senPPMVol.ppm|senPPMRev.ppm|senPPMSta.ppm|senPPMIn.ppm|senPPMVol2.ppm",fileNamePrefix="Buildings_9_Buildings.Fluid.Sensors.Examples.PPM")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001286/0.001287, allocations: 110.4 kB / 16.42 MB, free: 6.512 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001291/0.001291, allocations: 185.5 kB / 17.35 MB, free: 5.738 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.314/1.314, allocations: 222.9 MB / 241 MB, free: 15.17 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.1.3-maint.9.1.x/package.mo): time 2.2/2.2, allocations: 390.3 MB / 0.6655 GB, free: 0.6406 MB / 0.5294 GB
Notification: Performance of FrontEnd - loaded program: time 0.001267/0.001267, allocations: 67.91 kB / 0.9516 GB, free: 7.637 MB / 0.7325 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.7018/0.7031, allocations: 140.4 MB / 1.089 GB, free: 5.527 MB / 0.8575 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Sensors.Examples.PPM): time 0.2344/0.9376, allocations: 220.8 MB / 1.304 GB, free: 0.7266 MB / 1.029 GB
Notification: Performance of NFInst.instExpressions: time 0.0272/0.9648, allocations: 22.32 MB / 1.326 GB, free: 10.34 MB / 1.061 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001888/0.9667, allocations: 55.69 kB / 1.326 GB, free: 10.29 MB / 1.061 GB
Notification: Performance of NFTyping.typeComponents: time 0.002367/0.9691, allocations: 0.8347 MB / 1.327 GB, free: 9.449 MB / 1.061 GB
Notification: Performance of NFTyping.typeBindings: time 0.01053/0.9797, allocations: 4.559 MB / 1.331 GB, free: 4.871 MB / 1.061 GB
Notification: Performance of NFTyping.typeClassSections: time 0.003382/0.9831, allocations: 1.246 MB / 1.333 GB, free: 3.633 MB / 1.061 GB
Notification: Performance of NFFlatten.flatten: time 0.005218/0.9884, allocations: 4.14 MB / 1.337 GB, free: 15.48 MB / 1.076 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.002633/0.991, allocations: 1.621 MB / 1.338 GB, free: 13.82 MB / 1.076 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.003766/0.9948, allocations: 1.892 MB / 1.34 GB, free: 11.93 MB / 1.076 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.003249/0.998, allocations: 1.632 MB / 1.342 GB, free: 10.29 MB / 1.076 GB
Notification: Performance of NFPackage.collectConstants: time 0.0004983/0.9986, allocations: 168 kB / 1.342 GB, free: 10.13 MB / 1.076 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.004453/1.003, allocations: 2.179 MB / 1.344 GB, free: 7.945 MB / 1.076 GB
Notification: Performance of NFScalarize.scalarize: time 0.00107/1.004, allocations: 0.7714 MB / 1.345 GB, free: 7.172 MB / 1.076 GB
Notification: Performance of NFVerifyModel.verify: time 0.001814/1.006, allocations: 0.9994 MB / 1.346 GB, free: 6.168 MB / 1.076 GB
Notification: Performance of NFConvertDAE.convert: time 0.004935/1.011, allocations: 3.143 MB / 1.349 GB, free: 3.016 MB / 1.076 GB
Notification: Performance of FrontEnd - DAE generated: time 5.04e-06/1.011, allocations: 0 / 1.349 GB, free: 3.016 MB / 1.076 GB
Notification: Performance of FrontEnd: time 1.362e-06/1.011, allocations: 0 / 1.349 GB, free: 3.016 MB / 1.076 GB
Notification: Performance of Transformations before backend: time 7.721e-05/1.011, allocations: 4 kB / 1.349 GB, free: 3.012 MB / 1.076 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 337
 * Number of variables: 337
Notification: Performance of Generate backend data structure: time 0.004095/1.015, allocations: 2.159 MB / 1.351 GB, free: 0.7969 MB / 1.076 GB
Notification: Performance of prepare preOptimizeDAE: time 4.125e-05/1.015, allocations: 8.031 kB / 1.351 GB, free: 0.7891 MB / 1.076 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002434/1.018, allocations: 421.3 kB / 1.351 GB, free: 384 kB / 1.076 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002445/1.02, allocations: 1.199 MB / 1.352 GB, free: 15.12 MB / 1.092 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 8.202e-05/1.02, allocations: 106.7 kB / 1.353 GB, free: 15.01 MB / 1.092 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002325/1.02, allocations: 143.9 kB / 1.353 GB, free: 14.87 MB / 1.092 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002697/1.023, allocations: 1.639 MB / 1.354 GB, free: 13.16 MB / 1.092 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.914e-05/1.023, allocations: 0 / 1.354 GB, free: 13.16 MB / 1.092 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001302/1.023, allocations: 64 kB / 1.354 GB, free: 13.1 MB / 1.092 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.487e-05/1.023, allocations: 46.55 kB / 1.354 GB, free: 13.05 MB / 1.092 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.00218/1.025, allocations: 1.329 MB / 1.356 GB, free: 11.71 MB / 1.092 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.00843/1.034, allocations: 7.162 MB / 1.363 GB, free: 3.992 MB / 1.092 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.001433/1.035, allocations: 0.9247 MB / 1.364 GB, free: 3.059 MB / 1.092 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0006519/1.036, allocations: 476.8 kB / 1.364 GB, free: 2.59 MB / 1.092 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0007051/1.037, allocations: 413.3 kB / 1.364 GB, free: 2.113 MB / 1.092 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.809e-05/1.037, allocations: 43.56 kB / 1.365 GB, free: 2.062 MB / 1.092 GB
Notification: Performance of pre-optimization done (n=83): time 2.845e-06/1.037, allocations: 0 / 1.365 GB, free: 2.062 MB / 1.092 GB
Notification: Performance of matching and sorting (n=83): time 0.003027/1.04, allocations: 1.649 MB / 1.366 GB, free: 352 kB / 1.092 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.104e-05/1.04, allocations: 60.41 kB / 1.366 GB, free: 280 kB / 1.092 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001549/1.041, allocations: 1.19 MB / 1.367 GB, free: 15.06 MB / 1.107 GB
Notification: Performance of collectPreVariables (initialization): time 8.889e-05/1.042, allocations: 49.7 kB / 1.367 GB, free: 15.01 MB / 1.107 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0005329/1.042, allocations: 0.7148 MB / 1.368 GB, free: 14.29 MB / 1.107 GB
Notification: Performance of collectInitialBindings (initialization): time 0.000267/1.042, allocations: 299.6 kB / 1.368 GB, free: 13.99 MB / 1.107 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002893/1.043, allocations: 190.6 kB / 1.369 GB, free: 13.8 MB / 1.107 GB
Notification: Performance of setup shared object (initialization): time 0.0001301/1.043, allocations: 353.9 kB / 1.369 GB, free: 13.45 MB / 1.107 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0005848/1.043, allocations: 376.6 kB / 1.369 GB, free: 13.08 MB / 1.107 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0008963/1.044, allocations: 0.7208 MB / 1.37 GB, free: 12.21 MB / 1.107 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001442/1.046, allocations: 1.073 MB / 1.371 GB, free: 11.02 MB / 1.107 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.941e-06/1.046, allocations: 0 / 1.371 GB, free: 11.02 MB / 1.107 GB
Notification: Performance of matching and sorting (n=125) (initialization): time 0.002056/1.048, allocations: 1.277 MB / 1.372 GB, free: 9.73 MB / 1.107 GB
Notification: Performance of prepare postOptimizeDAE: time 2.219e-05/1.048, allocations: 16.2 kB / 1.372 GB, free: 9.715 MB / 1.107 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.331e-05/1.048, allocations: 12 kB / 1.372 GB, free: 9.703 MB / 1.107 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0003128/1.048, allocations: 126.5 kB / 1.372 GB, free: 9.57 MB / 1.107 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0009667/1.049, allocations: 223.6 kB / 1.373 GB, free: 9.352 MB / 1.107 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.00482/1.054, allocations: 5.974 MB / 1.378 GB, free: 2.938 MB / 1.107 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001231/1.055, allocations: 134.8 kB / 1.379 GB, free: 2.805 MB / 1.107 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.544e-05/1.055, allocations: 47.94 kB / 1.379 GB, free: 2.758 MB / 1.107 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001075/1.056, allocations: 0.7087 MB / 1.379 GB, free: 2.043 MB / 1.107 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0008216/1.057, allocations: 0.7169 MB / 1.38 GB, free: 1.18 MB / 1.107 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001437/1.059, allocations: 1.068 MB / 1.381 GB, free: 15.99 MB / 1.123 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 4.348e-06/1.059, allocations: 0 / 1.381 GB, free: 15.99 MB / 1.123 GB
Notification: Performance of matching and sorting (n=125) (initialization_lambda0): time 0.002038/1.061, allocations: 1.285 MB / 1.382 GB, free: 14.7 MB / 1.123 GB
Notification: Performance of prepare postOptimizeDAE: time 1.512e-05/1.061, allocations: 8 kB / 1.382 GB, free: 14.69 MB / 1.123 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.348e-06/1.061, allocations: 11.94 kB / 1.382 GB, free: 14.68 MB / 1.123 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0002542/1.061, allocations: 130.5 kB / 1.382 GB, free: 14.54 MB / 1.123 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0008032/1.062, allocations: 211.7 kB / 1.383 GB, free: 14.33 MB / 1.123 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.00433/1.066, allocations: 5.377 MB / 1.388 GB, free: 8.539 MB / 1.123 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001349/1.068, allocations: 111.2 kB / 1.388 GB, free: 8.43 MB / 1.123 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001003/1.068, allocations: 47.98 kB / 1.388 GB, free: 8.383 MB / 1.123 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 37
 * 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 (116):
 * Single equations (assignments): 112
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 1
 * Torn equation systems: 3
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 0 systems
 * Non-linear Jacobian (size): 1 system
   {1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 3 systems
   {(1,3), (1,3), (1,3)}
Notification: Performance of prepare postOptimizeDAE: time 0.0003015/1.068, allocations: 247.9 kB / 1.388 GB, free: 8.133 MB / 1.123 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002957/1.068, allocations: 138.3 kB / 1.388 GB, free: 7.996 MB / 1.123 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001831/1.07, allocations: 1.077 MB / 1.389 GB, free: 6.898 MB / 1.123 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001356/1.072, allocations: 1.031 MB / 1.39 GB, free: 5.805 MB / 1.123 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.326e-06/1.072, allocations: 0 / 1.39 GB, free: 5.805 MB / 1.123 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0006473/1.072, allocations: 319.1 kB / 1.391 GB, free: 5.473 MB / 1.123 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002142/1.072, allocations: 19.98 kB / 1.391 GB, free: 5.453 MB / 1.123 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0007886/1.073, allocations: 23.89 kB / 1.391 GB, free: 5.43 MB / 1.123 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001031/1.073, allocations: 52.88 kB / 1.391 GB, free: 5.379 MB / 1.123 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.002407/1.076, allocations: 1.161 MB / 1.392 GB, free: 4.199 MB / 1.123 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.002061/1.078, allocations: 1.564 MB / 1.394 GB, free: 2.621 MB / 1.123 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0005435/1.078, allocations: 407.7 kB / 1.394 GB, free: 2.223 MB / 1.123 GB
Notification: Performance of sorting global known variables: time 0.001182/1.08, allocations: 0.8182 MB / 1.395 GB, free: 1.402 MB / 1.123 GB
Notification: Performance of Backend: time 4.01e-07/1.08, allocations: 0 / 1.395 GB, free: 1.402 MB / 1.123 GB
Notification: Performance of simCode: created initialization part: time 0.004565/1.084, allocations: 2.421 MB / 1.397 GB, free: 14.91 MB / 1.139 GB
Notification: Performance of SimCode: time 0.006468/1.091, allocations: 3.795 MB / 1.401 GB, free: 11.08 MB / 1.139 GB
Notification: Performance of Templates: time 0.05824/1.149, allocations: 37.74 MB / 1.438 GB, free: 5.734 MB / 1.17 GB
make -j1 -f Buildings_9_Buildings.Fluid.Sensors.Examples.PPM.makefile
(rm -f Buildings_9_Buildings.Fluid.Sensors.Examples.PPM.pipe ; mkfifo Buildings_9_Buildings.Fluid.Sensors.Examples.PPM.pipe ; head -c 1048576 < Buildings_9_Buildings.Fluid.Sensors.Examples.PPM.pipe >> ../files/Buildings_9_Buildings.Fluid.Sensors.Examples.PPM.sim & ./Buildings_9_Buildings.Fluid.Sensors.Examples.PPM  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_9_Buildings.Fluid.Sensors.Examples.PPM.pipe 2>&1)
diffSimulationResults("Buildings_9_Buildings.Fluid.Sensors.Examples.PPM_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_9.1.x/Buildings_Fluid_Sensors_Examples_PPM.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_9_Buildings.Fluid.Sensors.Examples.PPM.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches