Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_13_Buildings.Fluid.HeatExchangers.Examples.WetCoilCounterFlowPControl.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.0009031/0.0009031, allocations: 80.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.000891/0.000891, allocations: 167.3 kB / 24.97 MB, free: 8.23 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.9824/0.9824, allocations: 177.1 MB / 205.4 MB, free: 5.48 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.942/1.942, allocations: 389.6 MB / 0.6362 GB, free: 12.32 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.Examples.WetCoilCounterFlowPControl,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.Fluid.HeatExchangers.Examples.WetCoilCounterFlowPControl")
translateModel(Buildings.Fluid.HeatExchangers.Examples.WetCoilCounterFlowPControl,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.Fluid.HeatExchangers.Examples.WetCoilCounterFlowPControl") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 1.473e-06/1.473e-06, allocations: 0 / 0.776 GB, free: 5.312 MB / 0.7292 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.584e-05/1.731e-05, allocations: 9.484 kB / 0.776 GB, free: 5.305 MB / 0.7292 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.HeatExchangers.Examples.WetCoilCounterFlowPControl): time 0.1526/0.1527, allocations: 167.8 MB / 0.9398 GB, free: 13.12 MB / 0.9011 GB
Notification: Performance of NFInst.instExpressions: time 0.02112/0.1738, allocations: 15.07 MB / 0.9546 GB, free: 14 MB / 0.9167 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004588/0.1784, allocations: 146.8 kB / 0.9547 GB, free: 13.86 MB / 0.9167 GB
Notification: Performance of NFTyping.typeComponents: time 0.001514/0.1799, allocations: 0.752 MB / 0.9554 GB, free: 13.1 MB / 0.9167 GB
Notification: Performance of NFTyping.typeBindings: time 0.005545/0.1854, allocations: 3.107 MB / 0.9585 GB, free: 9.973 MB / 0.9167 GB
Notification: Performance of NFTyping.typeClassSections: time 0.003989/0.1894, allocations: 2.436 MB / 0.9609 GB, free: 7.531 MB / 0.9167 GB
Notification: Performance of NFFlatten.flatten: time 0.01416/0.2036, allocations: 18.72 MB / 0.9791 GB, free: 4.758 MB / 0.9323 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.007319/0.2109, allocations: 5.887 MB / 0.9849 GB, free: 14.89 MB / 0.948 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01179/0.2227, allocations: 9.386 MB / 0.9941 GB, free: 5.602 MB / 0.948 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.006415/0.2291, allocations: 5.026 MB / 0.999 GB, free: 0.5625 MB / 0.948 GB
Notification: Performance of NFPackage.collectConstants: time 0.0009623/0.2301, allocations: 0.7734 MB / 0.9997 GB, free: 15.79 MB / 0.9636 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.003787/0.2339, allocations: 2.298 MB / 1.002 GB, free: 13.49 MB / 0.9636 GB
Notification: Performance of NFScalarize.scalarize: time 0.001585/0.2354, allocations: 2.372 MB / 1.004 GB, free: 11.11 MB / 0.9636 GB
Notification: Performance of NFVerifyModel.verify: time 0.003479/0.2389, allocations: 2.811 MB / 1.007 GB, free: 8.293 MB / 0.9636 GB
Notification: Performance of NFConvertDAE.convert: time 0.008442/0.2474, allocations: 7.758 MB / 1.015 GB, free: 0.5117 MB / 0.9636 GB
Notification: Performance of FrontEnd - DAE generated: time 7.764e-06/0.2474, allocations: 4 kB / 1.015 GB, free: 0.5078 MB / 0.9636 GB
Notification: Performance of FrontEnd: time 1.313e-06/0.2474, allocations: 0 / 1.015 GB, free: 0.5078 MB / 0.9636 GB
Notification: Performance of Transformations before backend: time 0.0001193/0.2475, allocations: 0 / 1.015 GB, free: 0.5078 MB / 0.9636 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1240
 * Number of variables: 1240
Notification: Performance of Generate backend data structure: time 0.009379/0.2569, allocations: 7.537 MB / 1.022 GB, free: 8.887 MB / 0.9792 GB
Notification: Performance of prepare preOptimizeDAE: time 4.425e-05/0.2569, allocations: 13.34 kB / 1.022 GB, free: 8.875 MB / 0.9792 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003557/0.2605, allocations: 1.508 MB / 1.023 GB, free: 7.363 MB / 0.9792 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.005136/0.2656, allocations: 3.847 MB / 1.027 GB, free: 3.395 MB / 0.9792 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001741/0.2658, allocations: 369.5 kB / 1.028 GB, free: 3.031 MB / 0.9792 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0004997/0.2663, allocations: 0.4921 MB / 1.028 GB, free: 2.539 MB / 0.9792 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.004596/0.2709, allocations: 4.453 MB / 1.032 GB, free: 13.76 MB / 0.9948 GB
Notification: Performance of preOpt findStateOrder (simulation): time 7.085e-05/0.2709, allocations: 15.91 kB / 1.032 GB, free: 13.75 MB / 0.9948 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003153/0.2713, allocations: 196 kB / 1.033 GB, free: 13.55 MB / 0.9948 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001495/0.2714, allocations: 225.3 kB / 1.033 GB, free: 13.33 MB / 0.9948 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002476/0.2739, allocations: 1.717 MB / 1.034 GB, free: 11.58 MB / 0.9948 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.01516/0.289, allocations: 12.32 MB / 1.047 GB, free: 15.03 MB / 1.01 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.001802/0.2909, allocations: 1.787 MB / 1.048 GB, free: 13.24 MB / 1.01 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0009612/0.2918, allocations: 0.8827 MB / 1.049 GB, free: 12.34 MB / 1.01 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.000355/0.2922, allocations: 154.4 kB / 1.049 GB, free: 12.19 MB / 1.01 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001294/0.2935, allocations: 1.73 MB / 1.051 GB, free: 10.23 MB / 1.01 GB
Notification: Performance of pre-optimization done (n=321): time 6.052e-06/0.2935, allocations: 0 / 1.051 GB, free: 10.23 MB / 1.01 GB
Notification: Performance of matching and sorting (n=325): time 0.007029/0.3005, allocations: 4.039 MB / 1.055 GB, free: 6.07 MB / 1.01 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.871e-05/0.3005, allocations: 119.6 kB / 1.055 GB, free: 5.934 MB / 1.01 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002444/0.303, allocations: 2.953 MB / 1.058 GB, free: 2.98 MB / 1.01 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001634/0.3032, allocations: 93.7 kB / 1.058 GB, free: 2.883 MB / 1.01 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001067/0.3042, allocations: 1.893 MB / 1.06 GB, free: 0.9648 MB / 1.01 GB
Notification: Performance of collectInitialBindings (initialization): time 0.4445/0.7488, allocations: 1.148 MB / 1.061 GB, free: 112.6 MB / 1.01 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001385/0.7501, allocations: 0.5828 MB / 1.062 GB, free: 112.6 MB / 1.01 GB
Notification: Performance of setup shared object (initialization): time 4.247e-05/0.7502, allocations: 303.3 kB / 1.062 GB, free: 112.3 MB / 1.01 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001255/0.7514, allocations: 474.9 kB / 1.062 GB, free: 112.3 MB / 1.01 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.00132/0.7528, allocations: 1.939 MB / 1.064 GB, free: 110.5 MB / 1.01 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002155/0.7549, allocations: 1.723 MB / 1.066 GB, free: 109.8 MB / 1.01 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.493e-05/0.7549, allocations: 4.531 kB / 1.066 GB, free: 109.8 MB / 1.01 GB
Notification: Performance of matching and sorting (n=422) (initialization): time 0.003538/0.7585, allocations: 1.976 MB / 1.068 GB, free: 109.6 MB / 1.01 GB
Notification: Performance of prepare postOptimizeDAE: time 4.581e-05/0.7585, allocations: 47.3 kB / 1.068 GB, free: 109.6 MB / 1.01 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.482e-05/0.7585, allocations: 14.78 kB / 1.068 GB, free: 109.6 MB / 1.01 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0006644/0.7592, allocations: 228.5 kB / 1.068 GB, free: 109.6 MB / 1.01 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001989/0.7612, allocations: 0.7723 MB / 1.069 GB, free: 109.6 MB / 1.01 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001468/0.7627, allocations: 2.77 MB / 1.072 GB, free: 107.2 MB / 1.01 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002079/0.7647, allocations: 131.2 kB / 1.072 GB, free: 107.2 MB / 1.01 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002221/0.765, allocations: 99.31 kB / 1.072 GB, free: 107.2 MB / 1.01 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.002094/0.7671, allocations: 0.6084 MB / 1.072 GB, free: 107.1 MB / 1.01 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001359/0.7684, allocations: 1.937 MB / 1.074 GB, free: 105.3 MB / 1.01 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.002141/0.7706, allocations: 1.715 MB / 1.076 GB, free: 104.6 MB / 1.01 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.168e-05/0.7706, allocations: 6.406 kB / 1.076 GB, free: 104.6 MB / 1.01 GB
Notification: Performance of matching and sorting (n=422) (initialization_lambda0): time 0.002924/0.7735, allocations: 1.953 MB / 1.078 GB, free: 104.4 MB / 1.01 GB
Notification: Performance of prepare postOptimizeDAE: time 3.081e-05/0.7735, allocations: 46.62 kB / 1.078 GB, free: 104.4 MB / 1.01 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.608e-05/0.7735, allocations: 17.72 kB / 1.078 GB, free: 104.4 MB / 1.01 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0003338/0.7739, allocations: 162.8 kB / 1.078 GB, free: 104.4 MB / 1.01 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001721/0.7756, allocations: 0.7688 MB / 1.079 GB, free: 104.4 MB / 1.01 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001476/0.7771, allocations: 3.203 MB / 1.082 GB, free: 101.8 MB / 1.01 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001321/0.7784, allocations: 141.2 kB / 1.082 GB, free: 101.8 MB / 1.01 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001639/0.7786, allocations: 96.19 kB / 1.082 GB, free: 101.8 MB / 1.01 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 68
 * Number of states: 0 ()
 * Number of discrete variables: 8 (con.I.trigger_internal,TSet.nextEventScaled,TSet.nextEvent,$PRE.TSet.nextEvent,TSet.last,TSet.b,TSet.a,$whenCondition1)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (401):
 * Single equations (assignments): 397
 * Array equations: 0
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 1
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 0 systems
 * Non-linear Jacobian (size): 1 system
   {1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 1 system
   {(1,7,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,9)}
Notification: Performance of prepare postOptimizeDAE: time 0.000532/0.7791, allocations: 423.1 kB / 1.083 GB, free: 101.6 MB / 1.01 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0005018/0.7796, allocations: 414.3 kB / 1.083 GB, free: 101.6 MB / 1.01 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002542/0.7821, allocations: 1.946 MB / 1.085 GB, free: 101.4 MB / 1.01 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001373/0.7835, allocations: 1.22 MB / 1.086 GB, free: 101.1 MB / 1.01 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.091e-06/0.7835, allocations: 0.9688 kB / 1.086 GB, free: 101.1 MB / 1.01 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0008926/0.7844, allocations: 0.6245 MB / 1.087 GB, free: 101.1 MB / 1.01 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000347/0.7847, allocations: 74.41 kB / 1.087 GB, free: 101.1 MB / 1.01 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0009324/0.7857, allocations: 100.6 kB / 1.087 GB, free: 101.1 MB / 1.01 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.00027/0.7859, allocations: 201 kB / 1.087 GB, free: 101 MB / 1.01 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.002668/0.7886, allocations: 1.775 MB / 1.089 GB, free: 100.7 MB / 1.01 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.002732/0.7913, allocations: 2.4 MB / 1.091 GB, free: 100.2 MB / 1.01 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0006585/0.792, allocations: 0.6762 MB / 1.092 GB, free: 100.2 MB / 1.01 GB
Notification: Performance of sorting global known variables: time 0.00149/0.7935, allocations: 1.581 MB / 1.093 GB, free: 100 MB / 1.01 GB
Notification: Performance of Backend: time 1.71e-07/0.7935, allocations: 0 / 1.093 GB, free: 100 MB / 1.01 GB
Notification: Performance of simCode: created initialization part: time 0.004397/0.7979, allocations: 3.275 MB / 1.096 GB, free: 99.36 MB / 1.01 GB
Notification: Performance of SimCode: time 0.01758/0.8155, allocations: 13.22 MB / 1.109 GB, free: 94.41 MB / 1.01 GB
Notification: Performance of Templates: time 0.1171/0.9325, allocations: 126.5 MB / 1.233 GB, free: 3.09 MB / 1.01 GB
"
[Timeout remaining time 299]
make -j1 -f Buildings_13_Buildings.Fluid.HeatExchangers.Examples.WetCoilCounterFlowPControl.makefile [Timeout 300]
(rm -f Buildings_13_Buildings.Fluid.HeatExchangers.Examples.WetCoilCounterFlowPControl.pipe ; mkfifo Buildings_13_Buildings.Fluid.HeatExchangers.Examples.WetCoilCounterFlowPControl.pipe ; head -c 1048576 < Buildings_13_Buildings.Fluid.HeatExchangers.Examples.WetCoilCounterFlowPControl.pipe >> ../files/Buildings_13_Buildings.Fluid.HeatExchangers.Examples.WetCoilCounterFlowPControl.sim & ./Buildings_13_Buildings.Fluid.HeatExchangers.Examples.WetCoilCounterFlowPControl -abortSlowSimulation -alarm=240  -lv LOG_STATS > Buildings_13_Buildings.Fluid.HeatExchangers.Examples.WetCoilCounterFlowPControl.pipe 2>&1) [Timeout 240]
[Calling sys.exit(0), Time elapsed: 7.784807280637324]