Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Annex60_1.0.0_Annex60.Fluid.MixingVolumes.Validation.MixingVolumeAdiabaticCooling.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Annex60 1.0.0/package.mo", uses=false)
Using package Annex60 with version 1.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Annex60 1.0.0/package.mo)
Using package Modelica with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+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(Annex60.Fluid.MixingVolumes.Validation.MixingVolumeAdiabaticCooling,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Annex60_1.0.0_Annex60.Fluid.MixingVolumes.Validation.MixingVolumeAdiabaticCooling")
translateModel(Annex60.Fluid.MixingVolumes.Validation.MixingVolumeAdiabaticCooling,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Annex60_1.0.0_Annex60.Fluid.MixingVolumes.Validation.MixingVolumeAdiabaticCooling")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001329/0.001329, allocations: 86.72 kB / 15.06 MB, free: 1.09 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.00162/0.00162, allocations: 168.7 kB / 15.95 MB, free: 204 kB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.716/1.716, allocations: 205.4 MB / 222.1 MB, free: 5.629 MB / 174.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Annex60 1.0.0/package.mo): time 0.418/0.418, allocations: 55.01 MB / 325.4 MB, free: 0.6562 MB / 254.1 MB
Notification: Modelica requested package Complex of version 3.2.3. Complex 4.0.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Modelica requested package ModelicaServices of version 3.2.3. ModelicaServices 4.0.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Annex60 requested package Modelica of version 3.2.2. Modelica 3.2.3 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.0006498/0.0006503, allocations: 19.98 kB / 396.6 MB, free: 11.7 MB / 334.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4686/0.4692, allocations: 60.72 MB / 457.4 MB, free: 38.71 MB / 382.1 MB
Notification: Performance of NFInst.instantiate(Annex60.Fluid.MixingVolumes.Validation.MixingVolumeAdiabaticCooling): time 0.2103/0.6796, allocations: 165.5 MB / 0.6083 GB, free: 1.676 MB / 478.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01158/0.6912, allocations: 5.354 MB / 0.6135 GB, free: 12.32 MB / 494.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001737/0.693, allocations: 31.81 kB / 0.6136 GB, free: 12.29 MB / 494.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.001454/0.6945, allocations: 314 kB / 0.6139 GB, free: 11.98 MB / 494.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/Fluid/Sources.mo:734:36-735:54:writable] Warning: 'each' used when modifying non-array element m_flow.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/Fluid/Sources.mo:732:36-733:54:writable] Warning: 'each' used when modifying non-array element m_flow.
Notification: Performance of NFTyping.typeBindings: time 0.004861/0.6994, allocations: 1.279 MB / 0.6151 GB, free: 10.7 MB / 494.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.002866/0.7023, allocations: 0.6309 MB / 0.6157 GB, free: 10.07 MB / 494.1 MB
Notification: Performance of NFFlatten.flatten: time 0.004724/0.707, allocations: 2.87 MB / 0.6185 GB, free: 7.195 MB / 494.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.001225/0.7083, allocations: 0.5838 MB / 0.6191 GB, free: 6.602 MB / 494.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.002013/0.7103, allocations: 0.7975 MB / 0.6199 GB, free: 5.801 MB / 494.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.001205/0.7115, allocations: 0.7121 MB / 0.6206 GB, free: 5.086 MB / 494.1 MB
Notification: Performance of NFPackage.collectConstants: time 9.138e-05/0.7116, allocations: 32 kB / 0.6206 GB, free: 5.055 MB / 494.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.001917/0.7135, allocations: 0.5651 MB / 0.6211 GB, free: 4.488 MB / 494.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.0003817/0.7139, allocations: 299.1 kB / 0.6214 GB, free: 4.195 MB / 494.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0003018/0.7142, allocations: 213.2 kB / 0.6216 GB, free: 3.98 MB / 494.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.001478/0.7157, allocations: 1.231 MB / 0.6228 GB, free: 2.746 MB / 494.1 MB
Notification: Performance of FrontEnd - DAE generated: time 9.197e-06/0.7158, allocations: 4 kB / 0.6228 GB, free: 2.742 MB / 494.1 MB
Notification: Performance of FrontEnd: time 1.883e-06/0.7158, allocations: 0 / 0.6228 GB, free: 2.742 MB / 494.1 MB
Notification: Performance of Transformations before backend: time 1.147e-05/0.7158, allocations: 0 / 0.6228 GB, free: 2.742 MB / 494.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 170
 * Number of variables: 170
