Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr HelmholtzMedia_HelmholtzMedia.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.001586/0.001586, allocations: 110.4 kB / 18.94 MB, free: 2.797 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.00155/0.00155, allocations: 223.2 kB / 22.26 MB, free: 5.211 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.356/1.356, allocations: 230.6 MB / 256 MB, free: 7.988 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/HelmholtzMedia main/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/HelmholtzMedia main/package.mo): time 0.04838/0.04838, allocations: 9.131 MB / 321.6 MB, free: 10.4 MB / 254.1 MB
"
[Timeout remaining time 180]
Using package HelmholtzMedia with version 2.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/HelmholtzMedia main/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(HelmholtzMedia.Examples.BranchingDynamicPipes,tolerance=1e-05,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="HelmholtzMedia_HelmholtzMedia.Examples.BranchingDynamicPipes")
translateModel(HelmholtzMedia.Examples.BranchingDynamicPipes,tolerance=1e-05,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="HelmholtzMedia_HelmholtzMedia.Examples.BranchingDynamicPipes") [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 0.001896/0.001896, allocations: 63.91 kB / 447.1 MB, free: 0.5039 MB / 302.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1068/0.1087, allocations: 54.95 MB / 0.4903 GB, free: 9.453 MB / 366.1 MB
Notification: Performance of NFInst.instantiate(HelmholtzMedia.Examples.BranchingDynamicPipes): time 0.9764/1.085, allocations: 456.1 MB / 0.9357 GB, free: 15.68 MB / 0.6387 GB
Notification: Performance of NFInst.instExpressions: time 1.241/2.326, allocations: 384 MB / 1.311 GB, free: 492 kB / 0.8262 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003563/2.33, allocations: 143.3 kB / 1.311 GB, free: 492 kB / 0.8262 GB
Notification: Performance of NFTyping.typeComponents: time 0.01548/2.346, allocations: 6.208 MB / 1.317 GB, free: 460 kB / 0.8262 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/HelmholtzMedia main/Interfaces/PartialHelmholtzMedium/package.mo:888:13-888:51:writable] Warning: RSS_ls was used before it was defined (given a value). Additional such uses may exist for the variable, but some messages were suppressed.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/HelmholtzMedia main/Interfaces/PartialHelmholtzMedium/package.mo:888:13-888:51:writable] Warning: lambda_ls was used before it was defined (given a value). Additional such uses may exist for the variable, but some messages were suppressed.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/HelmholtzMedia main/Interfaces/PartialHelmholtzMedium/package.mo:888:13-888:51:writable] Warning: RSS_ls was used before it was defined (given a value). Additional such uses may exist for the variable, but some messages were suppressed.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/HelmholtzMedia main/Interfaces/PartialHelmholtzMedium/package.mo:888:13-888:51:writable] Warning: lambda_ls was used before it was defined (given a value). Additional such uses may exist for the variable, but some messages were suppressed.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/HelmholtzMedia main/Interfaces/PartialHelmholtzMedium/package.mo:888:13-888:51:writable] Warning: RSS_ls was used before it was defined (given a value). Additional such uses may exist for the variable, but some messages were suppressed.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/HelmholtzMedia main/Interfaces/PartialHelmholtzMedium/package.mo:888:13-888:51:writable] Warning: lambda_ls was used before it was defined (given a value). Additional such uses may exist for the variable, but some messages were suppressed.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/HelmholtzMedia main/Interfaces/PartialHelmholtzMedium/package.mo:888:13-888:51:writable] Warning: RSS_ls was used before it was defined (given a value). Additional such uses may exist for the variable, but some messages were suppressed.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/HelmholtzMedia main/Interfaces/PartialHelmholtzMedium/package.mo:888:13-888:51:writable] Warning: lambda_ls was used before it was defined (given a value). Additional such uses may exist for the variable, but some messages were suppressed.
Notification: Performance of NFTyping.typeBindings: time 0.1057/2.451, allocations: 47.99 MB / 1.364 GB, free: 15.8 MB / 0.8419 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/HelmholtzMedia main/Interfaces/PartialHelmholtzMedium/Transport/thermalConductivity_dilute.mo:2:1-75:31:writable] Warning: Pure function 'HelmholtzMedia.Examples.BranchingDynamicPipes.pipe2.heatTransfer.Medium.Transport.thermalConductivity_dilute' contains a call to impure function 'Modelica.Utilities.Streams.print'.
Notification: Performance of NFTyping.typeClassSections: time 0.1255/2.577, allocations: 52.81 MB / 1.415 GB, free: 4.191 MB / 0.8419 GB
Notification: Performance of NFFlatten.flatten: time 0.02394/2.601, allocations: 20.26 MB / 1.435 GB, free: 7.715 MB / 0.8575 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.006128/2.607, allocations: 3.271 MB / 1.438 GB, free: 5.473 MB / 0.8575 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01537/2.622, allocations: 7.856 MB / 1.446 GB, free: 236 kB / 0.8575 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/HelmholtzMedia main/Interfaces/PartialHelmholtzMedium/package.mo:621:5-621:120:writable] Warning: assert triggered: setState_pTX: d_min and d_max did not bracket the root
Notification: Performance of NFSimplifyModel.simplify: time 0.0985/2.721, allocations: 69.4 MB / 1.514 GB, free: 13.09 MB / 0.9356 GB
Notification: Performance of NFPackage.collectConstants: time 0.003504/2.724, allocations: 0.707 MB / 1.514 GB, free: 12.38 MB / 0.9356 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.1676/2.892, allocations: 92.58 MB / 1.605 GB, free: 2.426 MB / 1.014 GB
Notification: Performance of NFScalarize.scalarize: time 0.005497/2.897, allocations: 3.29 MB / 1.608 GB, free: 15.17 MB / 1.029 GB
Notification: Performance of NFVerifyModel.verify: time 0.01012/2.907, allocations: 5.111 MB / 1.613 GB, free: 10.08 MB / 1.029 GB
Notification: Performance of NFConvertDAE.convert: time 0.1241/3.032, allocations: 45.95 MB / 1.658 GB, free: 14.92 MB / 1.076 GB
Notification: Performance of FrontEnd - DAE generated: time 6.472e-06/3.032, allocations: 0 / 1.658 GB, free: 14.92 MB / 1.076 GB
Notification: Performance of FrontEnd: time 2.054e-06/3.032, allocations: 2.625 kB / 1.658 GB, free: 14.92 MB / 1.076 GB
Notification: Performance of Transformations before backend: time 0.0004698/3.032, allocations: 0 / 1.658 GB, free: 14.92 MB / 1.076 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2409
 * Number of variables: 2409
Notification: Performance of Generate backend data structure: time 0.04806/3.08, allocations: 15.72 MB / 1.673 GB, free: 15.18 MB / 1.092 GB
Notification: Performance of prepare preOptimizeDAE: time 4.694e-05/3.08, allocations: 12.03 kB / 1.673 GB, free: 15.17 MB / 1.092 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01105/3.091, allocations: 1.712 MB / 1.675 GB, free: 13.45 MB / 1.092 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0191/3.11, allocations: 8.507 MB / 1.683 GB, free: 5.324 MB / 1.092 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0009096/3.111, allocations: 0.6021 MB / 1.684 GB, free: 4.734 MB / 1.092 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.002879/3.114, allocations: 0.6288 MB / 1.684 GB, free: 4.121 MB / 1.092 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.2715/3.386, allocations: 15.04 MB / 1.699 GB, free: 0.6758 GB / 1.092 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001314/3.386, allocations: 18.47 kB / 1.699 GB, free: 0.6758 GB / 1.092 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0007417/3.386, allocations: 262.5 kB / 1.699 GB, free: 0.6756 GB / 1.092 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.001131/3.388, allocations: 1.041 MB / 1.7 GB, free: 0.6755 GB / 1.092 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03103/3.419, allocations: 15.78 MB / 1.716 GB, free: 0.6704 GB / 1.092 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.08184/3.5, allocations: 57.75 MB / 1.772 GB, free: 0.6275 GB / 1.092 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01528/3.516, allocations: 9.544 MB / 1.782 GB, free: 0.6227 GB / 1.092 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0101/3.526, allocations: 6.81 MB / 1.788 GB, free: 0.6191 GB / 1.092 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.3583/3.884, allocations: 92.42 MB / 1.878 GB, free: 0.5327 GB / 1.092 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0001213/3.884, allocations: 103.6 kB / 1.879 GB, free: 0.5326 GB / 1.092 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.003807/3.888, allocations: 0.7798 MB / 1.879 GB, free: 0.532 GB / 1.092 GB
Notification: Performance of pre-optimization done (n=1018): time 1.074e-05/3.888, allocations: 3.281 kB / 1.879 GB, free: 0.532 GB / 1.092 GB
Notification: Performance of matching and sorting (n=1120): time 0.1678/4.056, allocations: 64.45 MB / 1.942 GB, free: 481.6 MB / 1.092 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001019/4.056, allocations: 125.2 kB / 1.942 GB, free: 481.5 MB / 1.092 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.00569/4.062, allocations: 4.005 MB / 1.946 GB, free: 477.5 MB / 1.092 GB
Notification: Performance of collectPreVariables (initialization): time 0.002044/4.064, allocations: 157.7 kB / 1.946 GB, free: 477.4 MB / 1.092 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001392/4.065, allocations: 2.876 MB / 1.949 GB, free: 474.9 MB / 1.092 GB
Notification: Performance of collectInitialBindings (initialization): time 0.004049/4.069, allocations: 3.879 MB / 1.953 GB, free: 471.5 MB / 1.092 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.00525/4.074, allocations: 1.811 MB / 1.955 GB, free: 469.7 MB / 1.092 GB
Notification: Performance of setup shared object (initialization): time 4.193e-05/4.074, allocations: 313.1 kB / 1.955 GB, free: 469.4 MB / 1.092 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01033/4.085, allocations: 7.13 MB / 1.962 GB, free: 462.3 MB / 1.092 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01157/4.096, allocations: 8.818 MB / 1.971 GB, free: 452.9 MB / 1.092 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.02148/4.118, allocations: 16.49 MB / 1.987 GB, free: 435.8 MB / 1.092 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.264e-05/4.118, allocations: 12 kB / 1.987 GB, free: 435.7 MB / 1.092 GB
Notification: Performance of matching and sorting (n=1419) (initialization): time 0.03373/4.152, allocations: 19.67 MB / 2.006 GB, free: 415.9 MB / 1.092 GB
Notification: Performance of prepare postOptimizeDAE: time 4.368e-05/4.152, allocations: 23.94 kB / 2.006 GB, free: 415.9 MB / 1.092 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.222e-05/4.152, allocations: 44.84 kB / 2.006 GB, free: 415.9 MB / 1.092 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02084/4.173, allocations: 7.278 MB / 2.013 GB, free: 408.5 MB / 1.092 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.007522/4.18, allocations: 1.892 MB / 2.015 GB, free: 406.6 MB / 1.092 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.2809/4.461, allocations: 127.5 MB / 2.14 GB, free: 275 MB / 1.092 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.007387/4.468, allocations: 0.6145 MB / 2.14 GB, free: 274.4 MB / 1.092 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001405/4.47, allocations: 383.9 kB / 2.141 GB, free: 274 MB / 1.092 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.01195/4.482, allocations: 9.024 MB / 2.149 GB, free: 265 MB / 1.092 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.009806/4.492, allocations: 8.516 MB / 2.158 GB, free: 255.9 MB / 1.092 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.01937/4.511, allocations: 15.84 MB / 2.173 GB, free: 239.4 MB / 1.092 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 3.501e-05/4.511, allocations: 12 kB / 2.173 GB, free: 239.4 MB / 1.092 GB
Notification: Performance of matching and sorting (n=1419) (initialization_lambda0): time 0.03211/4.543, allocations: 19.07 MB / 2.192 GB, free: 220.1 MB / 1.092 GB
Notification: Performance of prepare postOptimizeDAE: time 5.023e-05/4.543, allocations: 25.25 kB / 2.192 GB, free: 220.1 MB / 1.092 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.228e-05/4.543, allocations: 40 kB / 2.192 GB, free: 220.1 MB / 1.092 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01416/4.557, allocations: 5.734 MB / 2.197 GB, free: 214.3 MB / 1.092 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.007429/4.565, allocations: 1.903 MB / 2.199 GB, free: 212.4 MB / 1.092 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.2843/4.849, allocations: 129.9 MB / 2.326 GB, free: 77.85 MB / 1.092 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.006984/4.856, allocations: 0.6048 MB / 2.327 GB, free: 77.24 MB / 1.092 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0007552/4.857, allocations: 371.9 kB / 2.327 GB, free: 76.88 MB / 1.092 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 185
 * Number of states: 0 ()
 * Number of discrete variables: 74 (boundary4.medium.sat.vap.phase,boundary4.medium.sat.liq.phase,boundary4.medium.state.phase,pipe4.statesFM[7].phase,pipe4.statesFM[6].phase,pipe4.statesFM[5].phase,pipe4.statesFM[4].phase,pipe4.statesFM[3].phase,pipe4.statesFM[2].phase,pipe4.statesFM[1].phase,pipe4.mediums[5].sat.vap.phase,pipe4.mediums[5].sat.liq.phase,pipe4.mediums[4].sat.vap.phase,pipe4.mediums[4].sat.liq.phase,pipe4.mediums[3].sat.vap.phase,pipe4.mediums[3].sat.liq.phase,pipe4.mediums[2].sat.vap.phase,pipe4.mediums[2].sat.liq.phase,pipe4.mediums[1].sat.vap.phase,pipe4.mediums[1].sat.liq.phase,pipe3.statesFM[7].phase,pipe3.statesFM[6].phase,pipe3.statesFM[5].phase,pipe3.statesFM[4].phase,pipe3.statesFM[3].phase,pipe3.statesFM[2].phase,pipe3.statesFM[1].phase,pipe3.mediums[5].sat.vap.phase,pipe3.mediums[5].sat.liq.phase,pipe3.mediums[4].sat.vap.phase,pipe3.mediums[4].sat.liq.phase,pipe3.mediums[3].sat.vap.phase,pipe3.mediums[3].sat.liq.phase,pipe3.mediums[2].sat.vap.phase,pipe3.mediums[2].sat.liq.phase,pipe3.mediums[1].sat.vap.phase,pipe3.mediums[1].sat.liq.phase,pipe2.statesFM[5].phase,pipe2.statesFM[4].phase,pipe2.statesFM[3].phase,pipe2.statesFM[2].phase,pipe2.statesFM[1].phase,pipe2.state_b.phase,pipe2.state_a.phase,pipe2.mediums[5].sat.vap.phase,pipe2.mediums[5].sat.liq.phase,pipe2.mediums[4].sat.vap.phase,pipe2.mediums[4].sat.liq.phase,pipe2.mediums[3].sat.vap.phase,pipe2.mediums[3].sat.liq.phase,pipe2.mediums[2].sat.vap.phase,pipe2.mediums[2].sat.liq.phase,pipe2.mediums[1].sat.vap.phase,pipe2.mediums[1].sat.liq.phase,pipe1.statesFM[7].phase,pipe1.statesFM[6].phase,pipe1.statesFM[5].phase,pipe1.statesFM[4].phase,pipe1.statesFM[3].phase,pipe1.statesFM[2].phase,pipe1.statesFM[1].phase,pipe1.mediums[5].sat.vap.phase,pipe1.mediums[5].sat.liq.phase,pipe1.mediums[4].sat.vap.phase,pipe1.mediums[4].sat.liq.phase,pipe1.mediums[3].sat.vap.phase,pipe1.mediums[3].sat.liq.phase,pipe1.mediums[2].sat.vap.phase,pipe1.mediums[2].sat.liq.phase,pipe1.mediums[1].sat.vap.phase,pipe1.mediums[1].sat.liq.phase,boundary1.medium.sat.vap.phase,boundary1.medium.sat.liq.phase,boundary1.medium.state.phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (890):
 * Single equations (assignments): 837
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 26
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 27
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 25 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%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(4,17), (18,89)}
Notification: Performance of prepare postOptimizeDAE: time 0.001715/4.858, allocations: 0.7015 MB / 2.328 GB, free: 76.16 MB / 1.092 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001274/4.86, allocations: 0.6521 MB / 2.328 GB, free: 75.5 MB / 1.092 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.03184/4.892, allocations: 29.17 MB / 2.357 GB, free: 46.17 MB / 1.092 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.02461/4.916, allocations: 18.16 MB / 2.375 GB, free: 27.91 MB / 1.092 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 8.611e-05/4.916, allocations: 4 kB / 2.375 GB, free: 27.9 MB / 1.092 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.02781/4.944, allocations: 18.09 MB / 2.392 GB, free: 9.68 MB / 1.092 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.4903/5.434, allocations: 32.61 MB / 2.424 GB, free: 0.5662 GB / 1.092 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.543e-05/5.434, allocations: 0 / 2.424 GB, free: 0.5662 GB / 1.092 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.01297/5.447, allocations: 2.826 MB / 2.427 GB, free: 0.5662 GB / 1.092 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.003982/5.451, allocations: 1.385 MB / 2.428 GB, free: 0.566 GB / 1.092 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.001573/5.453, allocations: 286.8 kB / 2.429 GB, free: 0.566 GB / 1.092 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0246/5.478, allocations: 50.37 MB / 2.478 GB, free: 0.5241 GB / 1.092 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.493e-06/5.478, allocations: 3.281 kB / 2.478 GB, free: 0.5241 GB / 1.092 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.04116/5.519, allocations: 27.39 MB / 2.504 GB, free: 0.5155 GB / 1.092 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001865/5.521, allocations: 0.7752 MB / 2.505 GB, free: 0.5155 GB / 1.092 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.002031/5.523, allocations: 216.9 kB / 2.505 GB, free: 0.5154 GB / 1.092 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.005483/5.528, allocations: 0.5295 MB / 2.506 GB, free: 0.5152 GB / 1.092 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001554/5.53, allocations: 0.8726 MB / 2.507 GB, free: 0.5151 GB / 1.092 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0005807/5.53, allocations: 287.1 kB / 2.507 GB, free: 0.5151 GB / 1.092 GB
Notification: Performance of sorting global known variables: time 0.002782/5.533, allocations: 2.686 MB / 2.51 GB, free: 0.5142 GB / 1.092 GB
Notification: Performance of sort global known variables: time 8.1e-08/5.533, allocations: 0 / 2.51 GB, free: 0.5142 GB / 1.092 GB
Notification: Performance of remove unused functions: time 0.03603/5.569, allocations: 16.15 MB / 2.525 GB, free: 0.5132 GB / 1.092 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 62 (pipe1.mediums[1].p,pipe1.mediums[1].h,pipe1.mediums[2].p,pipe1.mediums[2].h,pipe1.mediums[3].p,pipe1.mediums[3].h,pipe1.mediums[4].p,pipe1.mediums[4].h,pipe1.mediums[5].p,pipe1.mediums[5].h,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].h,pipe2.mediums[2].p,pipe2.mediums[2].h,pipe2.mediums[3].p,pipe2.mediums[3].h,pipe2.mediums[4].p,pipe2.mediums[4].h,pipe2.mediums[5].p,pipe2.mediums[5].h,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].h,pipe3.mediums[2].p,pipe3.mediums[2].h,pipe3.mediums[3].p,pipe3.mediums[3].h,pipe3.mediums[4].p,pipe3.mediums[4].h,pipe3.mediums[5].p,pipe3.mediums[5].h,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].h,pipe4.mediums[2].p,pipe4.mediums[2].h,pipe4.mediums[3].p,pipe4.mediums[3].h,pipe4.mediums[4].p,pipe4.mediums[4].h,pipe4.mediums[5].p,pipe4.mediums[5].h,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: 102 (pipe1.statesFM[7].phase,pipe3.statesFM[1].phase,pipe3.statesFM[7].phase,pipe4.statesFM[1].phase,pipe1.statesFM[1].phase,pipe4.statesFM[7].phase,$cse241.phase,$cse242.phase,$cse244.phase,$cse247.phase,$cse250.phase,$cse253.phase,$cse256.phase,$cse264.phase,$cse265.phase,$cse269.phase,$cse272.phase,$cse275.phase,$cse278.phase,$cse281.phase,$cse301.phase,$cse304.phase,$cse307.phase,$cse310.phase,$cse313.phase,$cse321.phase,$cse322.phase,$cse325.phase,$cse328.phase,$cse331.phase,$cse334.phase,$cse337.phase,$cse345.phase,$cse346.phase,$cse347.phase,$cse348.phase,boundary1.medium.state.phase,pipe1.mediums[1].sat.liq.phase,pipe1.mediums[1].sat.vap.phase,pipe1.mediums[2].sat.liq.phase,pipe1.mediums[2].sat.vap.phase,pipe1.mediums[3].sat.liq.phase,pipe1.mediums[3].sat.vap.phase,pipe1.mediums[4].sat.liq.phase,pipe1.mediums[4].sat.vap.phase,pipe1.mediums[5].sat.liq.phase,pipe1.mediums[5].sat.vap.phase,pipe1.statesFM[2].phase,pipe1.statesFM[3].phase,pipe1.statesFM[4].phase,pipe1.statesFM[5].phase,pipe1.statesFM[6].phase,pipe2.mediums[1].sat.liq.phase,pipe2.mediums[1].sat.vap.phase,pipe2.mediums[2].sat.liq.phase,pipe2.mediums[2].sat.vap.phase,pipe2.mediums[3].sat.liq.phase,pipe2.mediums[3].sat.vap.phase,pipe2.mediums[4].sat.liq.phase,pipe2.mediums[4].sat.vap.phase,pipe2.mediums[5].sat.liq.phase,pipe2.mediums[5].sat.vap.phase,pipe2.state_a.phase,pipe2.state_b.phase,pipe2.statesFM[1].phase,pipe2.statesFM[2].phase,pipe2.statesFM[3].phase,pipe2.statesFM[4].phase,pipe2.statesFM[5].phase,pipe3.mediums[1].sat.liq.phase,pipe3.mediums[1].sat.vap.phase,pipe3.mediums[2].sat.liq.phase,pipe3.mediums[2].sat.vap.phase,pipe3.mediums[3].sat.liq.phase,pipe3.mediums[3].sat.vap.phase,pipe3.mediums[4].sat.liq.phase,pipe3.mediums[4].sat.vap.phase,pipe3.mediums[5].sat.liq.phase,pipe3.mediums[5].sat.vap.phase,pipe3.statesFM[2].phase,pipe3.statesFM[3].phase,pipe3.statesFM[4].phase,pipe3.statesFM[5].phase,pipe3.statesFM[6].phase,pipe4.mediums[1].sat.liq.phase,pipe4.mediums[1].sat.vap.phase,pipe4.mediums[2].sat.liq.phase,pipe4.mediums[2].sat.vap.phase,pipe4.mediums[3].sat.liq.phase,pipe4.mediums[3].sat.vap.phase,pipe4.mediums[4].sat.liq.phase,pipe4.mediums[4].sat.vap.phase,pipe4.mediums[5].sat.liq.phase,pipe4.mediums[5].sat.vap.phase,pipe4.statesFM[2].phase,pipe4.statesFM[3].phase,pipe4.statesFM[4].phase,pipe4.statesFM[5].phase,pipe4.statesFM[6].phase,boundary4.medium.state.phase,boundary4.medium.sat.liq.phase,boundary4.medium.sat.vap.phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (860):
 * Single equations (assignments): 760
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 53
 * 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): 25 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%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of Backend phase and start with SimCode phase: time 0.05193/5.621, allocations: 15.39 MB / 2.54 GB, free: 0.5103 GB / 1.092 GB
