Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.Fluid.HeatPumps.ModularReversible.Validation.ConstantCarnotEffectiveness.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001472/0.001472, allocations: 109 kB / 18.71 MB, free: 3.273 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001521/0.001521, allocations: 200.4 kB / 21.97 MB, free: 24 kB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.339/1.339, allocations: 225.6 MB / 250.7 MB, free: 13.4 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo", uses=false) [Timeout 180]
"[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/Media/Refrigerants/R410A/package.order:0:0-0:0:readonly] Warning: Found duplicate names in package.order file: A, B, C.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/Media/Refrigerants/R410A/package.mo:2:1-70:10:writable] Warning: C was referenced in the package.order file, but was not found in package.mo, C/package.mo or C.mo.
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 1.017/1.017, allocations: 175.7 MB / 481.6 MB, free: 7.871 MB / 382.1 MB
"
[Timeout remaining time 179]
Using package IDEAS with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo)
Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo)
Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Running command: translateModel(IDEAS.Fluid.HeatPumps.ModularReversible.Validation.ConstantCarnotEffectiveness,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.HeatPumps.ModularReversible.Validation.ConstantCarnotEffectiveness")
translateModel(IDEAS.Fluid.HeatPumps.ModularReversible.Validation.ConstantCarnotEffectiveness,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.HeatPumps.ModularReversible.Validation.ConstantCarnotEffectiveness") [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 0.001974/0.001974, allocations: 71.58 kB / 0.67 GB, free: 14.18 MB / 0.4981 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.5894/0.5913, allocations: 94.52 MB / 0.7624 GB, free: 10 MB / 0.5763 GB
Notification: Performance of NFInst.instantiate(IDEAS.Fluid.HeatPumps.ModularReversible.Validation.ConstantCarnotEffectiveness): time 0.08537/0.6767, allocations: 82.47 MB / 0.8429 GB, free: 14.34 MB / 0.6388 GB
Notification: Performance of NFInst.instExpressions: time 0.03503/0.7117, allocations: 19.09 MB / 0.8615 GB, free: 14.78 MB / 0.6544 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.007271/0.719, allocations: 102.7 kB / 0.8616 GB, free: 14.75 MB / 0.6544 GB
Notification: Performance of NFTyping.typeComponents: time 0.005433/0.7244, allocations: 1.214 MB / 0.8628 GB, free: 13.75 MB / 0.6544 GB
Notification: Performance of NFTyping.typeBindings: time 0.01007/0.7345, allocations: 2.93 MB / 0.8657 GB, free: 11.42 MB / 0.6544 GB
Notification: Performance of NFTyping.typeClassSections: time 0.006346/0.7409, allocations: 1.949 MB / 0.8676 GB, free: 9.875 MB / 0.6544 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/Fluid/HeatPumps/ModularReversible/Modular.mo:59:3-61:76:writable] Warning: Parameter heaPum.TConCoo_nominal has no value, and is fixed during initialization (fixed=true), using available start value (start=288.15) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/Fluid/HeatPumps/ModularReversible/Modular.mo:62:3-64:76:writable] Warning: Parameter heaPum.TEvaCoo_nominal has no value, and is fixed during initialization (fixed=true), using available start value (start=288.15) as default value.
Notification: Performance of NFFlatten.flatten: time 0.009174/0.75, allocations: 5.514 MB / 0.873 GB, free: 5.527 MB / 0.6544 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.003895/0.7539, allocations: 2.045 MB / 0.875 GB, free: 3.426 MB / 0.6544 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.006524/0.7604, allocations: 2.387 MB / 0.8773 GB, free: 1.039 MB / 0.6544 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.003405/0.7639, allocations: 1.715 MB / 0.879 GB, free: 15.31 MB / 0.67 GB
Notification: Performance of NFPackage.collectConstants: time 0.0007039/0.7646, allocations: 300 kB / 0.8793 GB, free: 15.02 MB / 0.67 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.00444/0.769, allocations: 1.724 MB / 0.8809 GB, free: 13.3 MB / 0.67 GB
Notification: Performance of NFScalarize.scalarize: time 0.0008247/0.7698, allocations: 0.7124 MB / 0.8816 GB, free: 12.58 MB / 0.67 GB
Notification: Performance of NFVerifyModel.verify: time 0.002249/0.7721, allocations: 1.446 MB / 0.883 GB, free: 11.13 MB / 0.67 GB
Notification: Performance of NFConvertDAE.convert: time 0.008249/0.7803, allocations: 4.839 MB / 0.8878 GB, free: 6.273 MB / 0.67 GB
Notification: Performance of FrontEnd - DAE generated: time 4.558e-06/0.7803, allocations: 0 / 0.8878 GB, free: 6.273 MB / 0.67 GB
Notification: Performance of FrontEnd: time 1.573e-06/0.7803, allocations: 0 / 0.8878 GB, free: 6.273 MB / 0.67 GB
Notification: Performance of Transformations before backend: time 9.552e-05/0.7804, allocations: 0 / 0.8878 GB, free: 6.273 MB / 0.67 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 453
 * Number of variables: 453
