Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_13_Buildings.Fluid.HeatExchangers.BaseClasses.Examples.HexElementLatentLoop.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.0009696/0.0009696, allocations: 80.81 kB / 21.55 MB, free: 2.949 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.001448/0.001448, allocations: 159 kB / 24.96 MB, free: 8.758 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.9667/0.9667, allocations: 177.1 MB / 205.4 MB, free: 5.504 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.902/1.902, allocations: 389.6 MB / 0.6362 GB, free: 12.29 MB / 0.6042 GB
"
[Timeout remaining time 178]
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.HeatExchangers.BaseClasses.Examples.HexElementLatentLoop,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.Fluid.HeatExchangers.BaseClasses.Examples.HexElementLatentLoop")
translateModel(Buildings.Fluid.HeatExchangers.BaseClasses.Examples.HexElementLatentLoop,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.Fluid.HeatExchangers.BaseClasses.Examples.HexElementLatentLoop") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 1.092e-06/1.092e-06, allocations: 0.6562 kB / 0.776 GB, free: 5.324 MB / 0.7292 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.035e-05/1.144e-05, allocations: 7.219 kB / 0.776 GB, free: 5.316 MB / 0.7292 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.HeatExchangers.BaseClasses.Examples.HexElementLatentLoop): time 0.138/0.138, allocations: 168.3 MB / 0.9403 GB, free: 12.64 MB / 0.9011 GB
Notification: Performance of NFInst.instExpressions: time 0.01575/0.1538, allocations: 13.09 MB / 0.9531 GB, free: 15.52 MB / 0.9167 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001557/0.1553, allocations: 150.8 kB / 0.9533 GB, free: 15.38 MB / 0.9167 GB
Notification: Performance of NFTyping.typeComponents: time 0.002726/0.1581, allocations: 1.823 MB / 0.955 GB, free: 13.54 MB / 0.9167 GB
Notification: Performance of NFTyping.typeBindings: time 0.003934/0.162, allocations: 3.369 MB / 0.9583 GB, free: 10.16 MB / 0.9167 GB
Notification: Performance of NFTyping.typeClassSections: time 0.003297/0.1653, allocations: 2.573 MB / 0.9609 GB, free: 7.578 MB / 0.9167 GB
Notification: Performance of NFFlatten.flatten: time 0.007988/0.1733, allocations: 10.68 MB / 0.9713 GB, free: 12.87 MB / 0.9323 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.002377/0.1757, allocations: 2.163 MB / 0.9734 GB, free: 10.66 MB / 0.9323 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.003559/0.1792, allocations: 4.003 MB / 0.9773 GB, free: 6.711 MB / 0.9323 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001645/0.1809, allocations: 1.913 MB / 0.9792 GB, free: 4.793 MB / 0.9323 GB
Notification: Performance of NFPackage.collectConstants: time 0.0002536/0.1811, allocations: 280 kB / 0.9794 GB, free: 4.52 MB / 0.9323 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.001865/0.183, allocations: 1.31 MB / 0.9807 GB, free: 3.207 MB / 0.9323 GB
Notification: Performance of NFScalarize.scalarize: time 0.0007049/0.1837, allocations: 1.192 MB / 0.9819 GB, free: 2.012 MB / 0.9323 GB
Notification: Performance of NFVerifyModel.verify: time 0.0008907/0.1846, allocations: 1.197 MB / 0.983 GB, free: 0.8125 MB / 0.9323 GB
Notification: Performance of NFConvertDAE.convert: time 0.002731/0.1873, allocations: 3.329 MB / 0.9863 GB, free: 13.47 MB / 0.948 GB
Notification: Performance of FrontEnd - DAE generated: time 3.357e-06/0.1873, allocations: 0 / 0.9863 GB, free: 13.47 MB / 0.948 GB
Notification: Performance of FrontEnd: time 1.062e-06/0.1873, allocations: 0 / 0.9863 GB, free: 13.47 MB / 0.948 GB
Notification: Performance of Transformations before backend: time 2.052e-05/0.1873, allocations: 4 kB / 0.9863 GB, free: 13.47 MB / 0.948 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 470
 * Number of variables: 470
Notification: Performance of Generate backend data structure: time 0.003877/0.1912, allocations: 3.608 MB / 0.9898 GB, free: 9.809 MB / 0.948 GB
Notification: Performance of prepare preOptimizeDAE: time 3.194e-05/0.1913, allocations: 8.625 kB / 0.9898 GB, free: 9.801 MB / 0.948 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002391/0.1936, allocations: 0.881 MB / 0.9907 GB, free: 8.918 MB / 0.948 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002623/0.1963, allocations: 2.284 MB / 0.9929 GB, free: 6.543 MB / 0.948 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 7.393e-05/0.1963, allocations: 139.7 kB / 0.9931 GB, free: 6.406 MB / 0.948 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001806/0.1965, allocations: 199.9 kB / 0.9932 GB, free: 6.211 MB / 0.948 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001749/0.1983, allocations: 1.74 MB / 0.9949 GB, free: 4.332 MB / 0.948 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.839e-05/0.1983, allocations: 4 kB / 0.995 GB, free: 4.328 MB / 0.948 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001148/0.1984, allocations: 87.97 kB / 0.995 GB, free: 4.242 MB / 0.948 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.481e-05/0.1985, allocations: 75.48 kB / 0.9951 GB, free: 4.168 MB / 0.948 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0009936/0.1995, allocations: 0.6635 MB / 0.9958 GB, free: 3.496 MB / 0.948 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.005302/0.2048, allocations: 5.508 MB / 1.001 GB, free: 13.82 MB / 0.9636 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0009439/0.2057, allocations: 0.5771 MB / 1.002 GB, free: 13.24 MB / 0.9636 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0002839/0.206, allocations: 234.4 kB / 1.002 GB, free: 13.01 MB / 0.9636 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0002279/0.2062, allocations: 88.92 kB / 1.002 GB, free: 12.92 MB / 0.9636 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.691e-05/0.2062, allocations: 47.56 kB / 1.002 GB, free: 12.86 MB / 0.9636 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.0004066/0.2067, allocations: 163.2 kB / 1.002 GB, free: 12.7 MB / 0.9636 GB
Notification: Performance of pre-optimization done (n=101): time 2.655e-06/0.2067, allocations: 0 / 1.002 GB, free: 12.7 MB / 0.9636 GB
Notification: Performance of matching and sorting (n=103): time 0.003822/0.2105, allocations: 1.972 MB / 1.004 GB, free: 10.7 MB / 0.9636 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 2.355e-05/0.2105, allocations: 64.41 kB / 1.004 GB, free: 10.62 MB / 0.9636 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001361/0.2119, allocations: 1.883 MB / 1.006 GB, free: 8.73 MB / 0.9636 GB
Notification: Performance of collectPreVariables (initialization): time 6.386e-05/0.2119, allocations: 49.7 kB / 1.006 GB, free: 8.676 MB / 0.9636 GB
Notification: Performance of collectInitialEqns (initialization): time 0.000432/0.2124, allocations: 0.9253 MB / 1.007 GB, free: 7.734 MB / 0.9636 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001955/0.2126, allocations: 372.7 kB / 1.007 GB, free: 7.367 MB / 0.9636 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002625/0.2128, allocations: 259.3 kB / 1.008 GB, free: 7.109 MB / 0.9636 GB
Notification: Performance of setup shared object (initialization): time 9.32e-05/0.2129, allocations: 365.8 kB / 1.008 GB, free: 6.746 MB / 0.9636 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0003485/0.2133, allocations: 211.5 kB / 1.008 GB, free: 6.535 MB / 0.9636 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0008249/0.2141, allocations: 0.882 MB / 1.009 GB, free: 5.41 MB / 0.9636 GB
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: fan.vol.dynBal.medium.p = fan.vol.dynBal.p_start (sin_2.p = fan.vol.dynBal.p_start)
Notification: Performance of analyzeInitialSystem (initialization): time 0.001415/0.2155, allocations: 1.244 MB / 1.01 GB, free: 4.004 MB / 0.9636 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.919e-06/0.2155, allocations: 4 kB / 1.01 GB, free: 4 MB / 0.9636 GB
Notification: Performance of matching and sorting (n=168) (initialization): time 0.001102/0.2166, allocations: 0.9141 MB / 1.011 GB, free: 3.074 MB / 0.9636 GB
Notification: Performance of prepare postOptimizeDAE: time 2.041e-05/0.2166, allocations: 12 kB / 1.011 GB, free: 3.062 MB / 0.9636 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.166e-05/0.2166, allocations: 12 kB / 1.011 GB, free: 3.051 MB / 0.9636 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0006822/0.2173, allocations: 311.2 kB / 1.011 GB, free: 2.746 MB / 0.9636 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0006239/0.2179, allocations: 295.5 kB / 1.012 GB, free: 2.457 MB / 0.9636 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0004353/0.2184, allocations: 0.6903 MB / 1.012 GB, free: 1.738 MB / 0.9636 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0006038/0.219, allocations: 71.92 kB / 1.012 GB, free: 1.668 MB / 0.9636 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 8.003e-05/0.2191, allocations: 47.98 kB / 1.012 GB, free: 1.621 MB / 0.9636 GB
Warning: The initial conditions are over specified. The following 1 initial equations are redundant, so they are removed from the initialization system:
         fan.vol.dynBal.medium.p = fan.vol.dynBal.p_start.
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.0005691/0.2196, allocations: 309.7 kB / 1.013 GB, free: 1.312 MB / 0.9636 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0005981/0.2202, allocations: 0.8743 MB / 1.014 GB, free: 200 kB / 0.9636 GB
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: fan.vol.dynBal.medium.p = fan.vol.dynBal.p_start (sin_2.p = fan.vol.dynBal.p_start)
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001645/0.2219, allocations: 1.235 MB / 1.015 GB, free: 14.8 MB / 0.9792 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 7.544e-06/0.2219, allocations: 4 kB / 1.015 GB, free: 14.8 MB / 0.9792 GB
Notification: Performance of matching and sorting (n=168) (initialization_lambda0): time 0.001104/0.223, allocations: 0.9106 MB / 1.016 GB, free: 13.88 MB / 0.9792 GB
Notification: Performance of prepare postOptimizeDAE: time 1.372e-05/0.223, allocations: 12 kB / 1.016 GB, free: 13.86 MB / 0.9792 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.728e-06/0.223, allocations: 12 kB / 1.016 GB, free: 13.85 MB / 0.9792 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0005521/0.2236, allocations: 235.6 kB / 1.016 GB, free: 13.62 MB / 0.9792 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0006118/0.2242, allocations: 295.5 kB / 1.016 GB, free: 13.33 MB / 0.9792 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0003872/0.2246, allocations: 0.6897 MB / 1.017 GB, free: 12.61 MB / 0.9792 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0006054/0.2252, allocations: 64 kB / 1.017 GB, free: 12.55 MB / 0.9792 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 7.293e-05/0.2252, allocations: 55.97 kB / 1.017 GB, free: 12.5 MB / 0.9792 GB
Warning: The initial conditions are over specified. The following 1 initial equations are redundant, so they are removed from the initialization_lambda0 system:
         fan.vol.dynBal.medium.p = fan.vol.dynBal.p_start.
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 52
 * 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 (144):
 * Single equations (assignments): 141
 * Array equations: 2
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(2,21)}
Notification: Performance of prepare postOptimizeDAE: time 0.0001979/0.2254, allocations: 275.8 kB / 1.017 GB, free: 12.22 MB / 0.9792 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002352/0.2257, allocations: 175.8 kB / 1.017 GB, free: 12.05 MB / 0.9792 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0009491/0.2266, allocations: 0.7897 MB / 1.018 GB, free: 11.24 MB / 0.9792 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0004532/0.2271, allocations: 412.7 kB / 1.019 GB, free: 10.82 MB / 0.9792 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.286e-06/0.2271, allocations: 0 / 1.019 GB, free: 10.82 MB / 0.9792 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003806/0.2275, allocations: 290.2 kB / 1.019 GB, free: 10.54 MB / 0.9792 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001465/0.2276, allocations: 19.98 kB / 1.019 GB, free: 10.52 MB / 0.9792 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0004824/0.2281, allocations: 43.92 kB / 1.019 GB, free: 10.48 MB / 0.9792 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 8.379e-05/0.2282, allocations: 64.81 kB / 1.019 GB, free: 10.41 MB / 0.9792 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.001075/0.2292, allocations: 0.7137 MB / 1.02 GB, free: 9.684 MB / 0.9792 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.0008986/0.2301, allocations: 0.9666 MB / 1.021 GB, free: 8.703 MB / 0.9792 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0002183/0.2304, allocations: 206.6 kB / 1.021 GB, free: 8.496 MB / 0.9792 GB
Notification: Performance of sorting global known variables: time 0.0009435/0.2313, allocations: 0.8988 MB / 1.022 GB, free: 7.59 MB / 0.9792 GB
Notification: Performance of Backend: time 3.71e-07/0.2313, allocations: 0 / 1.022 GB, free: 7.59 MB / 0.9792 GB
Notification: Performance of simCode: created initialization part: time 0.002307/0.2336, allocations: 1.442 MB / 1.023 GB, free: 6.152 MB / 0.9792 GB
Notification: Performance of SimCode: time 0.007321/0.2409, allocations: 6.412 MB / 1.029 GB, free: 15.67 MB / 0.9948 GB
Notification: Performance of Templates: time 0.3985/0.6394, allocations: 62.89 MB / 1.091 GB, free: 107.2 MB / 1.01 GB
"
[Timeout remaining time 299]
make -j1 -f Buildings_13_Buildings.Fluid.HeatExchangers.BaseClasses.Examples.HexElementLatentLoop.makefile [Timeout 300]
(rm -f Buildings_13_Buildings.Fluid.HeatExchangers.BaseClasses.Examples.HexElementLatentLoop.pipe ; mkfifo Buildings_13_Buildings.Fluid.HeatExchangers.BaseClasses.Examples.HexElementLatentLoop.pipe ; head -c 1048576 < Buildings_13_Buildings.Fluid.HeatExchangers.BaseClasses.Examples.HexElementLatentLoop.pipe >> ../files/Buildings_13_Buildings.Fluid.HeatExchangers.BaseClasses.Examples.HexElementLatentLoop.sim & ./Buildings_13_Buildings.Fluid.HeatExchangers.BaseClasses.Examples.HexElementLatentLoop -abortSlowSimulation -alarm=240  -lv LOG_STATS > Buildings_13_Buildings.Fluid.HeatExchangers.BaseClasses.Examples.HexElementLatentLoop.pipe 2>&1) [Timeout 240]
[Calling sys.exit(0), Time elapsed: 6.247781955637038]