Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_master_IBPSA.Fluid.Sensors.Examples.PPM.conf.json
Using package ModelicaServices with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo)
Using package Modelica with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo)
Using package IBPSA with version 3.0.0 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/package.mo)
Using package Complex with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo)
Running command: translateModel(IBPSA.Fluid.Sensors.Examples.PPM,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_master_IBPSA.Fluid.Sensors.Examples.PPM")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.001464/0.001463, allocations: 185.8 kB / 15.77 MB, free: 6.375 MB / 13.93 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/package.mo): time 0.7586/0.7586, allocations: 82.94 MB / 99.43 MB, free: 2.227 MB / 74.72 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 2.179/2.179, allocations: 205.4 MB / 325.4 MB, free: 6.551 MB / 266.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.0009996/0.0009994, allocations: 97 kB / 393.6 MB, free: 11.34 MB / 298.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004658/0.000466, allocations: 16 kB / 471.6 MB, free: 13.32 MB / 378.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3868/0.3873, allocations: 67.43 MB / 0.5263 GB, free: 55.61 MB / 410.7 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.Sensors.Examples.PPM): time 0.2472/0.6346, allocations: 177 MB / 0.6992 GB, free: 1.48 MB / 0.5105 GB
Notification: Performance of NFInst.instExpressions: time 0.4054/1.04, allocations: 18.53 MB / 0.7173 GB, free: 4.523 MB / 0.5105 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.00199/1.042, allocations: 43.44 kB / 0.7173 GB, free: 4.523 MB / 0.5105 GB
Notification: Performance of NFTyping.typeComponents: time 0.002961/1.045, allocations: 0.7601 MB / 0.718 GB, free: 4.52 MB / 0.5105 GB
Notification: Performance of NFTyping.typeBindings: time 0.01023/1.055, allocations: 2.897 MB / 0.7209 GB, free: 4.484 MB / 0.5105 GB
Notification: Performance of NFTyping.typeClassSections: time 0.005004/1.06, allocations: 1.205 MB / 0.7221 GB, free: 4.461 MB / 0.5105 GB
Notification: Performance of NFFlatten.flatten: time 0.004566/1.065, allocations: 2.241 MB / 0.7242 GB, free: 4.457 MB / 0.5105 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.002857/1.068, allocations: 1.186 MB / 0.7254 GB, free: 20.28 MB / 0.5261 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.004845/1.073, allocations: 1.665 MB / 0.727 GB, free: 20.27 MB / 0.5261 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.002991/1.076, allocations: 1.118 MB / 0.7281 GB, free: 20.27 MB / 0.5261 GB
Notification: Performance of NFPackage.collectConstants: time 0.0004909/1.076, allocations: 69.97 kB / 0.7282 GB, free: 20.27 MB / 0.5261 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.003529/1.08, allocations: 0.7971 MB / 0.729 GB, free: 20.26 MB / 0.5261 GB
Notification: Performance of NFScalarize.scalarize: time 0.001124/1.081, allocations: 0.5873 MB / 0.7295 GB, free: 20.26 MB / 0.5261 GB
Notification: Performance of NFVerifyModel.verify: time 0.0008794/1.082, allocations: 359.7 kB / 0.7299 GB, free: 20.23 MB / 0.5261 GB
Notification: Performance of NFConvertDAE.convert: time 0.003614/1.086, allocations: 1.93 MB / 0.7318 GB, free: 20.07 MB / 0.5261 GB
Notification: Performance of FrontEnd - DAE generated: time 3.987e-06/1.086, allocations: 0 / 0.7318 GB, free: 20.07 MB / 0.5261 GB
Notification: Performance of FrontEnd: time 2.83e-06/1.086, allocations: 0.9062 kB / 0.7318 GB, free: 20.07 MB / 0.5261 GB
Notification: Performance of Transformations before backend: time 5.764e-05/1.086, allocations: 0 / 0.7318 GB, free: 20.07 MB / 0.5261 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 325
 * Number of variables: 325
Notification: Performance of Generate backend data structure: time 0.003893/1.09, allocations: 1.681 MB / 0.7334 GB, free: 19.14 MB / 0.5261 GB
Notification: Performance of prepare preOptimizeDAE: time 4.138e-05/1.09, allocations: 8.688 kB / 0.7334 GB, free: 19.14 MB / 0.5261 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003017/1.093, allocations: 379.8 kB / 0.7338 GB, free: 19.05 MB / 0.5261 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.003013/1.096, allocations: 1.047 MB / 0.7348 GB, free: 18.71 MB / 0.5261 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.000123/1.096, allocations: 104.1 kB / 0.7349 GB, free: 18.7 MB / 0.5261 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003484/1.096, allocations: 135.8 kB / 0.735 GB, free: 18.7 MB / 0.5261 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003854/1.1, allocations: 1.559 MB / 0.7366 GB, free: 18.49 MB / 0.5261 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.976e-05/1.1, allocations: 0.7188 kB / 0.7366 GB, free: 18.49 MB / 0.5261 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001726/1.1, allocations: 55.28 kB / 0.7366 GB, free: 18.49 MB / 0.5261 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001081/1.101, allocations: 48.58 kB / 0.7367 GB, free: 18.49 MB / 0.5261 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003337/1.104, allocations: 1.286 MB / 0.7379 GB, free: 18.47 MB / 0.5261 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.01162/1.116, allocations: 6.493 MB / 0.7442 GB, free: 15.1 MB / 0.5261 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.001517/1.117, allocations: 0.7793 MB / 0.745 GB, free: 15.06 MB / 0.5261 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0005024/1.118, allocations: 161.6 kB / 0.7452 GB, free: 14.96 MB / 0.5261 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.39e-05/1.118, allocations: 45.34 kB / 0.7452 GB, free: 14.92 MB / 0.5261 GB
Notification: Performance of pre-optimization done (n=73): time 5.507e-06/1.118, allocations: 3.984 kB / 0.7452 GB, free: 14.92 MB / 0.5261 GB
Notification: Performance of matching and sorting (n=73): time 0.003789/1.122, allocations: 1.538 MB / 0.7467 GB, free: 14.5 MB / 0.5261 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.458e-05/1.122, allocations: 62.81 kB / 0.7468 GB, free: 14.44 MB / 0.5261 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.00213/1.124, allocations: 1.248 MB / 0.748 GB, free: 14.12 MB / 0.5261 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001967/1.124, allocations: 48.8 kB / 0.748 GB, free: 14.09 MB / 0.5261 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0005452/1.125, allocations: 0.6939 MB / 0.7487 GB, free: 13.75 MB / 0.5261 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0003113/1.125, allocations: 268 kB / 0.749 GB, free: 13.57 MB / 0.5261 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 6.375e-05/1.125, allocations: 18.22 kB / 0.749 GB, free: 13.57 MB / 0.5261 GB
Notification: Performance of setup shared object (initialization): time 0.0001861/1.125, allocations: 348.2 kB / 0.7493 GB, free: 13.25 MB / 0.5261 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0006953/1.126, allocations: 345.7 kB / 0.7497 GB, free: 13.19 MB / 0.5261 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0009228/1.127, allocations: 0.7139 MB / 0.7503 GB, free: 12.69 MB / 0.5261 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0008916/1.128, allocations: 472.5 kB / 0.7508 GB, free: 12.64 MB / 0.5261 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 9.284e-06/1.128, allocations: 4.938 kB / 0.7508 GB, free: 12.64 MB / 0.5261 GB
Notification: Performance of matching and sorting (n=121) (initialization): time 0.002672/1.13, allocations: 1.246 MB / 0.752 GB, free: 12.36 MB / 0.5261 GB
Notification: Performance of prepare postOptimizeDAE: time 2.787e-05/1.13, allocations: 8.344 kB / 0.752 GB, free: 12.36 MB / 0.5261 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.705e-05/1.13, allocations: 7.844 kB / 0.752 GB, free: 12.36 MB / 0.5261 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0003777/1.131, allocations: 133 kB / 0.7522 GB, free: 12.32 MB / 0.5261 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0009655/1.132, allocations: 195.5 kB / 0.7523 GB, free: 12.3 MB / 0.5261 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.005873/1.138, allocations: 4.887 MB / 0.7571 GB, free: 8.043 MB / 0.5261 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002165/1.14, allocations: 183.1 kB / 0.7573 GB, free: 7.945 MB / 0.5261 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002245/1.14, allocations: 53.48 kB / 0.7573 GB, free: 7.938 MB / 0.5261 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 40
 * 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 (112):
 * Single equations (assignments): 109
 * 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: 3
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 3 {1 3,1 3,1 3}
Notification: Performance of prepare postOptimizeDAE: time 0.001019/1.141, allocations: 424.2 kB / 0.7578 GB, free: 7.773 MB / 0.5261 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0004262/1.142, allocations: 138.8 kB / 0.7579 GB, free: 7.703 MB / 0.5261 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002238/1.144, allocations: 1.054 MB / 0.7589 GB, free: 7.418 MB / 0.5261 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.168e-05/1.144, allocations: 5.656 kB / 0.7589 GB, free: 7.418 MB / 0.5261 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.22e-06/1.144, allocations: 2.969 kB / 0.7589 GB, free: 7.418 MB / 0.5261 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001728/1.146, allocations: 0.9376 MB / 0.7598 GB, free: 7.031 MB / 0.5261 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.006084/1.152, allocations: 2.384 MB / 0.7622 GB, free: 6.105 MB / 0.5261 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.031e-05/1.152, allocations: 1.969 kB / 0.7622 GB, free: 6.105 MB / 0.5261 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0008774/1.153, allocations: 132.9 kB / 0.7623 GB, free: 6.09 MB / 0.5261 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0003707/1.153, allocations: 130 kB / 0.7624 GB, free: 6.039 MB / 0.5261 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 8.481e-05/1.153, allocations: 23.33 kB / 0.7624 GB, free: 6.035 MB / 0.5261 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0059/1.159, allocations: 4.845 MB / 0.7672 GB, free: 1.801 MB / 0.5261 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 6.35e-06/1.159, allocations: 5.656 kB / 0.7672 GB, free: 1.801 MB / 0.5261 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.003145/1.162, allocations: 1.684 MB / 0.7688 GB, free: 1.082 MB / 0.5261 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001071/1.164, allocations: 311 kB / 0.7691 GB, free: 0.8789 MB / 0.5261 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0004006/1.164, allocations: 16.41 kB / 0.7691 GB, free: 0.8789 MB / 0.5261 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001411/1.165, allocations: 70.86 kB / 0.7692 GB, free: 0.8516 MB / 0.5261 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001762/1.166, allocations: 56.8 kB / 0.7693 GB, free: 0.8281 MB / 0.5261 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 8.521e-05/1.166, allocations: 25.77 kB / 0.7693 GB, free: 0.8242 MB / 0.5261 GB
Notification: Performance of sorting global known variables: time 0.001702/1.167, allocations: 0.8731 MB / 0.7701 GB, free: 0.5664 MB / 0.5261 GB
Notification: Performance of sort global known variables: time 8.54e-07/1.167, allocations: 0 / 0.7701 GB, free: 0.5664 MB / 0.5261 GB
Notification: Performance of remove unused functions: time 0.002382/1.17, allocations: 441.7 kB / 0.7706 GB, free: 0.5312 MB / 0.5261 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 11
 * Number of states: 6 (volDyn.dynBal.U,volDyn.dynBal.mXi[1],volDyn.dynBal.mC[1],senPPMTwoPort.C,senPPMNoRev.C,senPPMRev.C)
 * 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 (61):
 * Single equations (assignments): 58
 * 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: 3
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 3 {1 3,1 3,1 3}
Notification: Performance of Backend phase and start with SimCode phase: time 0.0007394/1.171, allocations: 237.7 kB / 0.7708 GB, free: 416 kB / 0.5261 GB
Notification: Performance of simCode: created initialization part: time 0.002456/1.173, allocations: 1.201 MB / 0.772 GB, free: 15.93 MB / 0.5417 GB
Notification: Performance of simCode: created event and clocks part: time 7.685e-06/1.173, allocations: 0 / 0.772 GB, free: 15.93 MB / 0.5417 GB
Notification: Performance of simCode: created simulation system equations: time 0.00125/1.174, allocations: 0.7334 MB / 0.7727 GB, free: 15.53 MB / 0.5417 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.004973/1.179, allocations: 0.8407 MB / 0.7735 GB, free: 15.24 MB / 0.5417 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.006607/1.186, allocations: 3.177 MB / 0.7766 GB, free: 13.41 MB / 0.5417 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001429/1.188, allocations: 1.38 MB / 0.7779 GB, free: 12.43 MB / 0.5417 GB
Notification: Performance of simCode: alias equations: time 0.002098/1.19, allocations: 342.7 kB / 0.7783 GB, free: 12.27 MB / 0.5417 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0004506/1.19, allocations: 112.3 kB / 0.7784 GB, free: 12.26 MB / 0.5417 GB
Notification: Performance of SimCode: time 2.518e-06/1.19, allocations: 0 / 0.7784 GB, free: 12.26 MB / 0.5417 GB
Notification: Performance of Templates: time 0.07036/1.261, allocations: 28.7 MB / 0.8064 GB, free: 2.031 MB / 0.5573 GB