Notification: Performance of simCode: created initialization part: time 0.05368/5.675, allocations: 34.14 MB / 2.574 GB, free: 0.4952 GB / 1.092 GB
Notification: Performance of simCode: created event and clocks part: time 7.303e-06/5.675, allocations: 2.75 kB / 2.574 GB, free: 0.4952 GB / 1.092 GB
Notification: Performance of simCode: created simulation system equations: time 0.02305/5.698, allocations: 12.84 MB / 2.586 GB, free: 0.4895 GB / 1.092 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01861/5.716, allocations: 4.186 MB / 2.59 GB, free: 0.4887 GB / 1.092 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.03681/5.753, allocations: 26.48 MB / 2.616 GB, free: 480.4 MB / 1.092 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.005672/5.759, allocations: 5.853 MB / 2.622 GB, free: 476 MB / 1.092 GB
Notification: Performance of simCode: alias equations: time 0.01386/5.773, allocations: 7.146 MB / 2.629 GB, free: 471.8 MB / 1.092 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.002943/5.776, allocations: 0.6043 MB / 2.63 GB, free: 471.2 MB / 1.092 GB
Notification: Performance of SimCode: time 1.403e-06/5.776, allocations: 0.5469 kB / 2.63 GB, free: 471.2 MB / 1.092 GB
Notification: Performance of Templates: time 0.8568/6.632, allocations: 0.6066 GB / 3.236 GB, free: 488.7 MB / 1.092 GB
"
[Timeout remaining time 653]
make -j1 -f HelmholtzMedia_HelmholtzMedia.Examples.BranchingDynamicPipes.makefile [Timeout 660]
(rm -f HelmholtzMedia_HelmholtzMedia.Examples.BranchingDynamicPipes.pipe ; mkfifo HelmholtzMedia_HelmholtzMedia.Examples.BranchingDynamicPipes.pipe ; head -c 1048576 < HelmholtzMedia_HelmholtzMedia.Examples.BranchingDynamicPipes.pipe >> ../files/HelmholtzMedia_HelmholtzMedia.Examples.BranchingDynamicPipes.sim & ./HelmholtzMedia_HelmholtzMedia.Examples.BranchingDynamicPipes  -abortSlowSimulation -alarm=480 -lv LOG_STATS > HelmholtzMedia_HelmholtzMedia.Examples.BranchingDynamicPipes.pipe 2>&1) [Timeout 480]
[Calling sys.exit(0), Time elapsed: 111.4931908166036]
Failed to read output from testmodel.py, exit status != 0:
6.641413081903011 6.650951159 3.6166394139999998
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f0f997aef50>