Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr AixLib_AixLib.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatMoisturePort.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.0007174/0.0007174, allocations: 72.5 kB / 19.93 MB, free: 4.633 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.0006893/0.0006893, allocations: 177.9 kB / 23.21 MB, free: 1.348 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.8391/0.8391, allocations: 177.1 MB / 203.5 MB, free: 5.742 MB / 186.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/package.mo): time 0.03293/0.03293, allocations: 9.124 MB / 269.1 MB, free: 4.473 MB / 250.7 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/EmbeddedTargets/STM32F4/Functions/HAL.mo:5:3-11:14:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/OperatingSystem/DynamicArray.mo:6:3-94:18:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/Utilities/Functions.mo:1041:3-1062:27:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/Utilities/Functions.mo:1064:3-1092:25:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/SDF master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/SDF master/package.mo): time 0.00058/0.00058, allocations: 19.97 kB / 328.5 MB, free: 20.66 MB / 266.7 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/EmbeddedTargets/STM32F4/Functions/HAL.mo:5:3-11:14:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/OperatingSystem/DynamicArray.mo:6:3-94:18:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/Utilities/Functions.mo:1041:3-1062:27:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/Utilities/Functions.mo:1064:3-1092:25:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 3.0.0/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 3.0.0/package.mo): time 1.402/1.402, allocations: 275 MB / 0.6474 GB, free: 2.512 MB / 0.4949 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/EmbeddedTargets/STM32F4/Functions/HAL.mo:5:3-11:14:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/OperatingSystem/DynamicArray.mo:6:3-94:18:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/Utilities/Functions.mo:1041:3-1062:27:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/Utilities/Functions.mo:1064:3-1092:25:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 178]
Using package AixLib with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 3.0.0/package.mo)
Using package SDF with version 0.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/SDF master/package.mo)
Using package Modelica_DeviceDrivers with version 2.2.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/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(AixLib.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatMoisturePort,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="AixLib_AixLib.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatMoisturePort")
translateModel(AixLib.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatMoisturePort,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="AixLib_AixLib.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatMoisturePort") [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 1.062e-06/1.062e-06, allocations: 0.9844 kB / 0.9292 GB, free: 8.184 MB / 0.698 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.427e-05/1.533e-05, allocations: 10.22 kB / 0.9292 GB, free: 8.172 MB / 0.698 GB
Notification: Performance of NFInst.instantiate(AixLib.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatMoisturePort): time 0.1253/0.1253, allocations: 175.5 MB / 1.101 GB, free: 8.086 MB / 0.8699 GB
Notification: Performance of NFInst.instExpressions: time 0.005874/0.1311, allocations: 6.235 MB / 1.107 GB, free: 1.84 MB / 0.8699 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0005389/0.1317, allocations: 51.5 kB / 1.107 GB, free: 1.789 MB / 0.8699 GB
Notification: Performance of NFTyping.typeComponents: time 0.0008396/0.1325, allocations: 417.3 kB / 1.107 GB, free: 1.379 MB / 0.8699 GB
Notification: Performance of NFTyping.typeBindings: time 0.002412/0.1349, allocations: 1.504 MB / 1.109 GB, free: 15.87 MB / 0.8855 GB
Notification: Performance of NFTyping.typeClassSections: time 0.001202/0.1361, allocations: 0.8298 MB / 1.109 GB, free: 15.05 MB / 0.8855 GB
Notification: Performance of NFFlatten.flatten: time 0.00246/0.1386, allocations: 4.272 MB / 1.114 GB, free: 10.76 MB / 0.8855 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0008421/0.1394, allocations: 1.128 MB / 1.115 GB, free: 9.602 MB / 0.8855 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.002274/0.1417, allocations: 2.322 MB / 1.117 GB, free: 7.273 MB / 0.8855 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.00146/0.1432, allocations: 1.36 MB / 1.118 GB, free: 5.926 MB / 0.8855 GB
Notification: Performance of NFPackage.collectConstants: time 0.0001461/0.1433, allocations: 136 kB / 1.118 GB, free: 5.793 MB / 0.8855 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.001513/0.1448, allocations: 1.262 MB / 1.12 GB, free: 4.527 MB / 0.8855 GB
Notification: Performance of NFScalarize.scalarize: time 0.0003992/0.1452, allocations: 0.6465 MB / 1.12 GB, free: 3.879 MB / 0.8855 GB
Notification: Performance of NFVerifyModel.verify: time 0.0004563/0.1457, allocations: 0.6276 MB / 1.121 GB, free: 3.25 MB / 0.8855 GB
Notification: Performance of NFConvertDAE.convert: time 0.00209/0.1478, allocations: 2.887 MB / 1.124 GB, free: 364 kB / 0.8855 GB
Notification: Performance of FrontEnd - DAE generated: time 3.767e-06/0.1478, allocations: 0 / 1.124 GB, free: 364 kB / 0.8855 GB
Notification: Performance of FrontEnd: time 1.273e-06/0.1478, allocations: 3.938 kB / 1.124 GB, free: 360 kB / 0.8855 GB
Notification: Performance of Transformations before backend: time 1.489e-05/0.1478, allocations: 0 / 1.124 GB, free: 360 kB / 0.8855 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 262
 * Number of variables: 262
Notification: Performance of Generate backend data structure: time 0.001822/0.1496, allocations: 1.943 MB / 1.126 GB, free: 14.36 MB / 0.9012 GB
Notification: Performance of prepare preOptimizeDAE: time 3.423e-05/0.1497, allocations: 11.98 kB / 1.126 GB, free: 14.35 MB / 0.9012 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001608/0.1513, allocations: 0.5025 MB / 1.126 GB, free: 13.85 MB / 0.9012 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001308/0.1526, allocations: 1.256 MB / 1.127 GB, free: 12.54 MB / 0.9012 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 4.083e-05/0.1526, allocations: 82.06 kB / 1.127 GB, free: 12.46 MB / 0.9012 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001132/0.1527, allocations: 111.9 kB / 1.128 GB, free: 12.35 MB / 0.9012 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001652/0.1544, allocations: 1.714 MB / 1.129 GB, free: 10.53 MB / 0.9012 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.15e-05/0.1544, allocations: 4 kB / 1.129 GB, free: 10.53 MB / 0.9012 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 6.791e-05/0.1545, allocations: 40 kB / 1.129 GB, free: 10.49 MB / 0.9012 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.372e-05/0.1545, allocations: 49.98 kB / 1.129 GB, free: 10.44 MB / 0.9012 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001253/0.1557, allocations: 1.343 MB / 1.131 GB, free: 9.086 MB / 0.9012 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.003153/0.1589, allocations: 3.156 MB / 1.134 GB, free: 5.879 MB / 0.9012 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0009157/0.1598, allocations: 0.9559 MB / 1.135 GB, free: 4.914 MB / 0.9012 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0004833/0.1603, allocations: 0.5765 MB / 1.135 GB, free: 4.34 MB / 0.9012 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001285/0.1604, allocations: 44.62 kB / 1.135 GB, free: 4.297 MB / 0.9012 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.502e-05/0.1605, allocations: 55.14 kB / 1.135 GB, free: 4.234 MB / 0.9012 GB
Notification: Performance of pre-optimization done (n=81): time 1.944e-06/0.1605, allocations: 0 / 1.135 GB, free: 4.234 MB / 0.9012 GB
Notification: Performance of matching and sorting (n=84): time 0.003391/0.1638, allocations: 3.081 MB / 1.138 GB, free: 1.125 MB / 0.9012 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.05e-05/0.1639, allocations: 64.39 kB / 1.138 GB, free: 1.047 MB / 0.9012 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0006872/0.1646, allocations: 0.9484 MB / 1.139 GB, free: 76 kB / 0.9012 GB
Notification: Performance of collectPreVariables (initialization): time 4.608e-05/0.1646, allocations: 45.7 kB / 1.139 GB, free: 24 kB / 0.9012 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0002662/0.1649, allocations: 0.5595 MB / 1.14 GB, free: 15.46 MB / 0.9168 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001701/0.165, allocations: 314 kB / 1.14 GB, free: 15.15 MB / 0.9168 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.000148/0.1652, allocations: 162.6 kB / 1.14 GB, free: 14.98 MB / 0.9168 GB
Notification: Performance of setup shared object (initialization): time 7.824e-05/0.1653, allocations: 341.9 kB / 1.141 GB, free: 14.64 MB / 0.9168 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0004063/0.1657, allocations: 472.5 kB / 1.141 GB, free: 14.18 MB / 0.9168 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0005573/0.1662, allocations: 0.8914 MB / 1.142 GB, free: 13.17 MB / 0.9168 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0009087/0.1671, allocations: 1.103 MB / 1.143 GB, free: 12.04 MB / 0.9168 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.933e-06/0.1671, allocations: 0 / 1.143 GB, free: 12.04 MB / 0.9168 GB
Notification: Performance of matching and sorting (n=97) (initialization): time 0.001217/0.1684, allocations: 1.274 MB / 1.144 GB, free: 10.76 MB / 0.9168 GB
Notification: Performance of prepare postOptimizeDAE: time 1.539e-05/0.1684, allocations: 8 kB / 1.144 GB, free: 10.75 MB / 0.9168 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.101e-06/0.1684, allocations: 3.938 kB / 1.144 GB, free: 10.75 MB / 0.9168 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0001511/0.1685, allocations: 77.06 kB / 1.144 GB, free: 10.67 MB / 0.9168 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0005093/0.169, allocations: 199.7 kB / 1.145 GB, free: 10.47 MB / 0.9168 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001396/0.1704, allocations: 3.052 MB / 1.148 GB, free: 7.277 MB / 0.9168 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0004705/0.1709, allocations: 85.5 kB / 1.148 GB, free: 7.195 MB / 0.9168 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 4.404e-05/0.171, allocations: 28 kB / 1.148 GB, free: 7.168 MB / 0.9168 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.0007398/0.1717, allocations: 0.9271 MB / 1.149 GB, free: 6.234 MB / 0.9168 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0005416/0.1722, allocations: 0.8896 MB / 1.149 GB, free: 5.23 MB / 0.9168 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001117/0.1734, allocations: 1.092 MB / 1.15 GB, free: 4.109 MB / 0.9168 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.593e-06/0.1734, allocations: 3.938 kB / 1.15 GB, free: 4.105 MB / 0.9168 GB
Notification: Performance of matching and sorting (n=97) (initialization_lambda0): time 0.001093/0.1745, allocations: 1.274 MB / 1.152 GB, free: 2.82 MB / 0.9168 GB
Notification: Performance of prepare postOptimizeDAE: time 8.486e-06/0.1745, allocations: 11.98 kB / 1.152 GB, free: 2.809 MB / 0.9168 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.825e-06/0.1745, allocations: 0 / 1.152 GB, free: 2.809 MB / 0.9168 GB
Notification: Performance of postOpt tearingSystem (initialization): time 9.77e-05/0.1746, allocations: 72.81 kB / 1.152 GB, free: 2.734 MB / 0.9168 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0003432/0.1749, allocations: 171.7 kB / 1.152 GB, free: 2.566 MB / 0.9168 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0009353/0.1758, allocations: 1.876 MB / 1.154 GB, free: 0.5859 MB / 0.9168 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0004577/0.1763, allocations: 81.58 kB / 1.154 GB, free: 0.5078 MB / 0.9168 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 3.815e-05/0.1763, allocations: 27.98 kB / 1.154 GB, free: 492 kB / 0.9168 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 9
 * 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 (92):
 * Single equations (assignments): 89
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 2
 * Torn equation systems: 1
 * 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): 2 systems
   {1, 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,5,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.0001371/0.1765, allocations: 232 kB / 1.154 GB, free: 252 kB / 0.9168 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001023/0.1766, allocations: 115.3 kB / 1.154 GB, free: 136 kB / 0.9168 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001117/0.1777, allocations: 1.255 MB / 1.155 GB, free: 14.87 MB / 0.9324 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 4.839e-06/0.1777, allocations: 11.94 kB / 1.155 GB, free: 14.86 MB / 0.9324 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 4.168e-06/0.1777, allocations: 4 kB / 1.155 GB, free: 14.85 MB / 0.9324 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0009482/0.1786, allocations: 1.292 MB / 1.157 GB, free: 13.49 MB / 0.9324 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.002493/0.1811, allocations: 2.587 MB / 1.159 GB, free: 10.84 MB / 0.9324 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.236e-06/0.1811, allocations: 7.938 kB / 1.159 GB, free: 10.83 MB / 0.9324 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0005009/0.1816, allocations: 235.8 kB / 1.159 GB, free: 10.6 MB / 0.9324 GB
Notification: Performance of postOpt tearingSystem (simulation): time 9.74e-05/0.1817, allocations: 80.73 kB / 1.16 GB, free: 10.52 MB / 0.9324 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 3.669e-05/0.1818, allocations: 23.98 kB / 1.16 GB, free: 10.5 MB / 0.9324 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001229/0.183, allocations: 3.04 MB / 1.163 GB, free: 7.309 MB / 0.9324 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.493e-06/0.183, allocations: 4.031 kB / 1.163 GB, free: 7.305 MB / 0.9324 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.001771/0.1848, allocations: 1.932 MB / 1.164 GB, free: 5.328 MB / 0.9324 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003101/0.1851, allocations: 267.2 kB / 1.165 GB, free: 5.066 MB / 0.9324 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 6.682e-05/0.1852, allocations: 23.98 kB / 1.165 GB, free: 5.043 MB / 0.9324 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0003843/0.1855, allocations: 67.5 kB / 1.165 GB, free: 4.98 MB / 0.9324 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 6.407e-05/0.1856, allocations: 56.56 kB / 1.165 GB, free: 4.926 MB / 0.9324 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 3.396e-05/0.1856, allocations: 27.98 kB / 1.165 GB, free: 4.898 MB / 0.9324 GB
Notification: Performance of sorting global known variables: time 0.0004994/0.1861, allocations: 0.6794 MB / 1.166 GB, free: 4.207 MB / 0.9324 GB
Notification: Performance of sort global known variables: time 8.1e-08/0.1861, allocations: 0 / 1.166 GB, free: 4.207 MB / 0.9324 GB
Notification: Performance of remove unused functions: time 0.0008762/0.187, allocations: 0.664 MB / 1.166 GB, free: 3.543 MB / 0.9324 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 9
 * Number of states: 7 (vol[1].dynBal.medium.Xi[1],vol[1].dynBal.U,vol[2].dynBal.medium.Xi[1],vol[2].dynBal.U,vol[3].dynBal.medium.Xi[1],vol[3].dynBal.U,vol[3].dynBal.m)
 * 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 (79):
 * Single equations (assignments): 76
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 2
 * Torn equation systems: 1
 * 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): 2 systems
   {1, 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,5,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of Backend phase and start with SimCode phase: time 0.0002562/0.1873, allocations: 211 kB / 1.166 GB, free: 3.328 MB / 0.9324 GB
Notification: Performance of simCode: created initialization part: time 0.001727/0.189, allocations: 1.899 MB / 1.168 GB, free: 1.406 MB / 0.9324 GB
Notification: Performance of simCode: created event and clocks part: time 2.334e-06/0.189, allocations: 0 / 1.168 GB, free: 1.406 MB / 0.9324 GB
Notification: Performance of simCode: created simulation system equations: time 0.0005276/0.1895, allocations: 0.6776 MB / 1.169 GB, free: 0.7109 MB / 0.9324 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.2888/0.4783, allocations: 0.7726 MB / 1.17 GB, free: 243.3 MB / 0.9324 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.003324/0.4816, allocations: 3.1 MB / 1.173 GB, free: 242.4 MB / 0.9324 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0007401/0.4824, allocations: 0.8617 MB / 1.174 GB, free: 242.2 MB / 0.9324 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0002307/0.4826, allocations: 94.09 kB / 1.174 GB, free: 242.2 MB / 0.9324 GB
Notification: Performance of SimCode: time 1.333e-06/0.4826, allocations: 2.906 kB / 1.174 GB, free: 242.2 MB / 0.9324 GB
Notification: Performance of Templates: time 0.02513/0.5077, allocations: 45.23 MB / 1.218 GB, free: 207.2 MB / 0.9324 GB
"
[Timeout remaining time 659]
make -j1 -f AixLib_AixLib.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatMoisturePort.makefile [Timeout 660]
(rm -f AixLib_AixLib.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatMoisturePort.pipe ; mkfifo AixLib_AixLib.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatMoisturePort.pipe ; head -c 1048576 < AixLib_AixLib.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatMoisturePort.pipe >> ../files/AixLib_AixLib.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatMoisturePort.sim & ./AixLib_AixLib.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatMoisturePort  -abortSlowSimulation -alarm=480 -lv LOG_STATS > AixLib_AixLib.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatMoisturePort.pipe 2>&1) [Timeout 480]
[Calling sys.exit(0), Time elapsed: 10.526508652605116]
Failed to read output from testmodel.py, exit status != 0:
0.512481577694416 0.517622666 0.36860652000000005
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f7249f60710>