Notification: Performance of Generate backend data structure: time 0.005674/0.7861, allocations: 3.129 MB / 0.8908 GB, free: 3.062 MB / 0.67 GB
Notification: Performance of prepare preOptimizeDAE: time 4.462e-05/0.7861, allocations: 8.031 kB / 0.8908 GB, free: 3.055 MB / 0.67 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001573/0.7877, allocations: 433.9 kB / 0.8912 GB, free: 2.629 MB / 0.67 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.003802/0.7915, allocations: 2.115 MB / 0.8933 GB, free: 480 kB / 0.67 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001313/0.7916, allocations: 143.6 kB / 0.8935 GB, free: 336 kB / 0.67 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002595/0.7919, allocations: 184 kB / 0.8936 GB, free: 152 kB / 0.67 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.00347/0.7954, allocations: 1.905 MB / 0.8955 GB, free: 14.18 MB / 0.6856 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.707e-05/0.7954, allocations: 4 kB / 0.8955 GB, free: 14.18 MB / 0.6856 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001537/0.7956, allocations: 72 kB / 0.8956 GB, free: 14.11 MB / 0.6856 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.226e-05/0.7956, allocations: 47.98 kB / 0.8956 GB, free: 14.06 MB / 0.6856 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002874/0.7985, allocations: 1.438 MB / 0.897 GB, free: 12.62 MB / 0.6856 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.01089/0.8094, allocations: 8.05 MB / 0.9049 GB, free: 4.152 MB / 0.6856 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002286/0.8117, allocations: 1.007 MB / 0.9059 GB, free: 3.102 MB / 0.6856 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0006971/0.8124, allocations: 341.6 kB / 0.9062 GB, free: 2.77 MB / 0.6856 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0009304/0.8133, allocations: 1.16 MB / 0.9073 GB, free: 1.348 MB / 0.6856 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0009253/0.8142, allocations: 434.9 kB / 0.9077 GB, free: 0.9102 MB / 0.6856 GB
Notification: Performance of pre-optimization done (n=67): time 2.816e-06/0.8142, allocations: 0 / 0.9077 GB, free: 0.9102 MB / 0.6856 GB
Notification: Performance of matching and sorting (n=67): time 0.002884/0.8171, allocations: 1.126 MB / 0.9088 GB, free: 15.78 MB / 0.7013 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 9.527e-05/0.8172, allocations: 141.1 kB / 0.909 GB, free: 15.61 MB / 0.7013 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/Fluid/HeatPumps/ModularReversible/Modular.mo:62:3-64:76:writable] Warning: Parameter heaPum.TEvaCoo_nominal has no value, and is fixed during initialization (fixed=true), using available start value (start=288.15) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/Fluid/HeatPumps/ModularReversible/Modular.mo:59:3-61:76:writable] Warning: Parameter heaPum.TConCoo_nominal has no value, and is fixed during initialization (fixed=true), using available start value (start=288.15) as default value.
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003008/0.8202, allocations: 1.79 MB / 0.9107 GB, free: 13.78 MB / 0.7013 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001766/0.8204, allocations: 49.7 kB / 0.9108 GB, free: 13.72 MB / 0.7013 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001135/0.8215, allocations: 1.105 MB / 0.9118 GB, free: 12.61 MB / 0.7013 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002996/0.8218, allocations: 250 kB / 0.9121 GB, free: 12.36 MB / 0.7013 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0003542/0.8222, allocations: 214.5 kB / 0.9123 GB, free: 12.14 MB / 0.7013 GB
Notification: Performance of setup shared object (initialization): time 0.000156/0.8223, allocations: 345.9 kB / 0.9126 GB, free: 11.8 MB / 0.7013 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.00078/0.8231, allocations: 361.8 kB / 0.913 GB, free: 11.45 MB / 0.7013 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001091/0.8242, allocations: 0.6908 MB / 0.9136 GB, free: 10.62 MB / 0.7013 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001822/0.826, allocations: 1.005 MB / 0.9146 GB, free: 9.5 MB / 0.7013 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.605e-06/0.826, allocations: 3.938 kB / 0.9146 GB, free: 9.496 MB / 0.7013 GB
Notification: Performance of matching and sorting (n=122) (initialization): time 0.002652/0.8287, allocations: 1.254 MB / 0.9158 GB, free: 8.23 MB / 0.7013 GB
Notification: Performance of prepare postOptimizeDAE: time 2.523e-05/0.8287, allocations: 12 kB / 0.9159 GB, free: 8.219 MB / 0.7013 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.452e-05/0.8287, allocations: 8 kB / 0.9159 GB, free: 8.211 MB / 0.7013 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.767e-05/0.8288, allocations: 12 kB / 0.9159 GB, free: 8.199 MB / 0.7013 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0007817/0.8295, allocations: 227.6 kB / 0.9161 GB, free: 7.977 MB / 0.7013 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.569e-05/0.8296, allocations: 15.94 kB / 0.9161 GB, free: 7.961 MB / 0.7013 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001366/0.8309, allocations: 163.1 kB / 0.9163 GB, free: 7.801 MB / 0.7013 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.078e-05/0.831, allocations: 47.98 kB / 0.9163 GB, free: 7.754 MB / 0.7013 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 37
 * Number of states: 0 ()
 * Number of discrete variables: 10 ($PRE.tabMea.nextTimeEvent,$whenCondition1,heaPum.conHea.y,tabMea.nextTimeEventScaled,$PRE.tabMea.nextTimeEventScaled,tabMea.nextTimeEvent,heaPum.eff.hys.y,$PRE.heaPum.eff.hys.y,heaPum.hys.y,$PRE.heaPum.hys.y)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (122):
 * Single equations (assignments): 122
 * 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.001073/0.8321, allocations: 0.4975 MB / 0.9168 GB, free: 7.246 MB / 0.7013 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.000433/0.8325, allocations: 202.7 kB / 0.917 GB, free: 7.047 MB / 0.7013 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002325/0.8348, allocations: 1.065 MB / 0.918 GB, free: 5.988 MB / 0.7013 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.00161/0.8365, allocations: 0.8593 MB / 0.9189 GB, free: 5.098 MB / 0.7013 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.251e-06/0.8365, allocations: 4 kB / 0.9189 GB, free: 5.094 MB / 0.7013 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0007295/0.8372, allocations: 383.5 kB / 0.9192 GB, free: 4.699 MB / 0.7013 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000218/0.8374, allocations: 27.98 kB / 0.9193 GB, free: 4.672 MB / 0.7013 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0007667/0.8382, allocations: 51.94 kB / 0.9193 GB, free: 4.621 MB / 0.7013 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001274/0.8383, allocations: 68.39 kB / 0.9194 GB, free: 4.551 MB / 0.7013 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.002299/0.8406, allocations: 1.032 MB / 0.9204 GB, free: 3.516 MB / 0.7013 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.00292/0.8435, allocations: 1.648 MB / 0.922 GB, free: 1.844 MB / 0.7013 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0007453/0.8443, allocations: 385 kB / 0.9224 GB, free: 1.473 MB / 0.7013 GB