Notification: Performance of Generate backend data structure: time 0.001804/0.7176, allocations: 1.143 MB / 0.624 GB, free: 1.539 MB / 494.1 MB
Notification: Performance of prepare preOptimizeDAE: time 4.026e-05/0.7176, allocations: 16.03 kB / 0.624 GB, free: 1.523 MB / 494.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001607/0.7193, allocations: 255.4 kB / 0.6242 GB, free: 1.273 MB / 494.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001021/0.7203, allocations: 0.6564 MB / 0.6249 GB, free: 0.5742 MB / 494.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 5.587e-05/0.7204, allocations: 58 kB / 0.6249 GB, free: 0.5195 MB / 494.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001077/0.7205, allocations: 75.92 kB / 0.625 GB, free: 456 kB / 494.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.00129/0.7218, allocations: 0.7587 MB / 0.6257 GB, free: 15.67 MB / 0.4981 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.159e-05/0.7218, allocations: 0 / 0.6257 GB, free: 15.67 MB / 0.4981 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 8.884e-05/0.7219, allocations: 28 kB / 0.6258 GB, free: 15.64 MB / 0.4981 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.601e-05/0.7219, allocations: 29.98 kB / 0.6258 GB, free: 15.62 MB / 0.4981 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001023/0.723, allocations: 0.57 MB / 0.6263 GB, free: 15.05 MB / 0.4981 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.004134/0.7271, allocations: 2.927 MB / 0.6292 GB, free: 11.9 MB / 0.4981 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0006275/0.7278, allocations: 414.7 kB / 0.6296 GB, free: 11.48 MB / 0.4981 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0003115/0.7281, allocations: 208.7 kB / 0.6298 GB, free: 11.28 MB / 0.4981 GB
Notification: Performance of preOpt evalFunc (simulation): time 4.095e-05/0.7281, allocations: 4 kB / 0.6298 GB, free: 11.27 MB / 0.4981 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.315e-05/0.7282, allocations: 38.56 kB / 0.6298 GB, free: 11.23 MB / 0.4981 GB
Notification: Performance of pre-optimization done (n=43): time 2.225e-06/0.7282, allocations: 4 kB / 0.6298 GB, free: 11.22 MB / 0.4981 GB
Notification: Performance of matching and sorting (n=47): time 0.002579/0.7308, allocations: 1.383 MB / 0.6312 GB, free: 9.785 MB / 0.4981 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.801e-05/0.7308, allocations: 81.55 kB / 0.6313 GB, free: 9.684 MB / 0.4981 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0007728/0.7316, allocations: 0.6214 MB / 0.6319 GB, free: 9.051 MB / 0.4981 GB
Notification: Performance of collectPreVariables (initialization): time 5.058e-05/0.7317, allocations: 45.7 kB / 0.6319 GB, free: 9 MB / 0.4981 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0002854/0.732, allocations: 372 kB / 0.6323 GB, free: 8.633 MB / 0.4981 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001537/0.7321, allocations: 165.6 kB / 0.6324 GB, free: 8.469 MB / 0.4981 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 3.34e-05/0.7322, allocations: 19.94 kB / 0.6324 GB, free: 8.449 MB / 0.4981 GB
Notification: Performance of setup shared object (initialization): time 0.0001617/0.7323, allocations: 378.7 kB / 0.6328 GB, free: 8.07 MB / 0.4981 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0003344/0.7327, allocations: 185 kB / 0.633 GB, free: 7.891 MB / 0.4981 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0004134/0.7331, allocations: 314.9 kB / 0.6333 GB, free: 7.539 MB / 0.4981 GB
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: volExa.dynBal.medium.p = volExa.dynBal.p_start (bou.p = volExa.dynBal.p_start)
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: volSim.dynBal.medium.p = volSim.dynBal.p_start (bou.p = volSim.dynBal.p_start)
Notification: Performance of analyzeInitialSystem (initialization): time 0.002431/0.7355, allocations: 1.113 MB / 0.6344 GB, free: 6.375 MB / 0.4981 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.757e-06/0.7356, allocations: 3.953 kB / 0.6344 GB, free: 6.371 MB / 0.4981 GB
Notification: Performance of matching and sorting (n=66) (initialization): time 0.001013/0.7366, allocations: 0.6734 MB / 0.635 GB, free: 5.684 MB / 0.4981 GB
Notification: Performance of prepare postOptimizeDAE: time 5.893e-05/0.7366, allocations: 63.41 kB / 0.6351 GB, free: 5.609 MB / 0.4981 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.965e-06/0.7367, allocations: 0 / 0.6351 GB, free: 5.609 MB / 0.4981 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.043e-05/0.7367, allocations: 8 kB / 0.6351 GB, free: 5.602 MB / 0.4981 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0004331/0.7371, allocations: 108.8 kB / 0.6352 GB, free: 5.496 MB / 0.4981 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.224e-05/0.7371, allocations: 8.781 kB / 0.6352 GB, free: 5.488 MB / 0.4981 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00056/0.7377, allocations: 51.84 kB / 0.6353 GB, free: 5.438 MB / 0.4981 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 4.02e-05/0.7378, allocations: 20 kB / 0.6353 GB, free: 5.418 MB / 0.4981 GB
Warning: The initial conditions are over specified. The following 2 initial equations are redundant, so they are removed from the initialization sytem:
         volExa.dynBal.medium.p = volExa.dynBal.p_start
         volSim.dynBal.medium.p = volSim.dynBal.p_start.
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 12
 * Number of states: 0 ()
 * Number of discrete variables: 2 (volSim.i_w,volExa.i_w)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (66):
 * Single equations (assignments): 64
 * Array equations: 0
 * Algorithm blocks: 2
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.0003951/0.7382, allocations: 262.3 kB / 0.6355 GB, free: 5.152 MB / 0.4981 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001205/0.7383, allocations: 79.11 kB / 0.6356 GB, free: 5.074 MB / 0.4981 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.000167/0.7385, allocations: 83.06 kB / 0.6357 GB, free: 4.984 MB / 0.4981 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 6.262e-06/0.7385, allocations: 8 kB / 0.6357 GB, free: 4.977 MB / 0.4981 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.111e-05/0.7385, allocations: 1.125 kB / 0.6357 GB, free: 4.977 MB / 0.4981 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0006586/0.7392, allocations: 0.491 MB / 0.6362 GB, free: 4.457 MB / 0.4981 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.002306/0.7415, allocations: 1.497 MB / 0.6376 GB, free: 2.859 MB / 0.4981 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.301e-06/0.7415, allocations: 4 kB / 0.6376 GB, free: 2.855 MB / 0.4981 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.000501/0.742, allocations: 111.9 kB / 0.6378 GB, free: 2.746 MB / 0.4981 GB
Notification: Performance of postOpt tearingSystem (simulation): time 1.339e-05/0.742, allocations: 8 kB / 0.6378 GB, free: 2.738 MB / 0.4981 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 3.758e-05/0.7421, allocations: 23.94 kB / 0.6378 GB, free: 2.715 MB / 0.4981 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 8.886e-06/0.7421, allocations: 8.75 kB / 0.6378 GB, free: 2.707 MB / 0.4981 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.509e-06/0.7421, allocations: 4 kB / 0.6378 GB, free: 2.703 MB / 0.4981 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.001265/0.7434, allocations: 0.8775 MB / 0.6386 GB, free: 1.766 MB / 0.4981 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0002969/0.7437, allocations: 220.2 kB / 0.6389 GB, free: 1.531 MB / 0.4981 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001074/0.7438, allocations: 19.98 kB / 0.6389 GB, free: 1.512 MB / 0.4981 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0005327/0.7443, allocations: 51.84 kB / 0.6389 GB, free: 1.461 MB / 0.4981 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 7.056e-05/0.7444, allocations: 35.91 kB / 0.639 GB, free: 1.426 MB / 0.4981 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001058/0.7445, allocations: 28.91 kB / 0.639 GB, free: 1.398 MB / 0.4981 GB
Notification: Performance of sorting global known variables: time 0.0005169/0.745, allocations: 455 kB / 0.6394 GB, free: 0.9609 MB / 0.4981 GB
Notification: Performance of sort global known variables: time 2.1e-07/0.7451, allocations: 0 / 0.6394 GB, free: 0.9609 MB / 0.4981 GB
Notification: Performance of remove unused functions: time 0.000714/0.7458, allocations: 216 kB / 0.6396 GB, free: 0.75 MB / 0.4981 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 16
 * Number of states: 4 (volSim.dynBal.U,volSim.dynBal.mXi[1],volExa.dynBal.U,volExa.dynBal.mXi[1])
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (48):
 * Single equations (assignments): 48
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.0004122/0.7462, allocations: 182.1 kB / 0.6398 GB, free: 0.5742 MB / 0.4981 GB
Notification: Performance of simCode: created initialization part: time 0.2708/1.017, allocations: 0.5502 MB / 0.6403 GB, free: 160.7 MB / 0.4981 GB
Notification: Performance of simCode: created event and clocks part: time 3.438e-05/1.017, allocations: 1.969 kB / 0.6403 GB, free: 160.7 MB / 0.4981 GB
Notification: Performance of simCode: created simulation system equations: time 0.000979/1.018, allocations: 223.5 kB / 0.6406 GB, free: 160.7 MB / 0.4981 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003127/1.021, allocations: 0.4923 MB / 0.641 GB, free: 160.7 MB / 0.4981 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.003509/1.025, allocations: 1.958 MB / 0.6429 GB, free: 159.8 MB / 0.4981 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0005578/1.025, allocations: 1.005 MB / 0.6439 GB, free: 159.1 MB / 0.4981 GB
Notification: Performance of simCode: alias equations: time 0.0008355/1.026, allocations: 170.7 kB / 0.6441 GB, free: 159 MB / 0.4981 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0001526/1.026, allocations: 63.8 kB / 0.6442 GB, free: 159 MB / 0.4981 GB
Notification: Performance of SimCode: time 1.653e-06/1.026, allocations: 0 / 0.6442 GB, free: 159 MB / 0.4981 GB
Notification: Performance of Templates: time 0.03192/1.058, allocations: 15.1 MB / 0.6589 GB, free: 158.1 MB / 0.4981 GB
make -j1 -f Annex60_1.0.0_Annex60.Fluid.MixingVolumes.Validation.MixingVolumeAdiabaticCooling.makefile
Environment - environmentSimulation:
(rm -f Annex60_1.0.0_Annex60.Fluid.MixingVolumes.Validation.MixingVolumeAdiabaticCooling.pipe ; mkfifo Annex60_1.0.0_Annex60.Fluid.MixingVolumes.Validation.MixingVolumeAdiabaticCooling.pipe ; head -c 1048576 < Annex60_1.0.0_Annex60.Fluid.MixingVolumes.Validation.MixingVolumeAdiabaticCooling.pipe >> ../files/Annex60_1.0.0_Annex60.Fluid.MixingVolumes.Validation.MixingVolumeAdiabaticCooling.sim & ./Annex60_1.0.0_Annex60.Fluid.MixingVolumes.Validation.MixingVolumeAdiabaticCooling  -abortSlowSimulation -alarm=480 -lv LOG_STATS > Annex60_1.0.0_Annex60.Fluid.MixingVolumes.Validation.MixingVolumeAdiabaticCooling.pipe 2>&1)
Environment - environmentSimulation: