Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_4.1.0_Modelica.Fluid.Examples.BranchingDynamicPipes.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.001705/0.001705, allocations: 124.5 kB / 17.79 MB, free: 5.227 MB / 14.72 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.001984/0.001984, allocations: 207.2 kB / 20.75 MB, free: 2.273 MB / 14.72 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 1.5/1.5, allocations: 230.6 MB / 254.1 MB, free: 15.09 MB / 206.1 MB
"
[Timeout remaining time 178]
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: "" <> buildModelFMU(Modelica.Fluid.Examples.BranchingDynamicPipes,fileNamePrefix="Modelica_4_1_0_Modelica_Fluid_Examples_BranchingDynamicPipes",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(Modelica.Fluid.Examples.BranchingDynamicPipes,fileNamePrefix="Modelica_4_1_0_Modelica_Fluid_Examples_BranchingDynamicPipes",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 0.001506/0.001506, allocations: 51.92 kB / 373 MB, free: 10.23 MB / 302.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1138/0.1153, allocations: 53.32 MB / 426.3 MB, free: 4.82 MB / 350.1 MB
Notification: Performance of NFInst.instantiate(Modelica.Fluid.Examples.BranchingDynamicPipes): time 0.9271/1.042, allocations: 278.6 MB / 0.6883 GB, free: 1.008 MB / 0.5137 GB
Notification: Performance of NFInst.instExpressions: time 0.03125/1.074, allocations: 23.38 MB / 0.7112 GB, free: 288 kB / 0.5137 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.00367/1.077, allocations: 138.7 kB / 0.7113 GB, free: 288 kB / 0.5137 GB
Notification: Performance of NFTyping.typeComponents: time 0.003769/1.081, allocations: 1.275 MB / 0.7125 GB, free: 15.87 MB / 0.5294 GB
Notification: Performance of NFTyping.typeBindings: time 0.02087/1.102, allocations: 6.563 MB / 0.7189 GB, free: 14.05 MB / 0.5294 GB
Notification: Performance of NFTyping.typeClassSections: time 0.02621/1.128, allocations: 8.658 MB / 0.7274 GB, free: 9.922 MB / 0.5294 GB
Notification: Performance of NFFlatten.flatten: time 0.02317/1.151, allocations: 16.13 MB / 0.7431 GB, free: 13.51 MB / 0.545 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.009068/1.16, allocations: 4.197 MB / 0.7472 GB, free: 9.41 MB / 0.545 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01529/1.176, allocations: 6.291 MB / 0.7534 GB, free: 3.73 MB / 0.545 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01383/1.19, allocations: 7.152 MB / 0.7604 GB, free: 13.23 MB / 0.5606 GB
Notification: Performance of NFPackage.collectConstants: time 0.003713/1.193, allocations: 0.8359 MB / 0.7612 GB, free: 12.4 MB / 0.5606 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02979/1.223, allocations: 12.63 MB / 0.7735 GB, free: 0.9258 MB / 0.5606 GB
Notification: Performance of NFScalarize.scalarize: time 0.01019/1.233, allocations: 4.397 MB / 0.7778 GB, free: 12.59 MB / 0.5762 GB
Notification: Performance of NFVerifyModel.verify: time 0.01375/1.247, allocations: 4.877 MB / 0.7826 GB, free: 7.762 MB / 0.5762 GB
Notification: Performance of NFConvertDAE.convert: time 0.04318/1.29, allocations: 18.73 MB / 0.8009 GB, free: 5.699 MB / 0.5919 GB
Notification: Performance of FrontEnd - DAE generated: time 7.013e-06/1.29, allocations: 0 / 0.8009 GB, free: 5.699 MB / 0.5919 GB
Notification: Performance of FrontEnd: time 1.824e-06/1.29, allocations: 0 / 0.8009 GB, free: 5.699 MB / 0.5919 GB
Notification: Performance of Transformations before backend: time 0.00045/1.291, allocations: 7.984 kB / 0.8009 GB, free: 5.691 MB / 0.5919 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.04962/1.34, allocations: 11.91 MB / 0.8125 GB, free: 9.781 MB / 0.6075 GB
Notification: Performance of prepare preOptimizeDAE: time 5.254e-05/1.34, allocations: 8.031 kB / 0.8125 GB, free: 9.773 MB / 0.6075 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.004327/1.345, allocations: 1.015 MB / 0.8135 GB, free: 8.777 MB / 0.6075 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.006219/1.351, allocations: 0.8933 MB / 0.8144 GB, free: 7.879 MB / 0.6075 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01828/1.369, allocations: 6.006 MB / 0.8203 GB, free: 2.035 MB / 0.6075 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0006473/1.37, allocations: 484.3 kB / 0.8207 GB, free: 1.59 MB / 0.6075 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.003413/1.373, allocations: 0.6635 MB / 0.8214 GB, free: 0.957 MB / 0.6075 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.03765/1.411, allocations: 14.62 MB / 0.8356 GB, free: 2.359 MB / 0.6231 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0003688/1.411, allocations: 23.89 kB / 0.8357 GB, free: 2.336 MB / 0.6231 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.002918/1.414, allocations: 246 kB / 0.8359 GB, free: 2.121 MB / 0.6231 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.001768/1.416, allocations: 1.287 MB / 0.8372 GB, free: 0.832 MB / 0.6231 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.04179/1.458, allocations: 17.22 MB / 0.854 GB, free: 15.6 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.3511/1.809, allocations: 54.44 MB / 0.9071 GB, free: 266.6 MB / 0.6544 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01959/1.828, allocations: 11.17 MB / 0.918 GB, free: 261.5 MB / 0.6544 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01335/1.842, allocations: 7.632 MB / 0.9255 GB, free: 257.5 MB / 0.6544 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.003716/1.845, allocations: 4.219 MB / 0.9296 GB, free: 252.9 MB / 0.6544 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0002204/1.846, allocations: 147.2 kB / 0.9298 GB, free: 252.7 MB / 0.6544 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.006083/1.852, allocations: 0.8631 MB / 0.9306 GB, free: 252.3 MB / 0.6544 GB
Notification: Performance of pre-optimization done (n=925): time 3.774e-05/1.852, allocations: 3.562 kB / 0.9306 GB, free: 252.3 MB / 0.6544 GB
Notification: Performance of matching and sorting (n=1187): time 0.3609/2.213, allocations: 99.32 MB / 1.028 GB, free: 163.7 MB / 0.6544 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001088/2.213, allocations: 176.6 kB / 1.028 GB, free: 163.5 MB / 0.6544 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.00609/2.219, allocations: 3.793 MB / 1.031 GB, free: 159.8 MB / 0.6544 GB
Notification: Performance of collectPreVariables (initialization): time 0.004124/2.223, allocations: 245.7 kB / 1.032 GB, free: 159.5 MB / 0.6544 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001391/2.224, allocations: 2.397 MB / 1.034 GB, free: 157.4 MB / 0.6544 GB
Notification: Performance of collectInitialBindings (initialization): time 0.005889/2.23, allocations: 4.335 MB / 1.038 GB, free: 153.7 MB / 0.6544 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.008981/2.239, allocations: 2.322 MB / 1.041 GB, free: 151.3 MB / 0.6544 GB
Notification: Performance of setup shared object (initialization): time 5.159e-05/2.239, allocations: 301.1 kB / 1.041 GB, free: 151 MB / 0.6544 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.02099/2.26, allocations: 10.7 MB / 1.051 GB, free: 140.3 MB / 0.6544 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0244/2.285, allocations: 12.11 MB / 1.063 GB, free: 127.9 MB / 0.6544 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.04929/2.334, allocations: 23.16 MB / 1.086 GB, free: 104.3 MB / 0.6544 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 9.892e-05/2.334, allocations: 8 kB / 1.086 GB, free: 104.3 MB / 0.6544 GB
Notification: Performance of matching and sorting (n=1456) (initialization): time 0.09737/2.431, allocations: 33.53 MB / 1.118 GB, free: 70.66 MB / 0.6544 GB
Notification: Performance of prepare postOptimizeDAE: time 9.606e-05/2.432, allocations: 16 kB / 1.118 GB, free: 70.65 MB / 0.6544 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.048e-05/2.432, allocations: 28 kB / 1.119 GB, free: 70.62 MB / 0.6544 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.5394/2.971, allocations: 88.27 MB / 1.205 GB, free: 268.8 MB / 0.6544 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005272/2.976, allocations: 1.106 MB / 1.206 GB, free: 268.8 MB / 0.6544 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.08716/3.063, allocations: 37.03 MB / 1.242 GB, free: 259.9 MB / 0.6544 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01431/3.078, allocations: 1.309 MB / 1.243 GB, free: 259.7 MB / 0.6544 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004127/3.082, allocations: 0.5831 MB / 1.244 GB, free: 259.6 MB / 0.6544 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.02705/3.109, allocations: 12.53 MB / 1.256 GB, free: 250.1 MB / 0.6544 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.02187/3.131, allocations: 11.81 MB / 1.268 GB, free: 240.2 MB / 0.6544 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.0439/3.175, allocations: 22.53 MB / 1.29 GB, free: 217.9 MB / 0.6544 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 7.411e-05/3.175, allocations: 8 kB / 1.29 GB, free: 217.9 MB / 0.6544 GB
Notification: Performance of matching and sorting (n=1456) (initialization_lambda0): time 0.07982/3.255, allocations: 32.46 MB / 1.321 GB, free: 185.8 MB / 0.6544 GB
Notification: Performance of prepare postOptimizeDAE: time 7.943e-05/3.255, allocations: 16 kB / 1.321 GB, free: 185.8 MB / 0.6544 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.07e-05/3.255, allocations: 28 kB / 1.321 GB, free: 185.8 MB / 0.6544 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.2463/3.501, allocations: 85.12 MB / 1.404 GB, free: 100.8 MB / 0.6544 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005463/3.507, allocations: 1.151 MB / 1.406 GB, free: 99.66 MB / 0.6544 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.07231/3.579, allocations: 35.1 MB / 1.44 GB, free: 64.64 MB / 0.6544 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01474/3.594, allocations: 1.306 MB / 1.441 GB, free: 63.34 MB / 0.6544 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004548/3.598, allocations: 0.5622 MB / 1.442 GB, free: 62.77 MB / 0.6544 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.009101/3.607, allocations: 0.7101 MB / 1.442 GB, free: 62.07 MB / 0.6544 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.006557/3.614, allocations: 0.6977 MB / 1.443 GB, free: 61.42 MB / 0.6544 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.07943/3.693, allocations: 31.26 MB / 1.474 GB, free: 30.09 MB / 0.6544 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001346/3.693, allocations: 127.9 kB / 1.474 GB, free: 29.96 MB / 0.6544 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 5.532e-05/3.693, allocations: 4 kB / 1.474 GB, free: 29.96 MB / 0.6544 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.3333/4.027, allocations: 24.21 MB / 1.497 GB, free: 279.3 MB / 0.6544 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.1098/4.137, allocations: 42.82 MB / 1.539 GB, free: 261.1 MB / 0.6544 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0001688/4.137, allocations: 7.625 kB / 1.539 GB, free: 261.1 MB / 0.6544 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.01937/4.156, allocations: 3.4 MB / 1.542 GB, free: 260.3 MB / 0.6544 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.03963/4.196, allocations: 11.98 MB / 1.554 GB, free: 250.6 MB / 0.6544 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.006057/4.202, allocations: 0.6283 MB / 1.555 GB, free: 250 MB / 0.6544 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.04307/4.245, allocations: 45.07 MB / 1.599 GB, free: 203.5 MB / 0.6544 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 7.584e-06/4.245, allocations: 3.938 kB / 1.599 GB, free: 203.5 MB / 0.6544 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.09471/4.34, allocations: 37.78 MB / 1.636 GB, free: 166 MB / 0.6544 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0031/4.343, allocations: 0.8251 MB / 1.637 GB, free: 165.2 MB / 0.6544 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.006123/4.349, allocations: 483.7 kB / 1.637 GB, free: 164.7 MB / 0.6544 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01459/4.363, allocations: 1.154 MB / 1.638 GB, free: 163.6 MB / 0.6544 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.004679/4.368, allocations: 0.7978 MB / 1.639 GB, free: 162.8 MB / 0.6544 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.004328/4.372, allocations: 0.5504 MB / 1.639 GB, free: 162.2 MB / 0.6544 GB
Notification: Performance of sorting global known variables: time 0.004589/4.377, allocations: 2.614 MB / 1.642 GB, free: 159.6 MB / 0.6544 GB
Notification: Performance of sort global known variables: time 7e-08/4.377, allocations: 4 kB / 1.642 GB, free: 159.6 MB / 0.6544 GB
Notification: Performance of remove unused functions: time 0.034/4.411, allocations: 6.751 MB / 1.649 GB, free: 153.3 MB / 0.6544 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.1026/4.514, allocations: 40.96 MB / 1.689 GB, free: 112.7 MB / 0.6544 GB
Notification: Performance of simCode: created initialization part: time 0.09494/4.609, allocations: 37.51 MB / 1.725 GB, free: 75.2 MB / 0.6544 GB
Notification: Performance of simCode: created event and clocks part: time 1.791e-05/4.609, allocations: 5 kB / 1.725 GB, free: 75.19 MB / 0.6544 GB
Notification: Performance of simCode: created simulation system equations: time 0.03538/4.644, allocations: 14 MB / 1.739 GB, free: 61.12 MB / 0.6544 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.02576/4.67, allocations: 3.512 MB / 1.742 GB, free: 57.64 MB / 0.6544 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.607/5.277, allocations: 136.5 MB / 1.876 GB, free: 235.7 MB / 0.6544 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.007711/5.284, allocations: 5.146 MB / 1.881 GB, free: 231.5 MB / 0.6544 GB
Notification: Performance of simCode: alias equations: time 0.01849/5.303, allocations: 5.821 MB / 1.886 GB, free: 226.1 MB / 0.6544 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.009825/5.313, allocations: 3.643 MB / 1.89 GB, free: 222.5 MB / 0.6544 GB
Notification: Performance of SimCode: time 1.492e-06/5.313, allocations: 3.938 kB / 1.89 GB, free: 222.5 MB / 0.6544 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 1.493/6.806, allocations: 0.5072 GB / 2.397 GB, free: 241.2 MB / 0.6544 GB
Notification: Performance of buildModelFMU: Generate platform static: time 42.36/49.17, allocations: 5.875 kB / 2.397 GB, free: 241.2 MB / 0.6544 GB
"
[Timeout remaining time 611]
(rm -f Modelica_4.1.0_Modelica.Fluid.Examples.BranchingDynamicPipes.pipe ; mkfifo Modelica_4.1.0_Modelica.Fluid.Examples.BranchingDynamicPipes.pipe ; head -c 1048576 < Modelica_4.1.0_Modelica.Fluid.Examples.BranchingDynamicPipes.pipe >> ../files/Modelica_4.1.0_Modelica.Fluid.Examples.BranchingDynamicPipes.sim & python3 -m fmpy simulate  --output-file Modelica_4.1.0_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_4_1_0_Modelica_Fluid_Examples_BranchingDynamicPipes.fmu > Modelica_4.1.0_Modelica.Fluid.Examples.BranchingDynamicPipes.pipe 2>&1) [Timeout 52.5]
[Calling os._exit(0), Time elapsed: 52.143806303996826]
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']
49.48189290201117 49.498242066 48.204178699
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f528bdc7340>