Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_latest_IBPSA.Fluid.Interfaces.Examples.PrescribedOutlet_X_wSetOnly.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.0008537/0.0008537, allocations: 76.94 kB / 20.72 MB, free: 3.758 MB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.001421/0.001421, allocations: 169.3 kB / 24.14 MB, free: 348 kB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 1.09/1.09, allocations: 177.1 MB / 204.6 MB, free: 5.477 MB / 186.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA master/package.mo): time 0.6301/0.6301, allocations: 115 MB / 376 MB, free: 7.5 MB / 346.7 MB
"
[Timeout remaining time 179]
Using package IBPSA with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA master/package.mo)
Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo)
Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo)
Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo)
Running command: translateModel(IBPSA.Fluid.Interfaces.Examples.PrescribedOutlet_X_wSetOnly,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Fluid.Interfaces.Examples.PrescribedOutlet_X_wSetOnly")
translateModel(IBPSA.Fluid.Interfaces.Examples.PrescribedOutlet_X_wSetOnly,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Fluid.Interfaces.Examples.PrescribedOutlet_X_wSetOnly") [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 1.704e-06/1.704e-06, allocations: 0 / 428.8 MB, free: 2.711 MB / 394.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.29e-05/2.461e-05, allocations: 2.312 kB / 428.8 MB, free: 2.707 MB / 394.7 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.Interfaces.Examples.PrescribedOutlet_X_wSetOnly): time 0.4009/0.4009, allocations: 153.3 MB / 0.5684 GB, free: 12.24 MB / 0.5105 GB
Notification: Performance of NFInst.instExpressions: time 0.01035/0.4113, allocations: 5.052 MB / 0.5734 GB, free: 7.195 MB / 0.5105 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001865/0.4131, allocations: 91.19 kB / 0.5734 GB, free: 7.105 MB / 0.5105 GB
Notification: Performance of NFTyping.typeComponents: time 0.001385/0.4145, allocations: 0.6289 MB / 0.5741 GB, free: 6.473 MB / 0.5105 GB
Notification: Performance of NFTyping.typeBindings: time 0.003738/0.4183, allocations: 1.783 MB / 0.5758 GB, free: 4.68 MB / 0.5105 GB
Notification: Performance of NFTyping.typeClassSections: time 0.003106/0.4214, allocations: 1.517 MB / 0.5773 GB, free: 3.16 MB / 0.5105 GB
Notification: Performance of NFFlatten.flatten: time 0.005118/0.4265, allocations: 3.889 MB / 0.5811 GB, free: 15.26 MB / 0.5261 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.00183/0.4283, allocations: 1.022 MB / 0.5821 GB, free: 14.2 MB / 0.5261 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.003468/0.4318, allocations: 1.944 MB / 0.584 GB, free: 12.25 MB / 0.5261 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.002227/0.434, allocations: 1.092 MB / 0.585 GB, free: 11.16 MB / 0.5261 GB
Notification: Performance of NFPackage.collectConstants: time 0.0003581/0.4344, allocations: 124 kB / 0.5852 GB, free: 11.04 MB / 0.5261 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.001142/0.4355, allocations: 487.1 kB / 0.5856 GB, free: 10.56 MB / 0.5261 GB
Notification: Performance of NFScalarize.scalarize: time 0.0005066/0.436, allocations: 0.6462 MB / 0.5863 GB, free: 9.91 MB / 0.5261 GB
Notification: Performance of NFVerifyModel.verify: time 0.001205/0.4372, allocations: 0.6585 MB / 0.5869 GB, free: 9.25 MB / 0.5261 GB
Notification: Performance of NFConvertDAE.convert: time 0.002246/0.4395, allocations: 1.715 MB / 0.5886 GB, free: 7.531 MB / 0.5261 GB
Notification: Performance of FrontEnd - DAE generated: time 4.869e-06/0.4395, allocations: 3.938 kB / 0.5886 GB, free: 7.527 MB / 0.5261 GB
Notification: Performance of FrontEnd: time 1.633e-06/0.4395, allocations: 0 / 0.5886 GB, free: 7.527 MB / 0.5261 GB
Notification: Performance of Transformations before backend: time 7.279e-05/0.4395, allocations: 0 / 0.5886 GB, free: 7.527 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: 334
 * Number of variables: 334
Notification: Performance of Generate backend data structure: time 0.003165/0.4427, allocations: 2.262 MB / 0.5908 GB, free: 5.227 MB / 0.5261 GB
Notification: Performance of prepare preOptimizeDAE: time 3.616e-05/0.4427, allocations: 8.031 kB / 0.5908 GB, free: 5.219 MB / 0.5261 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003241/0.446, allocations: 1.122 MB / 0.5919 GB, free: 4.094 MB / 0.5261 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001652/0.4476, allocations: 1.058 MB / 0.5929 GB, free: 2.984 MB / 0.5261 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 6.617e-05/0.4477, allocations: 106.5 kB / 0.593 GB, free: 2.879 MB / 0.5261 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001462/0.4478, allocations: 128 kB / 0.5932 GB, free: 2.754 MB / 0.5261 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001872/0.4497, allocations: 1.329 MB / 0.5944 GB, free: 1.281 MB / 0.5261 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.799e-05/0.4497, allocations: 5.297 kB / 0.5945 GB, free: 1.277 MB / 0.5261 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 8.018e-05/0.4498, allocations: 60 kB / 0.5945 GB, free: 1.219 MB / 0.5261 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.747e-05/0.4499, allocations: 66.23 kB / 0.5946 GB, free: 1.152 MB / 0.5261 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0008584/0.4507, allocations: 0.6131 MB / 0.5952 GB, free: 0.5195 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.005304/0.456, allocations: 5.596 MB / 0.6006 GB, free: 10.73 MB / 0.5417 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.001148/0.4572, allocations: 0.5903 MB / 0.6012 GB, free: 10.14 MB / 0.5417 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0002838/0.4575, allocations: 220.8 kB / 0.6014 GB, free: 9.922 MB / 0.5417 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.000234/0.4577, allocations: 72.88 kB / 0.6015 GB, free: 9.852 MB / 0.5417 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0004603/0.4582, allocations: 392.9 kB / 0.6019 GB, free: 9.453 MB / 0.5417 GB
Notification: Performance of pre-optimization done (n=104): time 3.837e-06/0.4582, allocations: 0 / 0.6019 GB, free: 9.453 MB / 0.5417 GB
Notification: Performance of matching and sorting (n=104): time 0.001249/0.4594, allocations: 0.6739 MB / 0.6025 GB, free: 8.777 MB / 0.5417 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.654e-05/0.4595, allocations: 68.39 kB / 0.6026 GB, free: 8.699 MB / 0.5417 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0008203/0.4603, allocations: 1.144 MB / 0.6037 GB, free: 7.535 MB / 0.5417 GB
Notification: Performance of collectPreVariables (initialization): time 7.52e-05/0.4604, allocations: 49.7 kB / 0.6038 GB, free: 7.48 MB / 0.5417 GB
Notification: Performance of collectInitialEqns (initialization): time 0.000325/0.4607, allocations: 0.6261 MB / 0.6044 GB, free: 6.844 MB / 0.5417 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002445/0.4609, allocations: 368.8 kB / 0.6047 GB, free: 6.48 MB / 0.5417 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0003271/0.4613, allocations: 230.7 kB / 0.6049 GB, free: 6.25 MB / 0.5417 GB
Notification: Performance of setup shared object (initialization): time 0.0001221/0.4614, allocations: 361.8 kB / 0.6053 GB, free: 5.891 MB / 0.5417 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0003317/0.4617, allocations: 145.4 kB / 0.6054 GB, free: 5.746 MB / 0.5417 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.000622/0.4623, allocations: 0.7537 MB / 0.6062 GB, free: 4.777 MB / 0.5417 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0009564/0.4633, allocations: 0.7605 MB / 0.6069 GB, free: 3.859 MB / 0.5417 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 9.779e-06/0.4633, allocations: 4.875 kB / 0.6069 GB, free: 3.855 MB / 0.5417 GB
Notification: Performance of matching and sorting (n=157) (initialization): time 0.001525/0.4648, allocations: 0.7479 MB / 0.6076 GB, free: 3.102 MB / 0.5417 GB
Notification: Performance of prepare postOptimizeDAE: time 2.437e-05/0.4648, allocations: 8 kB / 0.6076 GB, free: 3.094 MB / 0.5417 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.6e-05/0.4649, allocations: 12 kB / 0.6077 GB, free: 3.082 MB / 0.5417 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.777e-05/0.4649, allocations: 16 kB / 0.6077 GB, free: 3.066 MB / 0.5417 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001086/0.466, allocations: 328.1 kB / 0.608 GB, free: 2.746 MB / 0.5417 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.135e-05/0.466, allocations: 23.92 kB / 0.608 GB, free: 2.723 MB / 0.5417 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0008155/0.4668, allocations: 169.2 kB / 0.6082 GB, free: 2.559 MB / 0.5417 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001096/0.4669, allocations: 55.97 kB / 0.6082 GB, free: 2.504 MB / 0.5417 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 49
 * Number of states: 0 ()
 * Number of discrete variables: 15 ($PRE.setHeaHigPow.nextTimeEvent,$whenCondition3,$PRE.setCooLimPow.nextTimeEvent,$whenCondition2,$PRE.setHeaCooUnl.nextTimeEvent,$whenCondition1,setHeaCooUnl.nextTimeEventScaled,$PRE.setHeaCooUnl.nextTimeEventScaled,setHeaCooUnl.nextTimeEvent,setCooLimPow.nextTimeEventScaled,$PRE.setCooLimPow.nextTimeEventScaled,setCooLimPow.nextTimeEvent,setHeaHigPow.nextTimeEventScaled,$PRE.setHeaHigPow.nextTimeEventScaled,setHeaHigPow.nextTimeEvent)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (157):
 * Single equations (assignments): 157
 * 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.0003772/0.4673, allocations: 199.2 kB / 0.6084 GB, free: 2.301 MB / 0.5417 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001977/0.4675, allocations: 127.9 kB / 0.6085 GB, free: 2.176 MB / 0.5417 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001184/0.4687, allocations: 0.695 MB / 0.6092 GB, free: 1.473 MB / 0.5417 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.089e-05/0.4687, allocations: 13.12 kB / 0.6092 GB, free: 1.461 MB / 0.5417 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 2.885e-06/0.4687, allocations: 0 / 0.6092 GB, free: 1.461 MB / 0.5417 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.064e-05/0.4687, allocations: 7.984 kB / 0.6092 GB, free: 1.453 MB / 0.5417 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.00292/0.4716, allocations: 1.758 MB / 0.6109 GB, free: 15.55 MB / 0.5573 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 8.756e-06/0.4716, allocations: 8 kB / 0.611 GB, free: 15.55 MB / 0.5573 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0008713/0.4725, allocations: 227.6 kB / 0.6112 GB, free: 15.32 MB / 0.5573 GB
Notification: Performance of postOpt tearingSystem (simulation): time 1.343e-05/0.4725, allocations: 12 kB / 0.6112 GB, free: 15.31 MB / 0.5573 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 8.475e-05/0.4726, allocations: 37.03 kB / 0.6112 GB, free: 15.28 MB / 0.5573 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.487e-05/0.4726, allocations: 23.92 kB / 0.6112 GB, free: 15.25 MB / 0.5573 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 7.624e-06/0.4726, allocations: 8.781 kB / 0.6113 GB, free: 15.25 MB / 0.5573 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.001587/0.4742, allocations: 1.155 MB / 0.6124 GB, free: 13.95 MB / 0.5573 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0004198/0.4746, allocations: 214.6 kB / 0.6126 GB, free: 13.74 MB / 0.5573 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001746/0.4748, allocations: 39.92 kB / 0.6126 GB, free: 13.7 MB / 0.5573 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0006519/0.4755, allocations: 67.94 kB / 0.6127 GB, free: 13.64 MB / 0.5573 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001634/0.4756, allocations: 98.44 kB / 0.6128 GB, free: 13.54 MB / 0.5573 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 8.529e-05/0.4757, allocations: 35.97 kB / 0.6128 GB, free: 13.51 MB / 0.5573 GB
Notification: Performance of sorting global known variables: time 0.0006053/0.4763, allocations: 0.5787 MB / 0.6134 GB, free: 12.93 MB / 0.5573 GB
Notification: Performance of sort global known variables: time 1.11e-07/0.4763, allocations: 0 / 0.6134 GB, free: 12.93 MB / 0.5573 GB
Notification: Performance of remove unused functions: time 0.001194/0.4775, allocations: 491.1 kB / 0.6139 GB, free: 12.45 MB / 0.5573 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 29
 * Number of states: 3 (heaHigPow.Xi,cooLimPow.Xi,heaCooUnl.Xi)
 * Number of discrete variables: 9 ($whenCondition3,$whenCondition2,$whenCondition1,setHeaHigPow.nextTimeEvent,setHeaHigPow.nextTimeEventScaled,setCooLimPow.nextTimeEvent,setCooLimPow.nextTimeEventScaled,setHeaCooUnl.nextTimeEvent,setHeaCooUnl.nextTimeEventScaled)
 * Number of discrete states: 6 (setHeaHigPow.nextTimeEvent,setCooLimPow.nextTimeEvent,setHeaCooUnl.nextTimeEvent,setHeaCooUnl.nextTimeEventScaled,setCooLimPow.nextTimeEventScaled,setHeaHigPow.nextTimeEventScaled)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (110):
 * Single equations (assignments): 104
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 6
 * 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.001589/0.4791, allocations: 0.5703 MB / 0.6144 GB, free: 12.2 MB / 0.5573 GB
Notification: Performance of simCode: created initialization part: time 0.001445/0.4805, allocations: 0.5975 MB / 0.615 GB, free: 11.6 MB / 0.5573 GB
Notification: Performance of simCode: created event and clocks part: time 3.206e-05/0.4806, allocations: 16.5 kB / 0.615 GB, free: 11.59 MB / 0.5573 GB
Notification: Performance of simCode: created simulation system equations: time 0.0005169/0.4811, allocations: 304.1 kB / 0.6153 GB, free: 11.29 MB / 0.5573 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002286/0.4834, allocations: 0.7014 MB / 0.616 GB, free: 10.63 MB / 0.5573 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.006979/0.4904, allocations: 3.281 MB / 0.6192 GB, free: 7.219 MB / 0.5573 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.000322/0.4907, allocations: 338 kB / 0.6195 GB, free: 6.863 MB / 0.5573 GB
Notification: Performance of simCode: alias equations: time 0.00133/0.492, allocations: 292 kB / 0.6198 GB, free: 6.586 MB / 0.5573 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001384/0.4934, allocations: 0.5068 MB / 0.6203 GB, free: 6.074 MB / 0.5573 GB
Notification: Performance of SimCode: time 1.583e-06/0.4934, allocations: 0 / 0.6203 GB, free: 6.074 MB / 0.5573 GB
Notification: Performance of Templates: time 0.06083/0.5542, allocations: 28.44 MB / 0.6481 GB, free: 10.41 MB / 0.5886 GB
"
[Timeout remaining time 659]
make -j1 -f IBPSA_latest_IBPSA.Fluid.Interfaces.Examples.PrescribedOutlet_X_wSetOnly.makefile [Timeout 660]
(rm -f IBPSA_latest_IBPSA.Fluid.Interfaces.Examples.PrescribedOutlet_X_wSetOnly.pipe ; mkfifo IBPSA_latest_IBPSA.Fluid.Interfaces.Examples.PrescribedOutlet_X_wSetOnly.pipe ; head -c 1048576 < IBPSA_latest_IBPSA.Fluid.Interfaces.Examples.PrescribedOutlet_X_wSetOnly.pipe >> ../files/IBPSA_latest_IBPSA.Fluid.Interfaces.Examples.PrescribedOutlet_X_wSetOnly.sim & ./IBPSA_latest_IBPSA.Fluid.Interfaces.Examples.PrescribedOutlet_X_wSetOnly -abortSlowSimulation -alarm=240 -s gbode -gbm=radauIIA3 -lv LOG_STATS > IBPSA_latest_IBPSA.Fluid.Interfaces.Examples.PrescribedOutlet_X_wSetOnly.pipe 2>&1) [Timeout 240]
[Calling sys.exit(0), Time elapsed: 4.89907307503745]