Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.PrescribedOutlet.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.002348/0.002348, allocations: 89.48 kB / 19.44 MB, free: 324 kB / 13.93 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.002764/0.002764, allocations: 169.2 kB / 22.76 MB, free: 1.652 MB / 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.639/1.639, allocations: 177.1 MB / 203.1 MB, free: 5.621 MB / 186.7 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS master/package.mo", uses=false) [Timeout 180]
"[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS master/Examples/PPD12/Structure.mo:531:21-535:34:writable] Warning: Lexer treating \\ as \\\\, since \\e is not a valid Modelica escape sequence.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS master/Examples/PPD12/Structure.mo:531:21-535:42:writable] Warning: Lexer treating \\ as \\\\, since \\< is not a valid Modelica escape sequence.
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS master/package.mo): time 1.317/1.317, allocations: 154.8 MB / 414.4 MB, free: 464 kB / 378.7 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS master/Utilities/Cryptographics/BaseClasses/sha.mo:2:1-19:8:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS master/Utilities/File/sha2.mo:2:1-9:9:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 178]
Using package IDEAS with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 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(IDEAS.Fluid.Interfaces.Examples.PrescribedOutlet,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.PrescribedOutlet")
translateModel(IDEAS.Fluid.Interfaces.Examples.PrescribedOutlet,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.PrescribedOutlet") [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 1.342e-06/1.342e-06, allocations: 0 / 0.5199 GB, free: 2.238 MB / 490.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.537e-05/2.671e-05, allocations: 3.156 kB / 0.5199 GB, free: 2.234 MB / 490.7 MB
Notification: Performance of NFInst.instantiate(IDEAS.Fluid.Interfaces.Examples.PrescribedOutlet): time 0.5857/0.5858, allocations: 240.5 MB / 0.7547 GB, free: 46.41 MB / 0.6355 GB
Notification: Performance of NFInst.instExpressions: time 0.01283/0.5986, allocations: 8.705 MB / 0.7632 GB, free: 46.21 MB / 0.6355 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002332/0.6009, allocations: 97.06 kB / 0.7633 GB, free: 46.21 MB / 0.6355 GB
Notification: Performance of NFTyping.typeComponents: time 0.002341/0.6033, allocations: 1.064 MB / 0.7644 GB, free: 46.12 MB / 0.6355 GB
Notification: Performance of NFTyping.typeBindings: time 0.007441/0.6107, allocations: 3.305 MB / 0.7676 GB, free: 45.51 MB / 0.6355 GB
Notification: Performance of NFTyping.typeClassSections: time 0.00807/0.6188, allocations: 3.693 MB / 0.7712 GB, free: 44.36 MB / 0.6355 GB
Notification: Performance of NFFlatten.flatten: time 0.00502/0.6238, allocations: 4.084 MB / 0.7752 GB, free: 42.61 MB / 0.6355 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.00192/0.6257, allocations: 1.177 MB / 0.7764 GB, free: 41.95 MB / 0.6355 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.005465/0.6312, allocations: 2.867 MB / 0.7792 GB, free: 40.99 MB / 0.6355 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.002457/0.6337, allocations: 1.278 MB / 0.7804 GB, free: 40.73 MB / 0.6355 GB
Notification: Performance of NFPackage.collectConstants: time 0.0003614/0.634, allocations: 137 kB / 0.7805 GB, free: 40.73 MB / 0.6355 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.00657/0.6406, allocations: 3.237 MB / 0.7837 GB, free: 39.99 MB / 0.6355 GB
Notification: Performance of NFScalarize.scalarize: time 0.000874/0.6415, allocations: 0.6682 MB / 0.7843 GB, free: 39.69 MB / 0.6355 GB
Notification: Performance of NFVerifyModel.verify: time 0.00123/0.6427, allocations: 0.6828 MB / 0.785 GB, free: 39.46 MB / 0.6355 GB
Notification: Performance of NFConvertDAE.convert: time 0.00809/0.6508, allocations: 3.932 MB / 0.7888 GB, free: 38.45 MB / 0.6355 GB
Notification: Performance of FrontEnd - DAE generated: time 5.4e-06/0.6508, allocations: 0 / 0.7888 GB, free: 38.45 MB / 0.6355 GB
Notification: Performance of FrontEnd: time 1.333e-06/0.6508, allocations: 3 kB / 0.7889 GB, free: 38.45 MB / 0.6355 GB
Notification: Performance of Transformations before backend: time 4.79e-05/0.6508, allocations: 0 / 0.7889 GB, free: 38.45 MB / 0.6355 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 338
 * Number of variables: 338
Notification: Performance of Generate backend data structure: time 0.005511/0.6563, allocations: 2.79 MB / 0.7916 GB, free: 36.72 MB / 0.6355 GB
Notification: Performance of prepare preOptimizeDAE: time 3.538e-05/0.6564, allocations: 9.656 kB / 0.7916 GB, free: 36.72 MB / 0.6355 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.007789/0.6642, allocations: 1.423 MB / 0.793 GB, free: 36.36 MB / 0.6355 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002307/0.6665, allocations: 1.223 MB / 0.7942 GB, free: 35.77 MB / 0.6355 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 6.556e-05/0.6665, allocations: 103 kB / 0.7943 GB, free: 35.72 MB / 0.6355 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002075/0.6668, allocations: 136.9 kB / 0.7944 GB, free: 35.68 MB / 0.6355 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003188/0.6699, allocations: 1.81 MB / 0.7962 GB, free: 34.89 MB / 0.6355 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.329e-05/0.67, allocations: 6.125 kB / 0.7962 GB, free: 34.89 MB / 0.6355 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001456/0.6701, allocations: 59.02 kB / 0.7962 GB, free: 34.86 MB / 0.6355 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.656e-05/0.6702, allocations: 62.19 kB / 0.7963 GB, free: 34.85 MB / 0.6355 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003711/0.6739, allocations: 1.552 MB / 0.7978 GB, free: 34.48 MB / 0.6355 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.008976/0.6829, allocations: 7.248 MB / 0.8049 GB, free: 29.53 MB / 0.6355 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.003141/0.686, allocations: 1.243 MB / 0.8061 GB, free: 29.16 MB / 0.6355 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001552/0.6876, allocations: 0.633 MB / 0.8067 GB, free: 29.01 MB / 0.6355 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0009032/0.6885, allocations: 202.8 kB / 0.8069 GB, free: 28.98 MB / 0.6355 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001826/0.6903, allocations: 0.7989 MB / 0.8077 GB, free: 28.75 MB / 0.6355 GB
Notification: Performance of pre-optimization done (n=119): time 3.727e-06/0.6903, allocations: 0 / 0.8077 GB, free: 28.75 MB / 0.6355 GB
Notification: Performance of matching and sorting (n=119): time 0.005945/0.6962, allocations: 2.075 MB / 0.8097 GB, free: 28.18 MB / 0.6355 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.536e-05/0.6963, allocations: 65.97 kB / 0.8098 GB, free: 28.11 MB / 0.6355 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001512/0.6978, allocations: 1.459 MB / 0.8112 GB, free: 27.48 MB / 0.6355 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001082/0.6979, allocations: 48.64 kB / 0.8112 GB, free: 27.43 MB / 0.6355 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0005289/0.6984, allocations: 0.948 MB / 0.8122 GB, free: 26.68 MB / 0.6355 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0003189/0.6987, allocations: 453.2 kB / 0.8126 GB, free: 26.34 MB / 0.6355 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.000433/0.6992, allocations: 262.9 kB / 0.8129 GB, free: 26.22 MB / 0.6355 GB
Notification: Performance of setup shared object (initialization): time 0.0001123/0.6993, allocations: 0.5487 MB / 0.8134 GB, free: 25.7 MB / 0.6355 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001534/0.7008, allocations: 0.5447 MB / 0.8139 GB, free: 25.58 MB / 0.6355 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001819/0.7026, allocations: 1.21 MB / 0.8151 GB, free: 24.68 MB / 0.6355 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.00323/0.7059, allocations: 1.465 MB / 0.8165 GB, free: 23.9 MB / 0.6355 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.852e-06/0.7059, allocations: 9.312 kB / 0.8165 GB, free: 23.9 MB / 0.6355 GB
Notification: Performance of matching and sorting (n=161) (initialization): time 0.004119/0.71, allocations: 1.669 MB / 0.8182 GB, free: 23.41 MB / 0.6355 GB
Notification: Performance of prepare postOptimizeDAE: time 2.028e-05/0.71, allocations: 8.375 kB / 0.8182 GB, free: 23.41 MB / 0.6355 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.364e-05/0.71, allocations: 8.812 kB / 0.8182 GB, free: 23.41 MB / 0.6355 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.922e-05/0.7101, allocations: 17.34 kB / 0.8182 GB, free: 23.4 MB / 0.6355 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0018/0.7119, allocations: 351.5 kB / 0.8185 GB, free: 23.36 MB / 0.6355 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.174e-05/0.7119, allocations: 19.22 kB / 0.8186 GB, free: 23.36 MB / 0.6355 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001523/0.7134, allocations: 190.1 kB / 0.8187 GB, free: 23.25 MB / 0.6355 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000135/0.7135, allocations: 67.5 kB / 0.8188 GB, free: 23.22 MB / 0.6355 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 35
 * 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 (161):
 * Single equations (assignments): 161
 * 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.0005726/0.7141, allocations: 331.1 kB / 0.8191 GB, free: 22.97 MB / 0.6355 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003304/0.7144, allocations: 213 kB / 0.8193 GB, free: 22.86 MB / 0.6355 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.003996/0.7184, allocations: 1.627 MB / 0.8209 GB, free: 22.04 MB / 0.6355 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 9.949e-06/0.7184, allocations: 16.31 kB / 0.8209 GB, free: 22.04 MB / 0.6355 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 4.919e-06/0.7184, allocations: 0 / 0.8209 GB, free: 22.04 MB / 0.6355 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.182e-05/0.7185, allocations: 7.969 kB / 0.8209 GB, free: 22.03 MB / 0.6355 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.007339/0.7258, allocations: 3.61 MB / 0.8245 GB, free: 19.84 MB / 0.6355 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.093e-05/0.7258, allocations: 10.19 kB / 0.8245 GB, free: 19.84 MB / 0.6355 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001624/0.7274, allocations: 285.3 kB / 0.8247 GB, free: 19.77 MB / 0.6355 GB
Notification: Performance of postOpt tearingSystem (simulation): time 1.429e-05/0.7275, allocations: 12.41 kB / 0.8248 GB, free: 19.77 MB / 0.6355 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001225/0.7276, allocations: 46.17 kB / 0.8248 GB, free: 19.75 MB / 0.6355 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.411e-05/0.7276, allocations: 12.75 kB / 0.8248 GB, free: 19.75 MB / 0.6355 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 6.553e-06/0.7276, allocations: 7.125 kB / 0.8248 GB, free: 19.75 MB / 0.6355 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.005496/0.7331, allocations: 2.665 MB / 0.8274 GB, free: 17.29 MB / 0.6355 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0007829/0.7339, allocations: 302.5 kB / 0.8277 GB, free: 17 MB / 0.6355 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000234/0.7341, allocations: 35.98 kB / 0.8277 GB, free: 16.96 MB / 0.6355 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001284/0.7354, allocations: 99.91 kB / 0.8278 GB, free: 16.86 MB / 0.6355 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001784/0.7356, allocations: 99.06 kB / 0.8279 GB, free: 16.77 MB / 0.6355 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001067/0.7357, allocations: 59.84 kB / 0.828 GB, free: 16.71 MB / 0.6355 GB
Notification: Performance of sorting global known variables: time 0.0009434/0.7366, allocations: 0.8811 MB / 0.8289 GB, free: 15.84 MB / 0.6355 GB
Notification: Performance of sort global known variables: time 1.01e-07/0.7366, allocations: 0 / 0.8289 GB, free: 15.84 MB / 0.6355 GB
Notification: Performance of remove unused functions: time 0.001347/0.738, allocations: 0.5225 MB / 0.8294 GB, free: 15.31 MB / 0.6355 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 29
 * Number of states: 6 (heaHigPow.T,heaHigPow.Xi,cooLimPow.T,cooLimPow.Xi,heaCooUnl.T,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 (125):
 * Single equations (assignments): 119
 * 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.003134/0.7411, allocations: 0.6003 MB / 0.83 GB, free: 14.97 MB / 0.6355 GB
Notification: Performance of simCode: created initialization part: time 0.003498/0.7446, allocations: 1.432 MB / 0.8313 GB, free: 13.58 MB / 0.6355 GB
Notification: Performance of simCode: created event and clocks part: time 4.879e-06/0.7446, allocations: 0 / 0.8313 GB, free: 13.58 MB / 0.6355 GB
Notification: Performance of simCode: created simulation system equations: time 0.001699/0.7463, allocations: 0.7523 MB / 0.8321 GB, free: 12.86 MB / 0.6355 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003173/0.7495, allocations: 0.7785 MB / 0.8328 GB, free: 12.12 MB / 0.6355 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.009411/0.7589, allocations: 3.957 MB / 0.8367 GB, free: 8.02 MB / 0.6355 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0005438/0.7594, allocations: 0.7832 MB / 0.8375 GB, free: 7.199 MB / 0.6355 GB
Notification: Performance of simCode: alias equations: time 0.00157/0.761, allocations: 372 kB / 0.8378 GB, free: 6.832 MB / 0.6355 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0005109/0.7615, allocations: 148.4 kB / 0.838 GB, free: 6.688 MB / 0.6355 GB
Notification: Performance of SimCode: time 1.774e-06/0.7615, allocations: 0 / 0.838 GB, free: 6.688 MB / 0.6355 GB
Notification: Performance of Templates: time 0.0515/0.813, allocations: 29.98 MB / 0.8672 GB, free: 9.531 MB / 0.6667 GB
"
[Timeout remaining time 659]
make -j1 -f IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.PrescribedOutlet.makefile [Timeout 660]
(rm -f IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.PrescribedOutlet.pipe ; mkfifo IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.PrescribedOutlet.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.PrescribedOutlet.pipe >> ../files/IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.PrescribedOutlet.sim & ./IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.PrescribedOutlet -abortSlowSimulation -alarm=240  -lv LOG_STATS > IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.PrescribedOutlet.pipe 2>&1) [Timeout 240]
[Calling sys.exit(0), Time elapsed: 8.04752385802567]