Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_master_IBPSA.Fluid.Examples.Performance.Example1v1.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.Examples.Performance.Example1v1,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_master_IBPSA.Fluid.Examples.Performance.Example1v1")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.002177/0.002176, allocations: 185.8 kB / 15.77 MB, free: 6 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.8027/0.8027, allocations: 82.93 MB / 99.42 MB, free: 3.242 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.057/2.057, allocations: 205.4 MB / 325.4 MB, free: 3.344 MB / 250.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.001088/0.001087, allocations: 98.47 kB / 393.6 MB, free: 15.11 MB / 330.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004561/0.0004565, allocations: 12 kB / 471.5 MB, free: 66.57 MB / 362.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.09159/0.09208, allocations: 67.46 MB / 0.5263 GB, free: 15.07 MB / 378.7 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.Examples.Performance.Example1v1): time 0.09176/0.1839, allocations: 60.57 MB / 0.5855 GB, free: 2.352 MB / 426.7 MB
Notification: Performance of NFInst.instExpressions: time 0.3859/0.5698, allocations: 17.69 MB / 0.6028 GB, free: 16.76 MB / 426.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003178/0.573, allocations: 77.78 kB / 0.6028 GB, free: 16.76 MB / 426.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.00431/0.5774, allocations: 1.126 MB / 0.6039 GB, free: 16.76 MB / 426.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.01029/0.5877, allocations: 2.685 MB / 0.6066 GB, free: 16.73 MB / 426.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.01378/0.6015, allocations: 3.598 MB / 0.6101 GB, free: 16.59 MB / 426.7 MB
Notification: Performance of NFFlatten.flatten: time 0.008628/0.6102, allocations: 4.824 MB / 0.6148 GB, free: 16.57 MB / 426.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.009517/0.6197, allocations: 5.46 MB / 0.6201 GB, free: 16.03 MB / 426.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.006607/0.6264, allocations: 2.501 MB / 0.6226 GB, free: 15.88 MB / 426.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.004135/0.6306, allocations: 1.761 MB / 0.6243 GB, free: 15.41 MB / 426.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0009319/0.6315, allocations: 132.5 kB / 0.6244 GB, free: 15.41 MB / 426.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.005186/0.6367, allocations: 1.179 MB / 0.6256 GB, free: 15.16 MB / 426.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.001315/0.6381, allocations: 0.6216 MB / 0.6262 GB, free: 14.9 MB / 426.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.001789/0.6399, allocations: 0.6868 MB / 0.6268 GB, free: 14.75 MB / 426.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.006064/0.646, allocations: 3.721 MB / 0.6305 GB, free: 12.83 MB / 426.7 MB
Notification: Performance of FrontEnd - DAE generated: time 3.855e-06/0.6461, allocations: 2.281 kB / 0.6305 GB, free: 12.83 MB / 426.7 MB
Notification: Performance of FrontEnd: time 2.404e-06/0.6461, allocations: 0 / 0.6305 GB, free: 12.83 MB / 426.7 MB
Notification: Performance of Transformations before backend: time 0.0001144/0.6462, allocations: 0 / 0.6305 GB, free: 12.83 MB / 426.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 414
 * Number of variables: 414
