Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Physiolibrary_Physiolibrary.Fluid.Examples.BloodGasesTransport.BloodyMary.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical 1.4.1/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical 1.4.1/package.mo): time 0.1526/0.1526, allocations: 15.55 MB / 34.4 MB, free: 4.52 MB / 26.18 MB
"
[Timeout remaining time 180]
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.001374/0.001374, allocations: 97.78 kB / 41.98 MB, free: 6.199 MB / 34.91 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.001696/0.001696, allocations: 216.8 kB / 49.67 MB, free: 10.04 MB / 34.91 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.599/1.599, allocations: 230.6 MB / 287.8 MB, free: 6.352 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Physiolibrary 3.0.0/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Physiolibrary 3.0.0/package.mo): time 0.1534/0.1534, allocations: 23.73 MB / 372.4 MB, free: 2.941 MB / 286.1 MB
"
[Timeout remaining time 180]
Using package Physiolibrary with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Physiolibrary 3.0.0/package.mo)
Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo)
Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo)
Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo)
Using package Chemical with version 1.4.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical 1.4.1/package.mo)
Running command: translateModel(Physiolibrary.Fluid.Examples.BloodGasesTransport.BloodyMary,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Physiolibrary_Physiolibrary.Fluid.Examples.BloodGasesTransport.BloodyMary")
translateModel(Physiolibrary.Fluid.Examples.BloodGasesTransport.BloodyMary,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Physiolibrary_Physiolibrary.Fluid.Examples.BloodGasesTransport.BloodyMary") [Timeout 660]
"Notification: Chemical requested package Modelica of version 4.0.0. Modelica 4.1.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Physiolibrary requested package Modelica of version 4.0.0. Modelica 4.1.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Physiolibrary requested package Complex of version 4.0.0. Complex 4.1.0 is used instead which states that it is fully compatible without conversion script needed.
Warning: Requested package Chemical of version 1.4.0, but this package was already loaded with version 1.4.1. There are no conversion annotations and 1.4.0 is older than 1.4.1, so the libraries are probably incompatible.
Notification: Performance of FrontEnd - loaded program: time 0.003618/0.003618, allocations: 115.8 kB / 0.5052 GB, free: 14.59 MB / 366.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4093/0.4129, allocations: 63.86 MB / 0.5675 GB, free: 14.35 MB / 398.1 MB
Notification: Performance of NFInst.instantiate(Physiolibrary.Fluid.Examples.BloodGasesTransport.BloodyMary): time 0.5467/0.9596, allocations: 195.1 MB / 0.7581 GB, free: 128 kB / 0.5294 GB
Notification: Performance of NFInst.instExpressions: time 0.1406/1.1, allocations: 110.1 MB / 0.8656 GB, free: 14.96 MB / 0.5919 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01133/1.112, allocations: 151.2 kB / 0.8657 GB, free: 14.81 MB / 0.5919 GB
Notification: Performance of NFTyping.typeComponents: time 0.01123/1.123, allocations: 3.251 MB / 0.8689 GB, free: 11.54 MB / 0.5919 GB
Notification: Performance of NFTyping.typeBindings: time 0.03514/1.158, allocations: 12.38 MB / 0.881 GB, free: 15.1 MB / 0.6075 GB
Notification: Performance of NFTyping.typeClassSections: time 0.05195/1.21, allocations: 18.9 MB / 0.8994 GB, free: 12.12 MB / 0.6231 GB
Notification: Performance of NFFlatten.flatten: time 0.03001/1.24, allocations: 22.31 MB / 0.9212 GB, free: 5.746 MB / 0.6387 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.04649/1.286, allocations: 22.76 MB / 0.9434 GB, free: 14.85 MB / 0.67 GB
Notification: Performance of NFEvalConstants.evaluate: time 3.687/4.973, allocations: 387.8 MB / 1.322 GB, free: 211.3 MB / 0.8575 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.9108/5.884, allocations: 140.6 MB / 1.459 GB, free: 145.7 MB / 0.8575 GB
Notification: Performance of NFPackage.collectConstants: time 0.01164/5.896, allocations: 3.965 MB / 1.463 GB, free: 141.7 MB / 0.8575 GB
Notification: Performance of NFFlatten.collectFunctions: time 5.417/11.31, allocations: 0.6314 GB / 2.095 GB, free: 148.1 MB / 0.8575 GB
Notification: Performance of NFScalarize.scalarize: time 0.02277/11.34, allocations: 19.67 MB / 2.114 GB, free: 139 MB / 0.8575 GB
Notification: Performance of NFVerifyModel.verify: time 0.04673/11.38, allocations: 18.84 MB / 2.132 GB, free: 125 MB / 0.8575 GB
Notification: Performance of NFConvertDAE.convert: time 0.09487/11.48, allocations: 77 MB / 2.207 GB, free: 51.56 MB / 0.8575 GB
Notification: Performance of FrontEnd - DAE generated: time 6.573e-06/11.48, allocations: 3.984 kB / 2.207 GB, free: 51.55 MB / 0.8575 GB
Notification: Performance of FrontEnd: time 2.334e-06/11.48, allocations: 0 / 2.207 GB, free: 51.55 MB / 0.8575 GB
Notification: Performance of Transformations before backend: time 0.001695/11.48, allocations: 4 kB / 2.207 GB, free: 51.55 MB / 0.8575 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 8166
 * Number of variables: 8166
Notification: Performance of Generate backend data structure: time 0.1041/11.58, allocations: 36.84 MB / 2.243 GB, free: 14.57 MB / 0.8575 GB
Notification: Performance of prepare preOptimizeDAE: time 4.107e-05/11.58, allocations: 16.03 kB / 2.243 GB, free: 14.55 MB / 0.8575 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0188/11.6, allocations: 4 MB / 2.247 GB, free: 10.55 MB / 0.8575 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.609/12.21, allocations: 18.84 MB / 2.266 GB, free: 394 MB / 0.8575 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.002941/12.21, allocations: 2.736 MB / 2.268 GB, free: 392.9 MB / 0.8575 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.01273/12.23, allocations: 2.8 MB / 2.271 GB, free: 392 MB / 0.8575 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.1395/12.37, allocations: 81.08 MB / 2.35 GB, free: 324.8 MB / 0.8575 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.001327/12.37, allocations: 120.9 kB / 2.35 GB, free: 324.6 MB / 0.8575 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.01063/12.38, allocations: 1.126 MB / 2.352 GB, free: 323.5 MB / 0.8575 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.001369/12.38, allocations: 1.604 MB / 2.353 GB, free: 321.9 MB / 0.8575 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.1443/12.52, allocations: 119.5 MB / 2.47 GB, free: 202.4 MB / 0.8575 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.8976/13.42, allocations: 263.5 MB / 2.727 GB, free: 280.6 MB / 0.8577 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.05965/13.48, allocations: 47.5 MB / 2.774 GB, free: 261 MB / 0.8577 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.04671/13.53, allocations: 37.55 MB / 2.81 GB, free: 241.9 MB / 0.8577 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.1644/13.69, allocations: 124.2 MB / 2.931 GB, free: 116.8 MB / 0.8577 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0001558/13.69, allocations: 260.3 kB / 2.932 GB, free: 116.5 MB / 0.8577 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.02897/13.72, allocations: 6.808 MB / 2.938 GB, free: 110.8 MB / 0.8577 GB
Notification: Performance of pre-optimization done (n=3087): time 5.859e-05/13.72, allocations: 0 / 2.938 GB, free: 110.8 MB / 0.8577 GB
Notification: Performance of matching and sorting (n=3087): time 0.7943/14.52, allocations: 132.2 MB / 3.067 GB, free: 351.9 MB / 0.8579 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001622/14.52, allocations: 287.4 kB / 3.068 GB, free: 351.8 MB / 0.8579 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01852/14.53, allocations: 16.16 MB / 3.084 GB, free: 347.2 MB / 0.8579 GB
Notification: Performance of collectPreVariables (initialization): time 0.005449/14.54, allocations: 422.1 kB / 3.084 GB, free: 346.9 MB / 0.8579 GB
Notification: Performance of collectInitialEqns (initialization): time 0.005916/14.55, allocations: 11.91 MB / 3.096 GB, free: 340 MB / 0.8579 GB
Notification: Performance of collectInitialBindings (initialization): time 0.01193/14.56, allocations: 11.17 MB / 3.106 GB, free: 332.2 MB / 0.8579 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.02413/14.58, allocations: 7.713 MB / 3.114 GB, free: 329.3 MB / 0.8579 GB
Notification: Performance of setup shared object (initialization): time 3.677e-05/14.58, allocations: 304.1 kB / 3.114 GB, free: 329 MB / 0.8579 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.04592/14.63, allocations: 39.74 MB / 3.153 GB, free: 305.8 MB / 0.8579 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.05211/14.68, allocations: 50.96 MB / 3.203 GB, free: 250.1 MB / 0.8579 GB
Notification: Performance of analyzeInitialSystem (initialization): time 2.221/16.9, allocations: 349.2 MB / 3.544 GB, free: 222.5 MB / 0.8579 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0003342/16.9, allocations: 96 kB / 3.544 GB, free: 222.5 MB / 0.8579 GB
Notification: Performance of matching and sorting (n=4958) (initialization): time 0.1977/17.1, allocations: 101.8 MB / 3.643 GB, free: 121.7 MB / 0.8579 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002213/17.1, allocations: 156 kB / 3.644 GB, free: 121.5 MB / 0.8579 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0004427/17.1, allocations: 344 kB / 3.644 GB, free: 121.2 MB / 0.8579 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.1623/17.26, allocations: 16.58 MB / 3.66 GB, free: 104.6 MB / 0.8579 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02908/17.29, allocations: 7.834 MB / 3.668 GB, free: 96.79 MB / 0.8579 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0159/17.31, allocations: 19.39 MB / 3.687 GB, free: 76.97 MB / 0.8579 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02661/17.33, allocations: 1.705 MB / 3.688 GB, free: 75.33 MB / 0.8579 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.007825/17.34, allocations: 2.475 MB / 3.691 GB, free: 72.86 MB / 0.8579 GB
Warning: Assuming fixed start value for the following 18 variables:
         pulmonaryArteries.extraSubstanceAmounts[1]:VARIABLE(start = pulmonaryArteries.tm_start * pulmonaryArteries.C_start[1] fixed = true )  \"Current amount of extra substances\" type: Real [3]
         pulmonaryArteries.extraSubstanceAmounts[2]:VARIABLE(start = pulmonaryArteries.tm_start * pulmonaryArteries.C_start[2] fixed = true )  \"Current amount of extra substances\" type: Real [3]
         pulmonaryArteries.extraSubstanceAmounts[3]:VARIABLE(start = pulmonaryArteries.tm_start * pulmonaryArteries.C_start[3] fixed = true )  \"Current amount of extra substances\" type: Real [3]
         pulmonaryVeins.extraSubstanceAmounts[1]:VARIABLE(start = pulmonaryVeins.tm_start * pulmonaryVeins.C_start[1] fixed = true )  \"Current amount of extra substances\" type: Real [3]
         pulmonaryVeins.extraSubstanceAmounts[2]:VARIABLE(start = pulmonaryVeins.tm_start * pulmonaryVeins.C_start[2] fixed = true )  \"Current amount of extra substances\" type: Real [3]
         pulmonaryVeins.extraSubstanceAmounts[3]:VARIABLE(start = pulmonaryVeins.tm_start * pulmonaryVeins.C_start[3] fixed = true )  \"Current amount of extra substances\" type: Real [3]
         systemicArteries.extraSubstanceAmounts[1]:VARIABLE(start = systemicArteries.tm_start * systemicArteries.C_start[1] fixed = true )  \"Current amount of extra substances\" type: Real [3]
         systemicArteries.extraSubstanceAmounts[2]:VARIABLE(start = systemicArteries.tm_start * systemicArteries.C_start[2] fixed = true )  \"Current amount of extra substances\" type: Real [3]
         systemicArteries.extraSubstanceAmounts[3]:VARIABLE(start = systemicArteries.tm_start * systemicArteries.C_start[3] fixed = true )  \"Current amount of extra substances\" type: Real [3]
         systemicVeins.extraSubstanceAmounts[1]:VARIABLE(start = systemicVeins.tm_start * systemicVeins.C_start[1] fixed = true )  \"Current amount of extra substances\" type: Real [3]
         systemicVeins.extraSubstanceAmounts[2]:VARIABLE(start = systemicVeins.tm_start * systemicVeins.C_start[2] fixed = true )  \"Current amount of extra substances\" type: Real [3]
         systemicVeins.extraSubstanceAmounts[3]:VARIABLE(start = systemicVeins.tm_start * systemicVeins.C_start[3] fixed = true )  \"Current amount of extra substances\" type: Real [3]
         respiratoryUnit[1].pulmCapysVentilated.extraSubstanceAmounts[1]:VARIABLE(start = respiratoryUnit[1].pulmCapysVentilated.tm_start * respiratoryUnit[1].pulmCapysVentilated.C_start[1] fixed = true )  \"Current amount of extra substances\" type: Real [1,3]
         respiratoryUnit[1].pulmCapysVentilated.extraSubstanceAmounts[2]:VARIABLE(start = respiratoryUnit[1].pulmCapysVentilated.tm_start * respiratoryUnit[1].pulmCapysVentilated.C_start[2] fixed = true )  \"Current amount of extra substances\" type: Real [1,3]
         respiratoryUnit[1].pulmCapysVentilated.extraSubstanceAmounts[3]:VARIABLE(start = respiratoryUnit[1].pulmCapysVentilated.tm_start * respiratoryUnit[1].pulmCapysVentilated.C_start[3] fixed = true )  \"Current amount of extra substances\" type: Real [1,3]
         tissueUnit[1].systemicCapillaries.extraSubstanceAmounts[1]:VARIABLE(start = tissueUnit[1].systemicCapillaries.tm_start * tissueUnit[1].systemicCapillaries.C_start[1] fixed = true )  \"Current amount of extra substances\" type: Real [1,3]
         tissueUnit[1].systemicCapillaries.extraSubstanceAmounts[2]:VARIABLE(start = tissueUnit[1].systemicCapillaries.tm_start * tissueUnit[1].systemicCapillaries.C_start[2] fixed = true )  \"Current amount of extra substances\" type: Real [1,3]
         tissueUnit[1].systemicCapillaries.extraSubstanceAmounts[3]:VARIABLE(start = tissueUnit[1].systemicCapillaries.tm_start * tissueUnit[1].systemicCapillaries.C_start[3] fixed = true )  \"Current amount of extra substances\" type: Real [1,3]
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 1571
 * 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 (4024):
 * Single equations (assignments): 3985
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 20
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 19
 * 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): 19 systems
   {(1,1), (1,1), (1,1), (1,1), (1,1), (1,3), (4,28), (1,1), (1,3), (5,10), (1,3), (1,1), (6,9), (1,3), (6,9), (1,3), (1,2), (5,10), (1,3)}
Notification: Performance of prepare postOptimizeDAE: time 0.02189/17.36, allocations: 10.75 MB / 3.701 GB, free: 62.32 MB / 0.8579 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.007514/17.37, allocations: 1.855 MB / 3.703 GB, free: 60.79 MB / 0.8579 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.5076/17.88, allocations: 96.05 MB / 3.797 GB, free: 309.4 MB / 0.8579 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.1656/18.04, allocations: 80.87 MB / 3.876 GB, free: 231.9 MB / 0.8579 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 5.555e-05/18.04, allocations: 0 / 3.876 GB, free: 231.9 MB / 0.8579 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0006073/18.04, allocations: 125.7 kB / 3.876 GB, free: 231.8 MB / 0.8579 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.2758/18.32, allocations: 147 MB / 4.02 GB, free: 81.96 MB / 0.8579 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0001537/18.32, allocations: 0 / 4.02 GB, free: 81.96 MB / 0.8579 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.02601/18.35, allocations: 5.505 MB / 4.025 GB, free: 76.46 MB / 0.8579 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.1246/18.47, allocations: 13.38 MB / 4.038 GB, free: 63.53 MB / 0.8579 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.006284/18.48, allocations: 0.9566 MB / 4.039 GB, free: 62.57 MB / 0.8579 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01372/18.49, allocations: 18.52 MB / 4.057 GB, free: 43.66 MB / 0.8579 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.755e-06/18.49, allocations: 0 / 4.057 GB, free: 43.66 MB / 0.8579 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.5751/19.07, allocations: 151.8 MB / 4.205 GB, free: 248.4 MB / 0.8579 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.02337/19.09, allocations: 8.376 MB / 4.213 GB, free: 240.7 MB / 0.8579 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.00899/19.1, allocations: 0.669 MB / 4.214 GB, free: 240 MB / 0.8579 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01937/19.12, allocations: 1.105 MB / 4.215 GB, free: 238.9 MB / 0.8579 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.008177/19.13, allocations: 2.546 MB / 4.218 GB, free: 236.4 MB / 0.8579 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.005477/19.13, allocations: 1.41 MB / 4.219 GB, free: 235 MB / 0.8579 GB
Notification: Performance of sorting global known variables: time 0.01474/19.15, allocations: 10.28 MB / 4.229 GB, free: 224.7 MB / 0.8579 GB
Notification: Performance of sort global known variables: time 2.1e-07/19.15, allocations: 0 / 4.229 GB, free: 224.7 MB / 0.8579 GB
Notification: Performance of remove unused functions: time 0.04253/19.19, allocations: 14.94 MB / 4.244 GB, free: 211.1 MB / 0.8579 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 263 (pulmonaryArteries.enthalpy,pulmonaryArteries.extraSubstanceAmounts[1],pulmonaryArteries.extraSubstanceAmounts[2],pulmonaryArteries.extraSubstanceAmounts[3],pulmonaryArteries.substanceMasses[1],pulmonaryArteries.substanceMasses[2],pulmonaryArteries.substanceMasses[3],pulmonaryArteries.substanceMasses[4],pulmonaryArteries.substanceMasses[5],pulmonaryArteries.substanceMasses[6],pulmonaryArteries.substanceMasses[7],pulmonaryArteries.substanceMasses[8],pulmonaryArteries.substanceMasses[9],pulmonaryArteries.substanceMasses[10],pulmonaryArteries.substanceMasses[11],pulmonaryArteries.substanceMasses[12],pulmonaryArteries.substanceMasses[13],pulmonaryArteries.substanceMasses[14],pulmonaryArteries.substanceMasses[15],pulmonaryArteries.substanceMasses[16],pulmonaryArteries.substanceMasses[17],pulmonaryArteries.substanceMasses[18],pulmonaryArteries.substanceMasses[19],pulmonaryArteries.substanceMasses[20],pulmonaryArteries.substanceMasses[21],pulmonaryArteries.substanceMasses[22],pulmonaryArteries.substanceMasses[23],pulmonaryArteries.substanceMasses[24],pulmonaryArteries.substanceMasses[25],pulmonaryArteries.substanceMasses[26],pulmonaryArteries.substanceMasses[27],pulmonaryArteries.substanceMasses[28],pulmonaryArteries.substanceMasses[29],pulmonaryArteries.substanceMasses[30],pulmonaryArteries.substanceMasses[31],pulmonaryArteries.substanceMasses[32],pulmonaryArteries.substanceMasses[33],pulmonaryArteries.substanceMasses[34],pulmonaryArteries.substanceMasses[35],pulmonaryArteries.substanceMasses[36],pulmonaryArteries.substanceMasses[37],pulmonaryArteries.substanceMasses[38],pulmonaryArteries.substanceMasses[39],pulmonaryVeins.enthalpy,pulmonaryVeins.extraSubstanceAmounts[1],pulmonaryVeins.extraSubstanceAmounts[2],pulmonaryVeins.extraSubstanceAmounts[3],pulmonaryVeins.substanceMasses[1],pulmonaryVeins.substanceMasses[2],pulmonaryVeins.substanceMasses[3],pulmonaryVeins.substanceMasses[4],pulmonaryVeins.substanceMasses[5],pulmonaryVeins.substanceMasses[6],pulmonaryVeins.substanceMasses[7],pulmonaryVeins.substanceMasses[8],pulmonaryVeins.substanceMasses[9],pulmonaryVeins.substanceMasses[10],pulmonaryVeins.substanceMasses[11],pulmonaryVeins.substanceMasses[12],pulmonaryVeins.substanceMasses[13],pulmonaryVeins.substanceMasses[14],pulmonaryVeins.substanceMasses[15],pulmonaryVeins.substanceMasses[16],pulmonaryVeins.substanceMasses[17],pulmonaryVeins.substanceMasses[18],pulmonaryVeins.substanceMasses[19],pulmonaryVeins.substanceMasses[20],pulmonaryVeins.substanceMasses[21],pulmonaryVeins.substanceMasses[22],pulmonaryVeins.substanceMasses[23],pulmonaryVeins.substanceMasses[24],pulmonaryVeins.substanceMasses[25],pulmonaryVeins.substanceMasses[26],pulmonaryVeins.substanceMasses[27],pulmonaryVeins.substanceMasses[28],pulmonaryVeins.substanceMasses[29],pulmonaryVeins.substanceMasses[30],pulmonaryVeins.substanceMasses[31],pulmonaryVeins.substanceMasses[32],pulmonaryVeins.substanceMasses[33],pulmonaryVeins.substanceMasses[34],pulmonaryVeins.substanceMasses[35],pulmonaryVeins.substanceMasses[36],pulmonaryVeins.substanceMasses[37],pulmonaryVeins.substanceMasses[38],pulmonaryVeins.substanceMasses[39],systemicArteries.chemicalSolution.substanceMasses[1],systemicArteries.chemicalSolution.substanceMasses[2],systemicArteries.chemicalSolution.substanceMasses[3],systemicArteries.chemicalSolution.substanceMasses[4],systemicArteries.chemicalSolution.substanceMasses[5],systemicArteries.chemicalSolution.substanceMasses[6],systemicArteries.chemicalSolution.substanceMasses[7],systemicArteries.chemicalSolution.substanceMasses[8],systemicArteries.chemicalSolution.substanceMasses[9],systemicArteries.chemicalSolution.substanceMasses[10],systemicArteries.chemicalSolution.substanceMasses[11],systemicArteries.chemicalSolution.substanceMasses[12],systemicArteries.chemicalSolution.substanceMasses[13],systemicArteries.chemicalSolution.substanceMasses[14],systemicArteries.chemicalSolution.substanceMasses[15],systemicArteries.chemicalSolution.substanceMasses[16],systemicArteries.chemicalSolution.substanceMasses[17],systemicArteries.chemicalSolution.substanceMasses[18],systemicArteries.chemicalSolution.substanceMasses[19],systemicArteries.chemicalSolution.substanceMasses[20],systemicArteries.chemicalSolution.substanceMasses[21],systemicArteries.chemicalSolution.substanceMasses[22],systemicArteries.chemicalSolution.substanceMasses[23],systemicArteries.chemicalSolution.substanceMasses[24],systemicArteries.chemicalSolution.substanceMasses[25],systemicArteries.chemicalSolution.substanceMasses[26],systemicArteries.chemicalSolution.substanceMasses[27],systemicArteries.chemicalSolution.substanceMasses[28],systemicArteries.chemicalSolution.substanceMasses[29],systemicArteries.chemicalSolution.substanceMasses[30],systemicArteries.chemicalSolution.substanceMasses[31],systemicArteries.chemicalSolution.substanceMasses[32],systemicArteries.chemicalSolution.substanceMasses[33],systemicArteries.chemicalSolution.substanceMasses[34],systemicArteries.chemicalSolution.substanceMasses[35],systemicArteries.chemicalSolution.substanceMasses[36],systemicArteries.chemicalSolution.substanceMasses[37],systemicArteries.chemicalSolution.substanceMasses[38],systemicArteries.chemicalSolution.substanceMasses[39],systemicArteries.enthalpy,systemicArteries.extraSubstanceAmounts[1],systemicArteries.extraSubstanceAmounts[2],systemicArteries.extraSubstanceAmounts[3],systemicVeins.chemicalSolution.substanceMasses[1],systemicVeins.chemicalSolution.substanceMasses[2],systemicVeins.chemicalSolution.substanceMasses[3],systemicVeins.chemicalSolution.substanceMasses[4],systemicVeins.chemicalSolution.substanceMasses[5],systemicVeins.chemicalSolution.substanceMasses[6],systemicVeins.chemicalSolution.substanceMasses[7],systemicVeins.chemicalSolution.substanceMasses[8],systemicVeins.chemicalSolution.substanceMasses[9],systemicVeins.chemicalSolution.substanceMasses[10],systemicVeins.chemicalSolution.substanceMasses[11],systemicVeins.chemicalSolution.substanceMasses[12],systemicVeins.chemicalSolution.substanceMasses[13],systemicVeins.chemicalSolution.substanceMasses[14],systemicVeins.chemicalSolution.substanceMasses[15],systemicVeins.chemicalSolution.substanceMasses[16],systemicVeins.chemicalSolution.substanceMasses[17],systemicVeins.chemicalSolution.substanceMasses[18],systemicVeins.chemicalSolution.substanceMasses[19],systemicVeins.chemicalSolution.substanceMasses[20],systemicVeins.chemicalSolution.substanceMasses[21],systemicVeins.chemicalSolution.substanceMasses[22],systemicVeins.chemicalSolution.substanceMasses[23],systemicVeins.chemicalSolution.substanceMasses[24],systemicVeins.chemicalSolution.substanceMasses[25],systemicVeins.chemicalSolution.substanceMasses[26],systemicVeins.chemicalSolution.substanceMasses[27],systemicVeins.chemicalSolution.substanceMasses[28],systemicVeins.chemicalSolution.substanceMasses[29],systemicVeins.chemicalSolution.substanceMasses[30],systemicVeins.chemicalSolution.substanceMasses[31],systemicVeins.chemicalSolution.substanceMasses[32],systemicVeins.chemicalSolution.substanceMasses[33],systemicVeins.chemicalSolution.substanceMasses[34],systemicVeins.chemicalSolution.substanceMasses[35],systemicVeins.chemicalSolution.substanceMasses[36],systemicVeins.chemicalSolution.substanceMasses[37],systemicVeins.chemicalSolution.substanceMasses[38],systemicVeins.chemicalSolution.substanceMasses[39],systemicVeins.enthalpy,systemicVeins.extraSubstanceAmounts[1],systemicVeins.extraSubstanceAmounts[2],systemicVeins.extraSubstanceAmounts[3],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[1],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[2],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[3],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[4],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[5],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[6],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[7],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[8],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[9],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[10],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[11],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[12],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[13],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[14],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[15],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[16],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[17],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[18],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[19],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[20],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[21],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[22],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[23],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[24],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[25],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[26],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[27],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[28],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[29],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[30],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[31],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[32],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[33],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[34],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[35],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[36],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[37],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[38],respiratoryUnit[1].pulmCapysVentilated.chemicalSolution.substanceMasses[39],respiratoryUnit[1].pulmCapysVentilated.enthalpy,respiratoryUnit[1].pulmCapysVentilated.extraSubstanceAmounts[1],respiratoryUnit[1].pulmCapysVentilated.extraSubstanceAmounts[2],respiratoryUnit[1].pulmCapysVentilated.extraSubstanceAmounts[3],respiratoryUnit[1].alveoli.chemicalSolution.substanceMasses[1],respiratoryUnit[1].alveoli.chemicalSolution.substanceMasses[2],respiratoryUnit[1].alveoli.chemicalSolution.substanceMasses[3],respiratoryUnit[1].alveoli.chemicalSolution.substanceMasses[4],respiratoryUnit[1].alveoli.enthalpy,tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[1],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[2],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[3],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[4],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[5],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[6],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[7],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[8],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[9],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[10],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[11],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[12],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[13],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[14],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[15],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[16],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[17],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[18],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[19],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[20],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[21],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[22],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[23],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[24],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[25],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[26],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[27],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[28],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[29],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[30],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[31],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[32],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[33],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[34],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[35],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[36],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[37],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[38],tissueUnit[1].systemicCapillaries.chemicalSolution.substanceMasses[39],tissueUnit[1].systemicCapillaries.enthalpy,tissueUnit[1].systemicCapillaries.extraSubstanceAmounts[1],tissueUnit[1].systemicCapillaries.extraSubstanceAmounts[2],tissueUnit[1].systemicCapillaries.extraSubstanceAmounts[3])
 * 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 (2862):
 * Single equations (assignments): 2823
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 20
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 19
 * 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): 19 systems
   {(1,1), (1,1), (1,1), (1,1), (1,1), (1,4), (4,35), (1,1), (1,4), (6,10), (1,4), (1,1), (6,10), (1,4), (6,10), (1,4), (1,3), (5,11), (1,4)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.02243/19.21, allocations: 9.623 MB / 4.253 GB, free: 203.5 MB / 0.8579 GB
Notification: Performance of simCode: created initialization part: time 0.1066/19.32, allocations: 87.31 MB / 4.338 GB, free: 116.2 MB / 0.8579 GB
Notification: Performance of simCode: created event and clocks part: time 6.662e-06/19.32, allocations: 0 / 4.338 GB, free: 116.2 MB / 0.8579 GB
Notification: Performance of simCode: created simulation system equations: time 0.05127/19.37, allocations: 41.24 MB / 4.378 GB, free: 74.87 MB / 0.8579 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.07189/19.44, allocations: 14.88 MB / 4.393 GB, free: 61.1 MB / 0.8579 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.4727/19.91, allocations: 119.3 MB / 4.51 GB, free: 264.6 MB / 0.8579 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.03412/19.95, allocations: 17.89 MB / 4.527 GB, free: 251.2 MB / 0.8579 GB
Notification: Performance of simCode: alias equations: time 0.05247/20, allocations: 18.02 MB / 4.545 GB, free: 237.4 MB / 0.8579 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.01378/20.01, allocations: 2.813 MB / 4.547 GB, free: 234.6 MB / 0.8579 GB
Notification: Performance of SimCode: time 8.92e-07/20.01, allocations: 0 / 4.547 GB, free: 234.6 MB / 0.8579 GB
Notification: Performance of Templates: time 1.913/21.93, allocations: 0.8592 GB / 5.407 GB, free: 266.4 MB / 0.8579 GB
"
[Timeout remaining time 638]
make -j1 -f Physiolibrary_Physiolibrary.Fluid.Examples.BloodGasesTransport.BloodyMary.makefile [Timeout 660]
(rm -f Physiolibrary_Physiolibrary.Fluid.Examples.BloodGasesTransport.BloodyMary.pipe ; mkfifo Physiolibrary_Physiolibrary.Fluid.Examples.BloodGasesTransport.BloodyMary.pipe ; head -c 1048576 < Physiolibrary_Physiolibrary.Fluid.Examples.BloodGasesTransport.BloodyMary.pipe >> ../files/Physiolibrary_Physiolibrary.Fluid.Examples.BloodGasesTransport.BloodyMary.sim & ./Physiolibrary_Physiolibrary.Fluid.Examples.BloodGasesTransport.BloodyMary  -abortSlowSimulation -alarm=480 -lv LOG_STATS > Physiolibrary_Physiolibrary.Fluid.Examples.BloodGasesTransport.BloodyMary.pipe 2>&1) [Timeout 480]
[Calling sys.exit(0), Time elapsed: 63.392205299809575]
Failed to read output from testmodel.py, exit status != 0:
21.93566266261041 21.945293995 10.465889952
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fc488f0afe0>