Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_13_Buildings.Fluid.CHPs.OrganicRankine.Validation.VariableSource.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.0009437/0.0009437, allocations: 84.81 kB / 21.55 MB, free: 2.941 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.0009837/0.0009837, allocations: 163.2 kB / 24.97 MB, free: 9.184 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 0.9339/0.9339, allocations: 177.1 MB / 205.4 MB, free: 5.484 MB / 186.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.x/package.mo): time 1.998/1.998, allocations: 389.6 MB / 0.6362 GB, free: 12.27 MB / 0.6042 GB
"
[Timeout remaining time 177]
Using package Buildings with version 13.0.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.x/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(Buildings.Fluid.CHPs.OrganicRankine.Validation.VariableSource,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.Fluid.CHPs.OrganicRankine.Validation.VariableSource")
translateModel(Buildings.Fluid.CHPs.OrganicRankine.Validation.VariableSource,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.Fluid.CHPs.OrganicRankine.Validation.VariableSource") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 1.813e-06/1.813e-06, allocations: 0 / 0.776 GB, free: 5.348 MB / 0.7292 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.377e-05/2.559e-05, allocations: 3.125 kB / 0.776 GB, free: 5.344 MB / 0.7292 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.CHPs.OrganicRankine.Validation.VariableSource): time 0.1416/0.1416, allocations: 160.4 MB / 0.9326 GB, free: 4.52 MB / 0.8855 GB
Notification: Performance of NFInst.instExpressions: time 0.01137/0.153, allocations: 8.526 MB / 0.941 GB, free: 11.97 MB / 0.9011 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001317/0.1543, allocations: 91.25 kB / 0.9411 GB, free: 11.88 MB / 0.9011 GB
Notification: Performance of NFTyping.typeComponents: time 0.001184/0.1555, allocations: 0.7764 MB / 0.9418 GB, free: 11.1 MB / 0.9011 GB
Notification: Performance of NFTyping.typeBindings: time 0.003379/0.1589, allocations: 2.355 MB / 0.9441 GB, free: 8.734 MB / 0.9011 GB
Notification: Performance of NFTyping.typeClassSections: time 0.00202/0.1609, allocations: 1.485 MB / 0.9456 GB, free: 7.246 MB / 0.9011 GB
Notification: Performance of NFFlatten.flatten: time 0.003055/0.164, allocations: 4.139 MB / 0.9496 GB, free: 3.094 MB / 0.9011 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001523/0.1655, allocations: 1.187 MB / 0.9508 GB, free: 1.879 MB / 0.9011 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.002165/0.1676, allocations: 2.153 MB / 0.9529 GB, free: 15.75 MB / 0.9167 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001113/0.1688, allocations: 1.16 MB / 0.954 GB, free: 14.59 MB / 0.9167 GB
Notification: Performance of NFPackage.collectConstants: time 0.000185/0.1689, allocations: 176 kB / 0.9542 GB, free: 14.41 MB / 0.9167 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.001721/0.1707, allocations: 1.368 MB / 0.9555 GB, free: 13.04 MB / 0.9167 GB
Notification: Performance of NFScalarize.scalarize: time 0.0005632/0.1712, allocations: 1.021 MB / 0.9565 GB, free: 12.02 MB / 0.9167 GB
Notification: Performance of NFVerifyModel.verify: time 0.0006982/0.1719, allocations: 0.8651 MB / 0.9574 GB, free: 11.15 MB / 0.9167 GB
Notification: Performance of NFConvertDAE.convert: time 0.002422/0.1744, allocations: 2.733 MB / 0.96 GB, free: 8.41 MB / 0.9167 GB
Notification: Performance of FrontEnd - DAE generated: time 2.535e-06/0.1744, allocations: 0 / 0.96 GB, free: 8.41 MB / 0.9167 GB
Notification: Performance of FrontEnd: time 1.203e-06/0.1744, allocations: 0 / 0.96 GB, free: 8.41 MB / 0.9167 GB
Notification: Performance of Transformations before backend: time 3.239e-05/0.1744, allocations: 0 / 0.96 GB, free: 8.41 MB / 0.9167 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 281
 * Number of variables: 281
Notification: Performance of Generate backend data structure: time 0.002942/0.1773, allocations: 2.901 MB / 0.9629 GB, free: 5.453 MB / 0.9167 GB
Notification: Performance of prepare preOptimizeDAE: time 8.246e-05/0.1774, allocations: 9.344 kB / 0.9629 GB, free: 5.445 MB / 0.9167 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002132/0.1795, allocations: 0.7059 MB / 0.9636 GB, free: 4.738 MB / 0.9167 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001609/0.1812, allocations: 1.477 MB / 0.965 GB, free: 3.188 MB / 0.9167 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 9.762e-05/0.1813, allocations: 149.5 kB / 0.9651 GB, free: 3.027 MB / 0.9167 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001131/0.1814, allocations: 112 kB / 0.9652 GB, free: 2.918 MB / 0.9167 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001375/0.1827, allocations: 1.135 MB / 0.9664 GB, free: 1.668 MB / 0.9167 GB
Notification: Performance of preOpt findStateOrder (simulation): time 1.793e-05/0.1828, allocations: 4 kB / 0.9664 GB, free: 1.664 MB / 0.9167 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 7.491e-05/0.1828, allocations: 51.98 kB / 0.9664 GB, free: 1.613 MB / 0.9167 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.792e-05/0.1829, allocations: 38.08 kB / 0.9664 GB, free: 1.574 MB / 0.9167 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0007133/0.1836, allocations: 0.5244 MB / 0.967 GB, free: 1.016 MB / 0.9167 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.004038/0.1876, allocations: 3.599 MB / 0.9705 GB, free: 13.32 MB / 0.9323 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.000784/0.1884, allocations: 0.5491 MB / 0.971 GB, free: 12.75 MB / 0.9323 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0003338/0.1887, allocations: 295.7 kB / 0.9713 GB, free: 12.45 MB / 0.9323 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0002442/0.189, allocations: 124.5 kB / 0.9714 GB, free: 12.32 MB / 0.9323 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0005814/0.1896, allocations: 0.5448 MB / 0.9719 GB, free: 11.72 MB / 0.9323 GB
Notification: Performance of pre-optimization done (n=89): time 3.066e-06/0.1896, allocations: 4 kB / 0.9719 GB, free: 11.71 MB / 0.9323 GB
Notification: Performance of matching and sorting (n=89): time 0.005664/0.1952, allocations: 2.185 MB / 0.9741 GB, free: 9.48 MB / 0.9323 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.965e-05/0.1953, allocations: 149.1 kB / 0.9742 GB, free: 9.305 MB / 0.9323 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001435/0.1967, allocations: 2.004 MB / 0.9762 GB, free: 7.273 MB / 0.9323 GB
Notification: Performance of collectPreVariables (initialization): time 5.949e-05/0.1968, allocations: 49.7 kB / 0.9762 GB, free: 7.219 MB / 0.9323 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0003582/0.1971, allocations: 0.6279 MB / 0.9768 GB, free: 6.578 MB / 0.9323 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001778/0.1973, allocations: 305.4 kB / 0.9771 GB, free: 6.277 MB / 0.9323 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002302/0.1975, allocations: 202.4 kB / 0.9773 GB, free: 6.074 MB / 0.9323 GB
Notification: Performance of setup shared object (initialization): time 9.055e-05/0.1976, allocations: 353.8 kB / 0.9777 GB, free: 5.723 MB / 0.9323 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0003433/0.198, allocations: 240.5 kB / 0.9779 GB, free: 5.473 MB / 0.9323 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0005057/0.1985, allocations: 0.6671 MB / 0.9785 GB, free: 4.664 MB / 0.9323 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0007336/0.1992, allocations: 0.7229 MB / 0.9792 GB, free: 3.855 MB / 0.9323 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.2e-06/0.1992, allocations: 4 kB / 0.9792 GB, free: 3.852 MB / 0.9323 GB
Notification: Performance of matching and sorting (n=131) (initialization): time 0.001107/0.2003, allocations: 0.931 MB / 0.9802 GB, free: 2.879 MB / 0.9323 GB
Notification: Performance of prepare postOptimizeDAE: time 4.483e-05/0.2004, allocations: 71.39 kB / 0.9802 GB, free: 2.797 MB / 0.9323 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.906e-06/0.2004, allocations: 7.938 kB / 0.9802 GB, free: 2.789 MB / 0.9323 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0009943/0.2014, allocations: 0.5587 MB / 0.9808 GB, free: 2.223 MB / 0.9323 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0004786/0.2019, allocations: 195.7 kB / 0.981 GB, free: 2.031 MB / 0.9323 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001292/0.2031, allocations: 2.094 MB / 0.983 GB, free: 15.82 MB / 0.948 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0005834/0.2037, allocations: 151.3 kB / 0.9832 GB, free: 15.67 MB / 0.948 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.978e-05/0.2038, allocations: 39.97 kB / 0.9832 GB, free: 15.63 MB / 0.948 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 20
 * Number of states: 0 ()
 * Number of discrete variables: 17 (THotIn_set.nextEventScaled,THotIn_set.nextEvent,$PRE.THotIn_set.nextEvent,THotIn_set.last,THotIn_set.b,THotIn_set.a,mHot_flow_set.nextEventScaled,mHot_flow_set.nextEvent,$PRE.mHot_flow_set.nextEvent,mHot_flow_set.last,mHot_flow_set.b,mHot_flow_set.a,orc.cyc.hys.y,$PRE.orc.cyc.hys.y,orc.on_actual,$whenCondition2,$whenCondition1)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (90):
 * Single equations (assignments): 85
 * Array equations: 1
 * Algorithm blocks: 2
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 1 system
   {(1,1,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(4,26)}
Notification: Performance of prepare postOptimizeDAE: time 0.0003086/0.2041, allocations: 239.9 kB / 0.9834 GB, free: 15.38 MB / 0.948 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001727/0.2043, allocations: 163.8 kB / 0.9836 GB, free: 15.21 MB / 0.948 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001368/0.2056, allocations: 1.02 MB / 0.9846 GB, free: 14.16 MB / 0.948 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 7.434e-06/0.2057, allocations: 3.984 kB / 0.9846 GB, free: 14.16 MB / 0.948 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.917e-06/0.2057, allocations: 0 / 0.9846 GB, free: 14.16 MB / 0.948 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003995/0.2061, allocations: 290.2 kB / 0.9849 GB, free: 13.87 MB / 0.948 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001454/0.2062, allocations: 27.92 kB / 0.9849 GB, free: 13.84 MB / 0.948 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0004516/0.2067, allocations: 71.94 kB / 0.9849 GB, free: 13.77 MB / 0.948 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 9.296e-05/0.2067, allocations: 56.89 kB / 0.985 GB, free: 13.72 MB / 0.948 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.001494/0.2082, allocations: 0.9873 MB / 0.986 GB, free: 12.69 MB / 0.948 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.001021/0.2093, allocations: 1.18 MB / 0.9871 GB, free: 11.46 MB / 0.948 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0002587/0.2095, allocations: 270.1 kB / 0.9874 GB, free: 11.18 MB / 0.948 GB
Notification: Performance of sorting global known variables: time 0.0007887/0.2103, allocations: 1.062 MB / 0.9884 GB, free: 10.1 MB / 0.948 GB
Notification: Performance of Backend: time 5.61e-07/0.2103, allocations: 0 / 0.9884 GB, free: 10.1 MB / 0.948 GB
Notification: Performance of simCode: created initialization part: time 0.001971/0.2123, allocations: 1.22 MB / 0.9896 GB, free: 8.824 MB / 0.948 GB
Notification: Performance of SimCode: time 0.005374/0.2177, allocations: 5.292 MB / 0.9948 GB, free: 3.418 MB / 0.948 GB
Notification: Performance of Templates: time 0.05227/0.2699, allocations: 48.49 MB / 1.042 GB, free: 3.902 MB / 0.9948 GB
"
[Timeout remaining time 300]
make -j1 -f Buildings_13_Buildings.Fluid.CHPs.OrganicRankine.Validation.VariableSource.makefile [Timeout 300]
(rm -f Buildings_13_Buildings.Fluid.CHPs.OrganicRankine.Validation.VariableSource.pipe ; mkfifo Buildings_13_Buildings.Fluid.CHPs.OrganicRankine.Validation.VariableSource.pipe ; head -c 1048576 < Buildings_13_Buildings.Fluid.CHPs.OrganicRankine.Validation.VariableSource.pipe >> ../files/Buildings_13_Buildings.Fluid.CHPs.OrganicRankine.Validation.VariableSource.sim & ./Buildings_13_Buildings.Fluid.CHPs.OrganicRankine.Validation.VariableSource -abortSlowSimulation -alarm=240  -lv LOG_STATS > Buildings_13_Buildings.Fluid.CHPs.OrganicRankine.Validation.VariableSource.pipe 2>&1) [Timeout 240]
[Calling os._exit(0), Time elapsed: 5.9314266769215465]