Notification: Performance of Generate backend data structure: time 0.009111/0.6553, allocations: 4.011 MB / 0.6344 GB, free: 10.37 MB / 426.7 MB
Notification: Performance of prepare preOptimizeDAE: time 3.716e-05/0.6554, allocations: 9.344 kB / 0.6344 GB, free: 10.37 MB / 426.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002908/0.6583, allocations: 0.5875 MB / 0.635 GB, free: 10.09 MB / 426.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.006153/0.6645, allocations: 2.55 MB / 0.6375 GB, free: 8.969 MB / 426.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001689/0.6647, allocations: 148.4 kB / 0.6376 GB, free: 8.961 MB / 426.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0005815/0.6653, allocations: 195.8 kB / 0.6378 GB, free: 8.961 MB / 426.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.005825/0.6711, allocations: 2.517 MB / 0.6402 GB, free: 7.289 MB / 426.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 5.301e-05/0.6712, allocations: 7.281 kB / 0.6403 GB, free: 7.285 MB / 426.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002872/0.6715, allocations: 68.22 kB / 0.6403 GB, free: 7.234 MB / 426.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.797e-05/0.6716, allocations: 49.41 kB / 0.6404 GB, free: 7.23 MB / 426.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.005456/0.677, allocations: 2.075 MB / 0.6424 GB, free: 6.156 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.02074/0.6978, allocations: 12.41 MB / 0.6545 GB, free: 10.51 MB / 442.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.004811/0.7027, allocations: 1.65 MB / 0.6561 GB, free: 8.852 MB / 442.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.01088/0.7136, allocations: 4.281 MB / 0.6603 GB, free: 4.363 MB / 442.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.002493/0.7161, allocations: 0.9106 MB / 0.6612 GB, free: 3.449 MB / 442.7 MB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.002312/0.7184, allocations: 470.3 kB / 0.6616 GB, free: 2.988 MB / 442.7 MB
Notification: Performance of pre-optimization done (n=104): time 5.419e-06/0.7185, allocations: 0 / 0.6616 GB, free: 2.988 MB / 442.7 MB
Notification: Performance of matching and sorting (n=104): time 0.0308/0.7493, allocations: 5.293 MB / 0.6668 GB, free: 13.66 MB / 458.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001641/0.7495, allocations: 222.6 kB / 0.667 GB, free: 13.39 MB / 458.7 MB
[/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/Fluid/Actuators/BaseClasses/ValveParameters.mo:29:3-35:70:writable] Warning: Parameter val.res3.dpValve_nominal has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/Fluid/Interfaces/PartialTwoPortInterface.mo:8:3-10:52:writable] Warning: Parameter val.res3.m_flow_nominal has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/Fluid/Actuators/BaseClasses/ValveParameters.mo:29:3-35:70:writable] Warning: Parameter val.res1.dpValve_nominal has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/Fluid/Interfaces/PartialTwoPortInterface.mo:8:3-10:52:writable] Warning: Parameter val.res1.m_flow_nominal has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.00671/0.7562, allocations: 3.135 MB / 0.6701 GB, free: 10.26 MB / 458.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0003408/0.7566, allocations: 61.7 kB / 0.6701 GB, free: 10.19 MB / 458.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.001907/0.7585, allocations: 1.486 MB / 0.6716 GB, free: 8.707 MB / 458.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0005351/0.759, allocations: 371.5 kB / 0.672 GB, free: 8.348 MB / 458.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001385/0.7592, allocations: 32 kB / 0.672 GB, free: 8.316 MB / 458.7 MB
Notification: Performance of setup shared object (initialization): time 0.0002502/0.7595, allocations: 369.9 kB / 0.6723 GB, free: 7.949 MB / 458.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002201/0.7617, allocations: 0.7573 MB / 0.6731 GB, free: 7.191 MB / 458.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003132/0.7648, allocations: 1.603 MB / 0.6746 GB, free: 5.23 MB / 458.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.003044/0.7679, allocations: 0.9879 MB / 0.6756 GB, free: 4.25 MB / 458.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.463e-05/0.7679, allocations: 4 kB / 0.6756 GB, free: 4.246 MB / 458.7 MB
Notification: Performance of matching and sorting (n=201) (initialization): time 0.0101/0.778, allocations: 3.146 MB / 0.6787 GB, free: 1.094 MB / 458.7 MB
Notification: Performance of prepare postOptimizeDAE: time 0.003484/0.7816, allocations: 6.214 MB / 0.6847 GB, free: 10.34 MB / 474.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.05e-05/0.7817, allocations: 19.95 kB / 0.6848 GB, free: 10.32 MB / 474.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.004099/0.7858, allocations: 0.7801 MB / 0.6855 GB, free: 9.547 MB / 474.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001972/0.7878, allocations: 337.3 kB / 0.6859 GB, free: 9.211 MB / 474.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.00355/0.7914, allocations: 2.173 MB / 0.688 GB, free: 6.984 MB / 474.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003642/0.795, allocations: 263.5 kB / 0.6882 GB, free: 6.73 MB / 474.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003125/0.7954, allocations: 79.97 kB / 0.6883 GB, free: 6.652 MB / 474.7 MB
Notification: Performance of prepare postOptimizeDAE: time 1.256e-05/0.7954, allocations: 8 kB / 0.6883 GB, free: 6.645 MB / 474.7 MB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.006709/0.8021, allocations: 2.478 MB / 0.6907 GB, free: 4.152 MB / 474.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.828e-05/0.8022, allocations: 16 kB / 0.6907 GB, free: 4.137 MB / 474.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002237/0.8045, allocations: 0.5865 MB / 0.6913 GB, free: 3.547 MB / 474.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001738/0.8062, allocations: 317.4 kB / 0.6916 GB, free: 3.238 MB / 474.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01244/0.8187, allocations: 6.611 MB / 0.6981 GB, free: 12.35 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003341/0.8221, allocations: 236.9 kB / 0.6983 GB, free: 12.12 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002396/0.8223, allocations: 80.22 kB / 0.6984 GB, free: 12.04 MB / 490.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 63
 * Number of states: 0 ()
 * Number of discrete variables: 8 ($whenCondition1,$PRE.pulse.T_start,pulse.T_start,$PRE.pulse.count,pulse.count,from_dp.y,nRes.y,allowFlowReversal.y)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (149):
 * Single equations (assignments): 141
 * Array equations: 3
 * Algorithm blocks: 1
 * Record equations: 2
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 2 {1 40,1 6}
Notification: Performance of prepare postOptimizeDAE: time 0.002182/0.8245, allocations: 0.8647 MB / 0.6992 GB, free: 11.16 MB / 490.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0007444/0.8253, allocations: 308.1 kB / 0.6995 GB, free: 10.86 MB / 490.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.007081/0.8324, allocations: 2.594 MB / 0.702 GB, free: 8.262 MB / 490.7 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.668e-05/0.8324, allocations: 15.98 kB / 0.7021 GB, free: 8.246 MB / 490.7 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 5.041e-06/0.8324, allocations: 4 kB / 0.7021 GB, free: 8.242 MB / 490.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.005614/0.8381, allocations: 2.257 MB / 0.7043 GB, free: 5.926 MB / 490.7 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.012/0.8501, allocations: 4.884 MB / 0.709 GB, free: 1.004 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.053e-05/0.8501, allocations: 0 / 0.709 GB, free: 1.004 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001282/0.8514, allocations: 161.7 kB / 0.7092 GB, free: 0.8398 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (simulation): time 0.001925/0.8534, allocations: 0.5438 MB / 0.7097 GB, free: 304 kB / 490.7 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001848/0.8536, allocations: 35.97 kB / 0.7098 GB, free: 268 kB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.003113/0.8567, allocations: 2.091 MB / 0.7118 GB, free: 14.12 MB / 0.4948 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.539e-06/0.8567, allocations: 0 / 0.7118 GB, free: 14.12 MB / 0.4948 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.009232/0.866, allocations: 3.506 MB / 0.7152 GB, free: 10.58 MB / 0.4948 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001863/0.8679, allocations: 0.5829 MB / 0.7158 GB, free: 9.977 MB / 0.4948 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0004747/0.8684, allocations: 24 kB / 0.7158 GB, free: 9.953 MB / 0.4948 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002358/0.8707, allocations: 203.5 kB / 0.716 GB, free: 9.754 MB / 0.4948 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002306/0.871, allocations: 84.78 kB / 0.7161 GB, free: 9.672 MB / 0.4948 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.000154/0.8712, allocations: 50.45 kB / 0.7161 GB, free: 9.625 MB / 0.4948 GB
Notification: Performance of sorting global known variables: time 0.004654/0.8758, allocations: 2.138 MB / 0.7182 GB, free: 7.5 MB / 0.4948 GB
Notification: Performance of sort global known variables: time 9.5e-07/0.8759, allocations: 0 / 0.7182 GB, free: 7.5 MB / 0.4948 GB
Notification: Performance of remove unused functions: time 0.005728/0.8816, allocations: 1.573 MB / 0.7198 GB, free: 5.926 MB / 0.4948 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 3
 * Number of states: 6 (pump.vol.dynBal.U,hea.outCon.T,val.res1.filter.x[1],val.res1.filter.x[2],val.res3.filter.x[1],val.res3.filter.x[2])
 * Number of discrete variables: 3 ($whenCondition1,pulse.T_start,pulse.count)
 * Number of discrete states: 1 (pulse.count)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (66):
 * Single equations (assignments): 58
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 4
 * When equations: 2
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 2 {1 6,1 40}
Notification: Performance of Backend phase and start with SimCode phase: time 0.001398/0.883, allocations: 488.4 kB / 0.7202 GB, free: 5.48 MB / 0.4948 GB
Notification: Performance of simCode: created initialization part: time 0.00905/0.8921, allocations: 3.568 MB / 0.7237 GB, free: 1.848 MB / 0.4948 GB
Notification: Performance of simCode: created event and clocks part: time 9.507e-06/0.8921, allocations: 4.375 kB / 0.7237 GB, free: 1.844 MB / 0.4948 GB
Notification: Performance of simCode: created simulation system equations: time 0.002472/0.8946, allocations: 0.8539 MB / 0.7246 GB, free: 0.9922 MB / 0.4948 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.009153/0.9038, allocations: 1.58 MB / 0.7261 GB, free: 15.41 MB / 0.5105 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01338/0.9172, allocations: 6.288 MB / 0.7322 GB, free: 9.105 MB / 0.5105 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.002605/0.9198, allocations: 2.17 MB / 0.7344 GB, free: 6.91 MB / 0.5105 GB
Notification: Performance of simCode: alias equations: time 0.004095/0.924, allocations: 0.7 MB / 0.735 GB, free: 6.203 MB / 0.5105 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0009263/0.9249, allocations: 219.4 kB / 0.7353 GB, free: 5.988 MB / 0.5105 GB
Notification: Performance of SimCode: time 1.526e-06/0.9249, allocations: 0 / 0.7353 GB, free: 5.988 MB / 0.5105 GB
Notification: Performance of Templates: time 0.144/1.069, allocations: 60.45 MB / 0.7943 GB, free: 9.996 MB / 0.573 GB