Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_trunk_Modelica.Fluid.Examples.HeatExchanger.HeatExchangerSimulation.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.001871/0.001871, allocations: 110 kB / 20.43 MB, free: 1.453 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.002813/0.002813, allocations: 213.6 kB / 23.74 MB, free: 4.66 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 1.485/1.485, allocations: 230.5 MB / 257.4 MB, free: 8.004 MB / 206.1 MB
"
[Timeout remaining time 178]
Using package Modelica with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo)
Using package Complex with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo)
Using package ModelicaServices with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo)
Running command: "" <> buildModelFMU(Modelica.Fluid.Examples.HeatExchanger.HeatExchangerSimulation,fileNamePrefix="Modelica_trunk_Modelica_Fluid_Examples_HeatExchanger_HeatExchangerSimulation",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(Modelica.Fluid.Examples.HeatExchanger.HeatExchangerSimulation,fileNamePrefix="Modelica_trunk_Modelica_Fluid_Examples_HeatExchanger_HeatExchangerSimulation",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 0.001911/0.001911, allocations: 56.09 kB / 377.8 MB, free: 3.023 MB / 302.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3151/0.317, allocations: 53.41 MB / 431.2 MB, free: 6.984 MB / 334.1 MB
Notification: Performance of NFInst.instantiate(Modelica.Fluid.Examples.HeatExchanger.HeatExchangerSimulation): time 0.09435/0.4114, allocations: 84.58 MB / 0.5037 GB, free: 2.125 MB / 414.1 MB
Notification: Performance of NFInst.instExpressions: time 0.5793/0.9907, allocations: 183 MB / 0.6823 GB, free: 10.77 MB / 0.5137 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003078/0.9937, allocations: 87.25 kB / 0.6824 GB, free: 10.69 MB / 0.5137 GB
Notification: Performance of NFTyping.typeComponents: time 0.00382/0.9976, allocations: 0.998 MB / 0.6834 GB, free: 9.684 MB / 0.5137 GB
Notification: Performance of NFTyping.typeBindings: time 0.01285/1.01, allocations: 4.607 MB / 0.6879 GB, free: 5.074 MB / 0.5137 GB
Notification: Performance of NFTyping.typeClassSections: time 0.02712/1.038, allocations: 10.1 MB / 0.6978 GB, free: 10.99 MB / 0.5294 GB
Notification: Performance of NFFlatten.flatten: time 0.02884/1.066, allocations: 24.86 MB / 0.722 GB, free: 2.074 MB / 0.545 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.01041/1.077, allocations: 5.789 MB / 0.7277 GB, free: 12.23 MB / 0.5606 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.03061/1.107, allocations: 14.65 MB / 0.742 GB, free: 13.46 MB / 0.5762 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.4102/1.518, allocations: 15.62 MB / 0.7573 GB, free: 32.17 MB / 0.5762 GB
Notification: Performance of NFPackage.collectConstants: time 0.005639/1.523, allocations: 1.728 MB / 0.7589 GB, free: 32.17 MB / 0.5762 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02641/1.55, allocations: 10.92 MB / 0.7696 GB, free: 32.17 MB / 0.5762 GB
Notification: Performance of NFScalarize.scalarize: time 0.009383/1.559, allocations: 6.216 MB / 0.7757 GB, free: 32.17 MB / 0.5762 GB
Notification: Performance of NFVerifyModel.verify: time 0.02178/1.581, allocations: 8.716 MB / 0.7842 GB, free: 31.38 MB / 0.5762 GB
Notification: Performance of NFConvertDAE.convert: time 0.05195/1.633, allocations: 31.5 MB / 0.8149 GB, free: 25.59 MB / 0.5762 GB
Notification: Performance of FrontEnd - DAE generated: time 7.995e-06/1.633, allocations: 4.625 kB / 0.815 GB, free: 25.59 MB / 0.5762 GB
Notification: Performance of FrontEnd: time 1.733e-06/1.633, allocations: 0 / 0.815 GB, free: 25.59 MB / 0.5762 GB
Notification: Performance of Transformations before backend: time 0.001089/1.634, allocations: 1.031 kB / 0.815 GB, free: 25.59 MB / 0.5762 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 3731
 * Number of variables: 3731
Notification: Performance of Generate backend data structure: time 0.1667/1.801, allocations: 38.74 MB / 0.8528 GB, free: 2.77 MB / 0.5762 GB
Notification: Performance of prepare preOptimizeDAE: time 4.348e-05/1.801, allocations: 8.031 kB / 0.8528 GB, free: 2.762 MB / 0.5762 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.00844/1.809, allocations: 1.789 MB / 0.8545 GB, free: 0.9688 MB / 0.5762 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.02633/1.835, allocations: 3.341 MB / 0.8578 GB, free: 13.62 MB / 0.5919 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.02933/1.865, allocations: 9.852 MB / 0.8674 GB, free: 4.082 MB / 0.5919 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.00121/1.866, allocations: 0.8372 MB / 0.8682 GB, free: 3.25 MB / 0.5919 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.008727/1.875, allocations: 1.084 MB / 0.8693 GB, free: 2.176 MB / 0.5919 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.07179/1.946, allocations: 26.54 MB / 0.8952 GB, free: 7.148 MB / 0.6231 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.000586/1.947, allocations: 54.17 kB / 0.8953 GB, free: 7.113 MB / 0.6231 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.007413/1.954, allocations: 440.9 kB / 0.8957 GB, free: 6.691 MB / 0.6231 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.002168/1.957, allocations: 1.975 MB / 0.8976 GB, free: 4.715 MB / 0.6231 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.07838/2.035, allocations: 26.68 MB / 0.9237 GB, free: 10.14 MB / 0.6544 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.5816/2.617, allocations: 106.8 MB / 1.028 GB, free: 201.3 MB / 0.7481 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.03384/2.65, allocations: 15.85 MB / 1.043 GB, free: 200.8 MB / 0.7481 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01671/2.667, allocations: 9.129 MB / 1.052 GB, free: 200.8 MB / 0.7481 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.08768/2.755, allocations: 26.63 MB / 1.078 GB, free: 199.7 MB / 0.7481 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0002004/2.755, allocations: 169.2 kB / 1.079 GB, free: 199.7 MB / 0.7481 GB
Notification: Performance of pre-optimization done (n=1173): time 1.316e-05/2.755, allocations: 0 / 1.079 GB, free: 199.7 MB / 0.7481 GB
Notification: Performance of matching and sorting (n=1373): time 0.1849/2.94, allocations: 72.18 MB / 1.149 GB, free: 151.7 MB / 0.7481 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002491/2.94, allocations: 0.7959 MB / 1.15 GB, free: 150.8 MB / 0.7481 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0139/2.954, allocations: 7.454 MB / 1.157 GB, free: 143.3 MB / 0.7481 GB
Notification: Performance of collectPreVariables (initialization): time 0.004414/2.958, allocations: 273.7 kB / 1.157 GB, free: 143 MB / 0.7481 GB
Notification: Performance of collectInitialEqns (initialization): time 0.003541/2.962, allocations: 5.007 MB / 1.162 GB, free: 138.1 MB / 0.7481 GB
Notification: Performance of collectInitialBindings (initialization): time 0.007168/2.969, allocations: 5.058 MB / 1.167 GB, free: 133.1 MB / 0.7481 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.01241/2.982, allocations: 3.137 MB / 1.17 GB, free: 129.9 MB / 0.7481 GB
Notification: Performance of setup shared object (initialization): time 5.893e-05/2.982, allocations: 309.1 kB / 1.171 GB, free: 129.6 MB / 0.7481 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01839/3, allocations: 11.39 MB / 1.182 GB, free: 118.2 MB / 0.7481 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.02376/3.024, allocations: 14.72 MB / 1.196 GB, free: 102.3 MB / 0.7481 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.03868/3.062, allocations: 26.63 MB / 1.222 GB, free: 74.76 MB / 0.7481 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.006e-05/3.063, allocations: 27.06 kB / 1.222 GB, free: 74.74 MB / 0.7481 GB
Notification: Performance of matching and sorting (n=1986) (initialization): time 0.06852/3.131, allocations: 36.94 MB / 1.258 GB, free: 38.2 MB / 0.7481 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001007/3.131, allocations: 52.23 kB / 1.258 GB, free: 38.15 MB / 0.7481 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001235/3.131, allocations: 84 kB / 1.258 GB, free: 38.07 MB / 0.7481 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.5508/3.682, allocations: 85.96 MB / 1.342 GB, free: 316.2 MB / 0.7481 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.006613/3.689, allocations: 1.689 MB / 1.344 GB, free: 314.9 MB / 0.7481 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0805/3.769, allocations: 39.84 MB / 1.383 GB, free: 286.4 MB / 0.7481 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0163/3.786, allocations: 0.804 MB / 1.384 GB, free: 285.6 MB / 0.7481 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.005248/3.791, allocations: 0.7068 MB / 1.384 GB, free: 284.9 MB / 0.7481 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.02948/3.82, allocations: 14.62 MB / 1.399 GB, free: 270.2 MB / 0.7481 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.02152/3.842, allocations: 13.93 MB / 1.412 GB, free: 255.1 MB / 0.7481 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.03854/3.88, allocations: 25.04 MB / 1.437 GB, free: 228.8 MB / 0.7481 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 9.795e-05/3.88, allocations: 24 kB / 1.437 GB, free: 228.7 MB / 0.7481 GB
Notification: Performance of matching and sorting (n=1986) (initialization_lambda0): time 0.06907/3.949, allocations: 34.29 MB / 1.47 GB, free: 194.8 MB / 0.7481 GB
Notification: Performance of prepare postOptimizeDAE: time 9.155e-05/3.95, allocations: 43.56 kB / 1.47 GB, free: 194.8 MB / 0.7481 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001211/3.95, allocations: 91.98 kB / 1.47 GB, free: 194.7 MB / 0.7481 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.2203/4.17, allocations: 49.41 MB / 1.518 GB, free: 145.2 MB / 0.7481 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.006989/4.177, allocations: 1.769 MB / 1.52 GB, free: 143.4 MB / 0.7481 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.06326/4.24, allocations: 36.29 MB / 1.556 GB, free: 107.2 MB / 0.7481 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01402/4.254, allocations: 0.781 MB / 1.556 GB, free: 106.4 MB / 0.7481 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004415/4.259, allocations: 0.6795 MB / 1.557 GB, free: 105.7 MB / 0.7481 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 390
 * Number of states: 0 ()
 * Number of discrete variables: 48 (HEX.pipe_2.mediums[20].phase,HEX.pipe_2.mediums[19].phase,HEX.pipe_2.mediums[18].phase,HEX.pipe_2.mediums[17].phase,HEX.pipe_2.mediums[16].phase,HEX.pipe_2.mediums[15].phase,HEX.pipe_2.mediums[14].phase,HEX.pipe_2.mediums[13].phase,HEX.pipe_2.mediums[12].phase,HEX.pipe_2.mediums[11].phase,HEX.pipe_2.mediums[10].phase,HEX.pipe_2.mediums[9].phase,HEX.pipe_2.mediums[8].phase,HEX.pipe_2.mediums[7].phase,HEX.pipe_2.mediums[6].phase,HEX.pipe_2.mediums[5].phase,HEX.pipe_2.mediums[4].phase,HEX.pipe_2.mediums[3].phase,HEX.pipe_2.mediums[2].phase,HEX.pipe_2.mediums[1].phase,HEX.pipe_2.state_a.phase,HEX.pipe_1.mediums[20].phase,HEX.pipe_1.mediums[19].phase,HEX.pipe_1.mediums[18].phase,HEX.pipe_1.mediums[17].phase,HEX.pipe_1.mediums[16].phase,HEX.pipe_1.mediums[15].phase,HEX.pipe_1.mediums[14].phase,HEX.pipe_1.mediums[13].phase,HEX.pipe_1.mediums[12].phase,HEX.pipe_1.mediums[11].phase,HEX.pipe_1.mediums[10].phase,HEX.pipe_1.mediums[9].phase,HEX.pipe_1.mediums[8].phase,HEX.pipe_1.mediums[7].phase,HEX.pipe_1.mediums[6].phase,HEX.pipe_1.mediums[5].phase,HEX.pipe_1.mediums[4].phase,HEX.pipe_1.mediums[3].phase,HEX.pipe_1.mediums[2].phase,HEX.pipe_1.mediums[1].phase,HEX.pipe_1.state_b.phase,massFlowRate1.medium.phase,massFlowRate2.medium.phase,ambient1.medium.phase,ambient2.medium.phase,HEX.pipe_2.state_b.phase,HEX.pipe_1.state_a.phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (923):
 * Single equations (assignments): 922
 * Array equations: 0
 * 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
   {(100,964)}
Notification: Performance of prepare postOptimizeDAE: time 0.007759/4.266, allocations: 1.013 MB / 1.558 GB, free: 104.8 MB / 0.7481 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.005078/4.271, allocations: 0.9595 MB / 1.559 GB, free: 104.3 MB / 0.7481 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.08285/4.354, allocations: 43.8 MB / 1.602 GB, free: 60.54 MB / 0.7481 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0002814/4.355, allocations: 279.7 kB / 1.602 GB, free: 60.26 MB / 0.7481 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 8.969e-05/4.355, allocations: 12 kB / 1.602 GB, free: 60.25 MB / 0.7481 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.3515/4.706, allocations: 38.13 MB / 1.639 GB, free: 340.5 MB / 0.7481 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.126/4.832, allocations: 68.31 MB / 1.706 GB, free: 308.3 MB / 0.7481 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0001766/4.832, allocations: 4 kB / 1.706 GB, free: 308.3 MB / 0.7481 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.01595/4.848, allocations: 2.89 MB / 1.709 GB, free: 305.9 MB / 0.7481 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.06474/4.913, allocations: 14.57 MB / 1.723 GB, free: 292.1 MB / 0.7481 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.00483/4.918, allocations: 0.5658 MB / 1.724 GB, free: 291.5 MB / 0.7481 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.04964/4.968, allocations: 87.38 MB / 1.809 GB, free: 199.3 MB / 0.7481 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.833e-06/4.968, allocations: 7.969 kB / 1.809 GB, free: 199.3 MB / 0.7481 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.08564/5.053, allocations: 53.49 MB / 1.861 GB, free: 146.2 MB / 0.7481 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.003914/5.057, allocations: 1.449 MB / 1.863 GB, free: 144.8 MB / 0.7481 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.005652/5.063, allocations: 455.7 kB / 1.863 GB, free: 144.3 MB / 0.7481 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01116/5.074, allocations: 0.5684 MB / 1.864 GB, free: 143.8 MB / 0.7481 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.003985/5.078, allocations: 0.9609 MB / 1.864 GB, free: 142.9 MB / 0.7481 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.002863/5.081, allocations: 499.7 kB / 1.865 GB, free: 142.4 MB / 0.7481 GB
Notification: Performance of sorting global known variables: time 0.007401/5.088, allocations: 5.076 MB / 1.87 GB, free: 137.3 MB / 0.7481 GB
Notification: Performance of sort global known variables: time 1.71e-07/5.088, allocations: 0 / 1.87 GB, free: 137.3 MB / 0.7481 GB
Notification: Performance of remove unused functions: time 0.03781/5.126, allocations: 8.797 MB / 1.879 GB, free: 128.5 MB / 0.7481 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 100 (HEX.wall.T[1],HEX.wall.T[2],HEX.wall.T[3],HEX.wall.T[4],HEX.wall.T[5],HEX.wall.T[6],HEX.wall.T[7],HEX.wall.T[8],HEX.wall.T[9],HEX.wall.T[10],HEX.wall.T[11],HEX.wall.T[12],HEX.wall.T[13],HEX.wall.T[14],HEX.wall.T[15],HEX.wall.T[16],HEX.wall.T[17],HEX.wall.T[18],HEX.wall.T[19],HEX.wall.T[20],HEX.pipe_1.mediums[1].p,HEX.pipe_1.mediums[1].T,HEX.pipe_1.mediums[2].p,HEX.pipe_1.mediums[2].T,HEX.pipe_1.mediums[3].p,HEX.pipe_1.mediums[3].T,HEX.pipe_1.mediums[4].p,HEX.pipe_1.mediums[4].T,HEX.pipe_1.mediums[5].p,HEX.pipe_1.mediums[5].T,HEX.pipe_1.mediums[6].p,HEX.pipe_1.mediums[6].T,HEX.pipe_1.mediums[7].p,HEX.pipe_1.mediums[7].T,HEX.pipe_1.mediums[8].p,HEX.pipe_1.mediums[8].T,HEX.pipe_1.mediums[9].p,HEX.pipe_1.mediums[9].T,HEX.pipe_1.mediums[10].p,HEX.pipe_1.mediums[10].T,HEX.pipe_1.mediums[11].p,HEX.pipe_1.mediums[11].T,HEX.pipe_1.mediums[12].p,HEX.pipe_1.mediums[12].T,HEX.pipe_1.mediums[13].p,HEX.pipe_1.mediums[13].T,HEX.pipe_1.mediums[14].p,HEX.pipe_1.mediums[14].T,HEX.pipe_1.mediums[15].p,HEX.pipe_1.mediums[15].T,HEX.pipe_1.mediums[16].p,HEX.pipe_1.mediums[16].T,HEX.pipe_1.mediums[17].p,HEX.pipe_1.mediums[17].T,HEX.pipe_1.mediums[18].p,HEX.pipe_1.mediums[18].T,HEX.pipe_1.mediums[19].p,HEX.pipe_1.mediums[19].T,HEX.pipe_1.mediums[20].p,HEX.pipe_1.mediums[20].T,HEX.pipe_2.mediums[1].p,HEX.pipe_2.mediums[1].T,HEX.pipe_2.mediums[2].p,HEX.pipe_2.mediums[2].T,HEX.pipe_2.mediums[3].p,HEX.pipe_2.mediums[3].T,HEX.pipe_2.mediums[4].p,HEX.pipe_2.mediums[4].T,HEX.pipe_2.mediums[5].p,HEX.pipe_2.mediums[5].T,HEX.pipe_2.mediums[6].p,HEX.pipe_2.mediums[6].T,HEX.pipe_2.mediums[7].p,HEX.pipe_2.mediums[7].T,HEX.pipe_2.mediums[8].p,HEX.pipe_2.mediums[8].T,HEX.pipe_2.mediums[9].p,HEX.pipe_2.mediums[9].T,HEX.pipe_2.mediums[10].p,HEX.pipe_2.mediums[10].T,HEX.pipe_2.mediums[11].p,HEX.pipe_2.mediums[11].T,HEX.pipe_2.mediums[12].p,HEX.pipe_2.mediums[12].T,HEX.pipe_2.mediums[13].p,HEX.pipe_2.mediums[13].T,HEX.pipe_2.mediums[14].p,HEX.pipe_2.mediums[14].T,HEX.pipe_2.mediums[15].p,HEX.pipe_2.mediums[15].T,HEX.pipe_2.mediums[16].p,HEX.pipe_2.mediums[16].T,HEX.pipe_2.mediums[17].p,HEX.pipe_2.mediums[17].T,HEX.pipe_2.mediums[18].p,HEX.pipe_2.mediums[18].T,HEX.pipe_2.mediums[19].p,HEX.pipe_2.mediums[19].T,HEX.pipe_2.mediums[20].p,HEX.pipe_2.mediums[20].T)
 * Number of discrete variables: 92 ($cse1.phase,$cse1.region,$cse2.phase,$cse2.region,$cse3.phase,$cse3.region,$cse4.phase,$cse4.region,$cse5.phase,$cse5.region,$cse6.phase,$cse6.region,$cse7.phase,$cse7.region,$cse8.phase,$cse8.region,$cse9.phase,$cse9.region,$cse10.phase,$cse10.region,$cse11.phase,$cse11.region,$cse12.phase,$cse12.region,$cse13.phase,$cse13.region,$cse14.phase,$cse14.region,$cse15.phase,$cse15.region,$cse16.phase,$cse16.region,$cse17.phase,$cse17.region,$cse18.phase,$cse18.region,$cse19.phase,$cse19.region,$cse20.phase,$cse20.region,$cse81.phase,$cse81.region,$cse82.phase,$cse82.region,$cse83.phase,$cse83.region,$cse84.phase,$cse84.region,$cse85.phase,$cse85.region,$cse86.phase,$cse86.region,$cse87.phase,$cse87.region,$cse88.phase,$cse88.region,$cse89.phase,$cse89.region,$cse90.phase,$cse90.region,$cse91.phase,$cse91.region,$cse92.phase,$cse92.region,$cse93.phase,$cse93.region,$cse94.phase,$cse94.region,$cse95.phase,$cse95.region,$cse96.phase,$cse96.region,$cse97.phase,$cse97.region,$cse98.phase,$cse98.region,$cse99.phase,$cse99.region,$cse100.phase,$cse100.region,$cse101.phase,$cse101.region,$cse102.phase,$cse102.region,$cse123.phase,$cse123.region,$cse124.phase,$cse124.region,$cse127.phase,$cse127.region,$cse128.phase,$cse128.region)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (1379):
 * Single equations (assignments): 1253
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 46
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 80
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 40 systems
   {(1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 40 systems
   {(2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.09774/5.224, allocations: 56.29 MB / 1.933 GB, free: 72.07 MB / 0.7481 GB
Notification: Performance of simCode: created initialization part: time 0.09512/5.319, allocations: 44.99 MB / 1.977 GB, free: 27.11 MB / 0.7481 GB
Notification: Performance of simCode: created event and clocks part: time 1.395e-05/5.319, allocations: 5.969 kB / 1.977 GB, free: 27.11 MB / 0.7481 GB
Notification: Performance of simCode: created simulation system equations: time 0.03331/5.352, allocations: 21 MB / 1.998 GB, free: 5.598 MB / 0.7481 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.02879/5.381, allocations: 4.251 MB / 2.002 GB, free: 1.387 MB / 0.7481 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.6178/5.999, allocations: 175.7 MB / 2.174 GB, free: 222.7 MB / 0.7481 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.01254/6.011, allocations: 8.596 MB / 2.182 GB, free: 214.1 MB / 0.7481 GB
Notification: Performance of simCode: alias equations: time 0.01992/6.031, allocations: 7.023 MB / 2.189 GB, free: 207.1 MB / 0.7481 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.01193/6.043, allocations: 6.162 MB / 2.195 GB, free: 201 MB / 0.7481 GB
Notification: Performance of SimCode: time 1.303e-06/6.043, allocations: 0 / 2.195 GB, free: 201 MB / 0.7481 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 1.641/7.684, allocations: 0.638 GB / 2.833 GB, free: 197.1 MB / 0.7482 GB
Notification: Performance of buildModelFMU: Generate platform static: time 71.93/79.62, allocations: 0 / 2.833 GB, free: 197.1 MB / 0.7482 GB
"
[Timeout remaining time 580]
(rm -f Modelica_trunk_Modelica.Fluid.Examples.HeatExchanger.HeatExchangerSimulation.pipe ; mkfifo Modelica_trunk_Modelica.Fluid.Examples.HeatExchanger.HeatExchangerSimulation.pipe ; head -c 1048576 < Modelica_trunk_Modelica.Fluid.Examples.HeatExchanger.HeatExchangerSimulation.pipe >> ../files/Modelica_trunk_Modelica.Fluid.Examples.HeatExchanger.HeatExchangerSimulation.sim & python3 -m fmpy simulate  --output-file Modelica_trunk_Modelica.Fluid.Examples.HeatExchanger.HeatExchangerSimulation_res.csv --start-time 0 --stop-time 200 --timeout 50 --relative-tolerance 1e-05 --interface-type ModelExchange --solver CVode --output-interval 0.039968 Modelica_trunk_Modelica_Fluid_Examples_HeatExchanger_HeatExchangerSimulation.fmu > Modelica_trunk_Modelica.Fluid.Examples.HeatExchanger.HeatExchangerSimulation.pipe 2>&1) [Timeout 52.5]
[Calling os._exit(0), Time elapsed: 82.72412582499965]
Failed to read output from testmodel.py, exit status != 0:
['time', 'HEX.pipe_1.mediums[10].T', 'HEX.pipe_1.mediums[10].p', 'HEX.pipe_1.mediums[11].T', 'HEX.pipe_1.mediums[11].p', 'HEX.pipe_1.mediums[12].T', 'HEX.pipe_1.mediums[12].p', 'HEX.pipe_1.mediums[13].T', 'HEX.pipe_1.mediums[13].p', 'HEX.pipe_1.mediums[14].T', 'HEX.pipe_1.mediums[14].p', 'HEX.pipe_1.mediums[15].T', 'HEX.pipe_1.mediums[15].p', 'HEX.pipe_1.mediums[16].T', 'HEX.pipe_1.mediums[16].p', 'HEX.pipe_1.mediums[17].T', 'HEX.pipe_1.mediums[17].p', 'HEX.pipe_1.mediums[18].T', 'HEX.pipe_1.mediums[18].p', 'HEX.pipe_1.mediums[19].T', 'HEX.pipe_1.mediums[19].p', 'HEX.pipe_1.mediums[1].T', 'HEX.pipe_1.mediums[1].p', 'HEX.pipe_1.mediums[20].T', 'HEX.pipe_1.mediums[20].p', 'HEX.pipe_1.mediums[2].T', 'HEX.pipe_1.mediums[2].p', 'HEX.pipe_1.mediums[3].T', 'HEX.pipe_1.mediums[3].p', 'HEX.pipe_1.mediums[4].T', 'HEX.pipe_1.mediums[4].p', 'HEX.pipe_1.mediums[5].T', 'HEX.pipe_1.mediums[5].p', 'HEX.pipe_1.mediums[6].T', 'HEX.pipe_1.mediums[6].p', 'HEX.pipe_1.mediums[7].T', 'HEX.pipe_1.mediums[7].p', 'HEX.pipe_1.mediums[8].T', 'HEX.pipe_1.mediums[8].p', 'HEX.pipe_1.mediums[9].T', 'HEX.pipe_1.mediums[9].p', 'HEX.pipe_2.mediums[10].T', 'HEX.pipe_2.mediums[10].p', 'HEX.pipe_2.mediums[11].T', 'HEX.pipe_2.mediums[11].p', 'HEX.pipe_2.mediums[12].T', 'HEX.pipe_2.mediums[12].p', 'HEX.pipe_2.mediums[13].T', 'HEX.pipe_2.mediums[13].p', 'HEX.pipe_2.mediums[14].T', 'HEX.pipe_2.mediums[14].p', 'HEX.pipe_2.mediums[15].T', 'HEX.pipe_2.mediums[15].p', 'HEX.pipe_2.mediums[16].T', 'HEX.pipe_2.mediums[16].p', 'HEX.pipe_2.mediums[17].T', 'HEX.pipe_2.mediums[17].p', 'HEX.pipe_2.mediums[18].T', 'HEX.pipe_2.mediums[18].p', 'HEX.pipe_2.mediums[19].T', 'HEX.pipe_2.mediums[19].p', 'HEX.pipe_2.mediums[1].T', 'HEX.pipe_2.mediums[1].p', 'HEX.pipe_2.mediums[20].T', 'HEX.pipe_2.mediums[20].p', 'HEX.pipe_2.mediums[2].T', 'HEX.pipe_2.mediums[2].p', 'HEX.pipe_2.mediums[3].T', 'HEX.pipe_2.mediums[3].p', 'HEX.pipe_2.mediums[4].T', 'HEX.pipe_2.mediums[4].p', 'HEX.pipe_2.mediums[5].T', 'HEX.pipe_2.mediums[5].p', 'HEX.pipe_2.mediums[6].T', 'HEX.pipe_2.mediums[6].p', 'HEX.pipe_2.mediums[7].T', 'HEX.pipe_2.mediums[7].p', 'HEX.pipe_2.mediums[8].T', 'HEX.pipe_2.mediums[8].p', 'HEX.pipe_2.mediums[9].T', 'HEX.pipe_2.mediums[9].p', 'HEX.wall.T[10]', 'HEX.wall.T[11]', 'HEX.wall.T[12]', 'HEX.wall.T[13]', 'HEX.wall.T[14]', 'HEX.wall.T[15]', 'HEX.wall.T[16]', 'HEX.wall.T[17]', 'HEX.wall.T[18]', 'HEX.wall.T[19]', 'HEX.wall.T[1]', 'HEX.wall.T[20]', 'HEX.wall.T[2]', 'HEX.wall.T[3]', 'HEX.wall.T[4]', 'HEX.wall.T[5]', 'HEX.wall.T[6]', 'HEX.wall.T[7]', 'HEX.wall.T[8]', 'HEX.wall.T[9]']
80.02322203700169 80.043547631 78.406562653
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fcffcfc2f20>