Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_trunk_Modelica.Fluid.Examples.BranchingDynamicPipes.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.0007926/0.0007926, allocations: 88.33 kB / 20.67 MB, free: 3.875 MB / 18.57 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.0008754/0.0008754, allocations: 160.9 kB / 23.95 MB, free: 0.5977 MB / 18.57 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 0.8906/0.8906, allocations: 177 MB / 204.1 MB, free: 5.723 MB / 186.7 MB
"
[Timeout remaining time 179]
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.BranchingDynamicPipes,fileNamePrefix="Modelica_trunk_Modelica_Fluid_Examples_BranchingDynamicPipes",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(Modelica.Fluid.Examples.BranchingDynamicPipes,fileNamePrefix="Modelica_trunk_Modelica_Fluid_Examples_BranchingDynamicPipes",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 1.503e-06/1.503e-06, allocations: 0 / 324.5 MB, free: 15.91 MB / 298.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.737e-05/1.888e-05, allocations: 3.266 kB / 324.5 MB, free: 15.91 MB / 298.7 MB
Notification: Performance of NFInst.instantiate(Modelica.Fluid.Examples.BranchingDynamicPipes): time 0.3622/0.3622, allocations: 242.9 MB / 0.5541 GB, free: 15 MB / 458.7 MB
Notification: Performance of NFInst.instExpressions: time 0.02458/0.3868, allocations: 21.28 MB / 0.5749 GB, free: 9.664 MB / 474.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002473/0.3893, allocations: 138.9 kB / 0.575 GB, free: 9.527 MB / 474.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.002386/0.3916, allocations: 1.196 MB / 0.5762 GB, free: 8.324 MB / 474.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.01251/0.4042, allocations: 6.806 MB / 0.5828 GB, free: 1.488 MB / 474.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.01715/0.4213, allocations: 10.27 MB / 0.5929 GB, free: 7.203 MB / 490.7 MB
Notification: Performance of NFFlatten.flatten: time 0.01401/0.4353, allocations: 15.98 MB / 0.6085 GB, free: 7.184 MB / 0.4948 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.005684/0.441, allocations: 4.016 MB / 0.6124 GB, free: 3.137 MB / 0.4948 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01819/0.4592, allocations: 8.035 MB / 0.6203 GB, free: 11.09 MB / 0.5105 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01026/0.4694, allocations: 6.942 MB / 0.627 GB, free: 4.129 MB / 0.5105 GB
Notification: Performance of NFPackage.collectConstants: time 0.003213/0.4727, allocations: 0.8359 MB / 0.6278 GB, free: 3.293 MB / 0.5105 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01909/0.4918, allocations: 10.05 MB / 0.6377 GB, free: 9.227 MB / 0.5261 GB
Notification: Performance of NFScalarize.scalarize: time 0.006842/0.4986, allocations: 4.576 MB / 0.6421 GB, free: 4.641 MB / 0.5261 GB
Notification: Performance of NFVerifyModel.verify: time 0.009234/0.5078, allocations: 3.661 MB / 0.6457 GB, free: 0.9727 MB / 0.5261 GB
Notification: Performance of NFConvertDAE.convert: time 0.2897/0.7975, allocations: 19.81 MB / 0.665 GB, free: 26.61 MB / 0.5261 GB
Notification: Performance of FrontEnd - DAE generated: time 6.883e-06/0.7975, allocations: 1.531 kB / 0.665 GB, free: 26.61 MB / 0.5261 GB
Notification: Performance of FrontEnd: time 1.723e-06/0.7975, allocations: 0 / 0.665 GB, free: 26.61 MB / 0.5261 GB
Notification: Performance of Transformations before backend: time 0.0005295/0.798, allocations: 2.969 kB / 0.6651 GB, free: 26.61 MB / 0.5261 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2025
 * Number of variables: 2025
Notification: Performance of Generate backend data structure: time 0.04048/0.8385, allocations: 11.78 MB / 0.6766 GB, free: 23.09 MB / 0.5261 GB
Notification: Performance of prepare preOptimizeDAE: time 5.084e-05/0.8386, allocations: 15.86 kB / 0.6766 GB, free: 23.08 MB / 0.5261 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.00623/0.8448, allocations: 1.01 MB / 0.6776 GB, free: 23 MB / 0.5261 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.007046/0.8518, allocations: 0.8941 MB / 0.6784 GB, free: 22.56 MB / 0.5261 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01441/0.8663, allocations: 5.973 MB / 0.6843 GB, free: 21.68 MB / 0.5261 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0006914/0.8669, allocations: 484.7 kB / 0.6847 GB, free: 21.67 MB / 0.5261 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.004717/0.8717, allocations: 0.658 MB / 0.6854 GB, free: 21.64 MB / 0.5261 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.03157/0.9032, allocations: 16.9 MB / 0.7019 GB, free: 18.46 MB / 0.5261 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0003292/0.9036, allocations: 19.62 kB / 0.7019 GB, free: 18.45 MB / 0.5261 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.003992/0.9076, allocations: 264.3 kB / 0.7021 GB, free: 18.45 MB / 0.5261 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.001063/0.9086, allocations: 1.283 MB / 0.7034 GB, free: 18.43 MB / 0.5261 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03008/0.9387, allocations: 17.13 MB / 0.7201 GB, free: 18.37 MB / 0.5261 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.06981/1.009, allocations: 37.05 MB / 0.7563 GB, free: 5.77 MB / 0.5417 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01633/1.025, allocations: 11.12 MB / 0.7672 GB, free: 10.7 MB / 0.5573 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01249/1.037, allocations: 7.632 MB / 0.7746 GB, free: 3.059 MB / 0.5573 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.00183/1.039, allocations: 0.6567 MB / 0.7753 GB, free: 2.402 MB / 0.5573 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0001299/1.039, allocations: 154.8 kB / 0.7754 GB, free: 2.242 MB / 0.5573 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.0052/1.044, allocations: 0.8554 MB / 0.7762 GB, free: 1.387 MB / 0.5573 GB
Notification: Performance of pre-optimization done (n=925): time 3.041e-05/1.045, allocations: 3.984 kB / 0.7762 GB, free: 1.383 MB / 0.5573 GB
Notification: Performance of matching and sorting (n=1187): time 0.2225/1.267, allocations: 98.18 MB / 0.8721 GB, free: 472 kB / 0.6511 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001082/1.267, allocations: 172.7 kB / 0.8723 GB, free: 284 kB / 0.6511 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.006703/1.274, allocations: 3.864 MB / 0.8761 GB, free: 12.42 MB / 0.6667 GB
Notification: Performance of collectPreVariables (initialization): time 0.004976/1.279, allocations: 242.7 kB / 0.8763 GB, free: 12.18 MB / 0.6667 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001869/1.281, allocations: 2.386 MB / 0.8786 GB, free: 9.781 MB / 0.6667 GB
Notification: Performance of collectInitialBindings (initialization): time 0.00692/1.288, allocations: 4.281 MB / 0.8828 GB, free: 5.555 MB / 0.6667 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.009934/1.298, allocations: 2.314 MB / 0.8851 GB, free: 3.234 MB / 0.6667 GB
Notification: Performance of setup shared object (initialization): time 8.95e-05/1.298, allocations: 301.1 kB / 0.8853 GB, free: 2.938 MB / 0.6667 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.2165/1.514, allocations: 10.69 MB / 0.8958 GB, free: 342.8 MB / 0.6667 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01862/1.533, allocations: 12.12 MB / 0.9076 GB, free: 339.7 MB / 0.6667 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.03604/1.569, allocations: 23.17 MB / 0.9302 GB, free: 330.8 MB / 0.6667 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.181e-05/1.569, allocations: 10.72 kB / 0.9303 GB, free: 330.8 MB / 0.6667 GB
Notification: Performance of matching and sorting (n=1456) (initialization): time 0.05663/1.625, allocations: 33.52 MB / 0.963 GB, free: 306.3 MB / 0.6667 GB
Notification: Performance of prepare postOptimizeDAE: time 4.944e-05/1.625, allocations: 16 kB / 0.963 GB, free: 306.3 MB / 0.6667 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.758e-05/1.626, allocations: 28 kB / 0.963 GB, free: 306.3 MB / 0.6667 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.1393/1.765, allocations: 88.26 MB / 1.049 GB, free: 218.2 MB / 0.6667 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003621/1.769, allocations: 1.1 MB / 1.05 GB, free: 217.1 MB / 0.6667 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.05553/1.824, allocations: 37.04 MB / 1.086 GB, free: 180.1 MB / 0.6667 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01078/1.835, allocations: 1.314 MB / 1.088 GB, free: 178.8 MB / 0.6667 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.003613/1.838, allocations: 0.5739 MB / 1.088 GB, free: 178.3 MB / 0.6667 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.02024/1.859, allocations: 12.52 MB / 1.101 GB, free: 165.7 MB / 0.6667 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.01594/1.875, allocations: 11.82 MB / 1.112 GB, free: 153.5 MB / 0.6667 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.03256/1.907, allocations: 22.52 MB / 1.134 GB, free: 130.6 MB / 0.6667 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 6.177e-05/1.907, allocations: 8 kB / 1.134 GB, free: 130.6 MB / 0.6667 GB
Notification: Performance of matching and sorting (n=1456) (initialization_lambda0): time 0.05374/1.961, allocations: 32.47 MB / 1.166 GB, free: 98.39 MB / 0.6667 GB
Notification: Performance of prepare postOptimizeDAE: time 3.435e-05/1.961, allocations: 20 kB / 1.166 GB, free: 98.38 MB / 0.6667 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.737e-05/1.961, allocations: 28 kB / 1.166 GB, free: 98.35 MB / 0.6667 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.1328/2.094, allocations: 85.1 MB / 1.249 GB, free: 13.17 MB / 0.6667 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00373/2.098, allocations: 1.146 MB / 1.25 GB, free: 12.03 MB / 0.6667 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.238/2.336, allocations: 35.12 MB / 1.284 GB, free: 329.7 MB / 0.6667 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01107/2.347, allocations: 1.299 MB / 1.286 GB, free: 329.5 MB / 0.6667 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.003802/2.35, allocations: 0.568 MB / 1.286 GB, free: 329.4 MB / 0.6667 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 123
 * 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 (619):
 * Single equations (assignments): 618
 * 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
   {(75,763)}
Notification: Performance of prepare postOptimizeDAE: time 0.004491/2.355, allocations: 0.7067 MB / 1.287 GB, free: 328.9 MB / 0.6667 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.002469/2.357, allocations: 0.6932 MB / 1.288 GB, free: 328.9 MB / 0.6667 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0467/2.404, allocations: 31.25 MB / 1.318 GB, free: 318.2 MB / 0.6667 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 9.821e-05/2.404, allocations: 129.1 kB / 1.318 GB, free: 318.1 MB / 0.6667 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 4.264e-05/2.404, allocations: 0 / 1.318 GB, free: 318.1 MB / 0.6667 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.03941/2.444, allocations: 24.21 MB / 1.342 GB, free: 295.3 MB / 0.6667 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.06847/2.512, allocations: 40.71 MB / 1.382 GB, free: 255 MB / 0.6667 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 9.455e-05/2.512, allocations: 7.938 kB / 1.382 GB, free: 254.9 MB / 0.6667 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.01201/2.524, allocations: 3.394 MB / 1.385 GB, free: 251.5 MB / 0.6667 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0199/2.544, allocations: 12.01 MB / 1.397 GB, free: 239.6 MB / 0.6667 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.004131/2.548, allocations: 0.6283 MB / 1.397 GB, free: 239 MB / 0.6667 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.02269/2.571, allocations: 44.52 MB / 1.441 GB, free: 193.1 MB / 0.6667 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.166e-06/2.571, allocations: 7.094 kB / 1.441 GB, free: 193.1 MB / 0.6667 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.05662/2.628, allocations: 37.77 MB / 1.478 GB, free: 155.2 MB / 0.6667 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002048/2.63, allocations: 0.7548 MB / 1.478 GB, free: 154.4 MB / 0.6667 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.004374/2.634, allocations: 485.7 kB / 1.479 GB, free: 154 MB / 0.6667 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.008663/2.643, allocations: 1.145 MB / 1.48 GB, free: 152.8 MB / 0.6667 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.003046/2.646, allocations: 0.8325 MB / 1.481 GB, free: 152 MB / 0.6667 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.001947/2.648, allocations: 0.5504 MB / 1.481 GB, free: 151.4 MB / 0.6667 GB
Notification: Performance of sorting global known variables: time 0.002946/2.651, allocations: 2.61 MB / 1.484 GB, free: 148.8 MB / 0.6667 GB
Notification: Performance of sort global known variables: time 2.41e-07/2.651, allocations: 0 / 1.484 GB, free: 148.8 MB / 0.6667 GB
Notification: Performance of remove unused functions: time 0.02468/2.675, allocations: 6.756 MB / 1.49 GB, free: 142.5 MB / 0.6667 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 5
 * Number of states: 82 (pipe1.mediums[1].p,pipe1.mediums[1].Xi[1],pipe1.mediums[1].T,pipe1.mediums[2].p,pipe1.mediums[2].Xi[1],pipe1.mediums[2].T,pipe1.mediums[3].p,pipe1.mediums[3].Xi[1],pipe1.mediums[3].T,pipe1.mediums[4].p,pipe1.mediums[4].Xi[1],pipe1.mediums[4].T,pipe1.mediums[5].p,pipe1.mediums[5].Xi[1],pipe1.mediums[5].T,pipe1.flowModel.m_flows[1],pipe1.flowModel.m_flows[2],pipe1.flowModel.m_flows[3],pipe1.flowModel.m_flows[4],pipe1.flowModel.m_flows[5],pipe1.flowModel.m_flows[6],pipe2.mediums[1].p,pipe2.mediums[1].Xi[1],pipe2.mediums[1].T,pipe2.mediums[2].p,pipe2.mediums[2].Xi[1],pipe2.mediums[2].T,pipe2.mediums[3].p,pipe2.mediums[3].Xi[1],pipe2.mediums[3].T,pipe2.mediums[4].p,pipe2.mediums[4].Xi[1],pipe2.mediums[4].T,pipe2.mediums[5].p,pipe2.mediums[5].Xi[1],pipe2.mediums[5].T,pipe2.flowModel.m_flows[1],pipe2.flowModel.m_flows[2],pipe2.flowModel.m_flows[3],pipe2.flowModel.m_flows[4],pipe3.mediums[1].p,pipe3.mediums[1].Xi[1],pipe3.mediums[1].T,pipe3.mediums[2].p,pipe3.mediums[2].Xi[1],pipe3.mediums[2].T,pipe3.mediums[3].p,pipe3.mediums[3].Xi[1],pipe3.mediums[3].T,pipe3.mediums[4].p,pipe3.mediums[4].Xi[1],pipe3.mediums[4].T,pipe3.mediums[5].p,pipe3.mediums[5].Xi[1],pipe3.mediums[5].T,pipe3.flowModel.m_flows[1],pipe3.flowModel.m_flows[2],pipe3.flowModel.m_flows[3],pipe3.flowModel.m_flows[4],pipe3.flowModel.m_flows[5],pipe3.flowModel.m_flows[6],pipe4.mediums[1].p,pipe4.mediums[1].Xi[1],pipe4.mediums[1].T,pipe4.mediums[2].p,pipe4.mediums[2].Xi[1],pipe4.mediums[2].T,pipe4.mediums[3].p,pipe4.mediums[3].Xi[1],pipe4.mediums[3].T,pipe4.mediums[4].p,pipe4.mediums[4].Xi[1],pipe4.mediums[4].T,pipe4.mediums[5].p,pipe4.mediums[5].Xi[1],pipe4.mediums[5].T,pipe4.flowModel.m_flows[1],pipe4.flowModel.m_flows[2],pipe4.flowModel.m_flows[3],pipe4.flowModel.m_flows[4],pipe4.flowModel.m_flows[5],pipe4.flowModel.m_flows[6])
 * 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 (1168):
 * Single equations (assignments): 1121
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 22
 * Torn equation systems: 25
 * 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): 22 systems
   {1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 5 systems
   {(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): 20 systems
   {(2,6), (2,6), (2,6), (2,6), (2,6), (2,6), (2,6), (2,6), (2,6), (2,6), (2,6), (2,6), (2,6), (2,6), (2,6), (2,6), (2,6), (2,6), (2,6), (2,6)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.07502/2.75, allocations: 41.12 MB / 1.531 GB, free: 101.5 MB / 0.6667 GB
Notification: Performance of simCode: created initialization part: time 0.06584/2.816, allocations: 37.5 MB / 1.567 GB, free: 64.01 MB / 0.6667 GB
Notification: Performance of simCode: created event and clocks part: time 1.304e-05/2.816, allocations: 9 kB / 1.567 GB, free: 64 MB / 0.6667 GB
Notification: Performance of simCode: created simulation system equations: time 0.02493/2.841, allocations: 14.01 MB / 1.581 GB, free: 49.93 MB / 0.6667 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01655/2.858, allocations: 3.513 MB / 1.584 GB, free: 46.43 MB / 0.6667 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.3978/3.255, allocations: 135.4 MB / 1.717 GB, free: 287.1 MB / 0.6667 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.005493/3.261, allocations: 4.664 MB / 1.721 GB, free: 282.5 MB / 0.6667 GB
Notification: Performance of simCode: alias equations: time 0.01426/3.275, allocations: 5.814 MB / 1.727 GB, free: 277.1 MB / 0.6667 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.006983/3.282, allocations: 3.636 MB / 1.73 GB, free: 273.5 MB / 0.6667 GB
Notification: Performance of SimCode: time 2.023e-06/3.282, allocations: 0 / 1.73 GB, free: 273.5 MB / 0.6667 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.5354/3.818, allocations: 452.4 MB / 2.172 GB, free: 163.1 MB / 0.6667 GB
Notification: Performance of buildModelFMU: Generate platform static: time 23.22/27.04, allocations: 11.95 kB / 2.172 GB, free: 163.1 MB / 0.6667 GB
"
[Timeout remaining time 633]
(rm -f Modelica_trunk_Modelica.Fluid.Examples.BranchingDynamicPipes.pipe ; mkfifo Modelica_trunk_Modelica.Fluid.Examples.BranchingDynamicPipes.pipe ; head -c 1048576 < Modelica_trunk_Modelica.Fluid.Examples.BranchingDynamicPipes.pipe >> ../files/Modelica_trunk_Modelica.Fluid.Examples.BranchingDynamicPipes.sim & python3 -m fmpy simulate  --output-file Modelica_trunk_Modelica.Fluid.Examples.BranchingDynamicPipes_res.csv --start-time 0 --stop-time 10 --timeout 50 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 0.00199402 Modelica_trunk_Modelica_Fluid_Examples_BranchingDynamicPipes.fmu > Modelica_trunk_Modelica.Fluid.Examples.BranchingDynamicPipes.pipe 2>&1) [Timeout 52.5]
[Calling os._exit(0), Time elapsed: 28.981508184224367]
Failed to read output from testmodel.py, exit status != 0:
['time', 'pipe1.flowModel.m_flows[1]', 'pipe1.flowModel.m_flows[2]', 'pipe1.flowModel.m_flows[3]', 'pipe1.flowModel.m_flows[4]', 'pipe1.flowModel.m_flows[5]', 'pipe1.flowModel.m_flows[6]', 'pipe1.mediums[1].p', 'pipe1.mediums[1].Xi[1]', 'pipe1.mediums[1].T', 'pipe1.mediums[2].p', 'pipe1.mediums[2].Xi[1]', 'pipe1.mediums[2].T', 'pipe1.mediums[3].p', 'pipe1.mediums[3].Xi[1]', 'pipe1.mediums[3].T', 'pipe1.mediums[4].p', 'pipe1.mediums[4].Xi[1]', 'pipe1.mediums[4].T', 'pipe1.mediums[5].p', 'pipe1.mediums[5].Xi[1]', 'pipe1.mediums[5].T', 'pipe2.flowModel.m_flows[1]', 'pipe2.flowModel.m_flows[2]', 'pipe2.flowModel.m_flows[3]', 'pipe2.flowModel.m_flows[4]', 'pipe2.mediums[1].p', 'pipe2.mediums[1].Xi[1]', 'pipe2.mediums[1].T', 'pipe2.mediums[2].p', 'pipe2.mediums[2].Xi[1]', 'pipe2.mediums[2].T', 'pipe2.mediums[3].p', 'pipe2.mediums[3].Xi[1]', 'pipe2.mediums[3].T', 'pipe2.mediums[4].p', 'pipe2.mediums[4].Xi[1]', 'pipe2.mediums[4].T', 'pipe2.mediums[5].p', 'pipe2.mediums[5].Xi[1]', 'pipe2.mediums[5].T', 'pipe3.flowModel.m_flows[1]', 'pipe3.flowModel.m_flows[2]', 'pipe3.flowModel.m_flows[3]', 'pipe3.flowModel.m_flows[4]', 'pipe3.flowModel.m_flows[5]', 'pipe3.flowModel.m_flows[6]', 'pipe3.mediums[1].p', 'pipe3.mediums[1].Xi[1]', 'pipe3.mediums[1].T', 'pipe3.mediums[2].p', 'pipe3.mediums[2].Xi[1]', 'pipe3.mediums[2].T', 'pipe3.mediums[3].p', 'pipe3.mediums[3].Xi[1]', 'pipe3.mediums[3].T', 'pipe3.mediums[4].p', 'pipe3.mediums[4].Xi[1]', 'pipe3.mediums[4].T', 'pipe3.mediums[5].p', 'pipe3.mediums[5].Xi[1]', 'pipe3.mediums[5].T', 'pipe4.flowModel.m_flows[1]', 'pipe4.flowModel.m_flows[2]', 'pipe4.flowModel.m_flows[3]', 'pipe4.flowModel.m_flows[4]', 'pipe4.flowModel.m_flows[5]', 'pipe4.flowModel.m_flows[6]', 'pipe4.mediums[1].p', 'pipe4.mediums[1].Xi[1]', 'pipe4.mediums[1].T', 'pipe4.mediums[2].p', 'pipe4.mediums[2].Xi[1]', 'pipe4.mediums[2].T', 'pipe4.mediums[3].p', 'pipe4.mediums[3].Xi[1]', 'pipe4.mediums[3].T', 'pipe4.mediums[4].p', 'pipe4.mediums[4].Xi[1]', 'pipe4.mediums[4].T', 'pipe4.mediums[5].p', 'pipe4.mediums[5].Xi[1]', 'pipe4.mediums[5].T']
27.290603457018733 27.298345159 26.499023326
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7d425ebe9f40>