Notification: Performance of sorting global known variables: time 0.001864/0.8461, allocations: 1.194 MB / 0.9235 GB, free: 264 kB / 0.7013 GB
Notification: Performance of Backend: time 2.3e-07/0.8461, allocations: 4 kB / 0.9235 GB, free: 260 kB / 0.7013 GB
Notification: Performance of simCode: created initialization part: time 0.004849/0.851, allocations: 1.547 MB / 0.925 GB, free: 14.94 MB / 0.7169 GB
Notification: Performance of SimCode: time 0.009875/0.8609, allocations: 4.521 MB / 0.9295 GB, free: 10.36 MB / 0.7169 GB
Notification: Performance of Templates: time 0.06644/0.9273, allocations: 38.18 MB / 0.9667 GB, free: 4.586 MB / 0.7481 GB
"
[Timeout remaining time 659]
make -j1 -f IDEAS_dev_IDEAS.Fluid.HeatPumps.ModularReversible.Validation.ConstantCarnotEffectiveness.makefile [Timeout 660]
(rm -f IDEAS_dev_IDEAS.Fluid.HeatPumps.ModularReversible.Validation.ConstantCarnotEffectiveness.pipe ; mkfifo IDEAS_dev_IDEAS.Fluid.HeatPumps.ModularReversible.Validation.ConstantCarnotEffectiveness.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Fluid.HeatPumps.ModularReversible.Validation.ConstantCarnotEffectiveness.pipe >> ../files/IDEAS_dev_IDEAS.Fluid.HeatPumps.ModularReversible.Validation.ConstantCarnotEffectiveness.sim & ./IDEAS_dev_IDEAS.Fluid.HeatPumps.ModularReversible.Validation.ConstantCarnotEffectiveness  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_dev_IDEAS.Fluid.HeatPumps.ModularReversible.Validation.ConstantCarnotEffectiveness.pipe 2>&1) [Timeout 480]
[Calling sys.exit(0), Time elapsed: 8.473839701968245]
Failed to read output from testmodel.py, exit status != 0:
0.9364872039295733 0.955561162 0.17128687
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f02381ae050>