Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Chemical_Chemical.Examples.AcidBase.CarbonDioxideInBlood.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical 1.4.1-master/package.mo", uses=false)
Using package Chemical with version 1.4.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical 1.4.1-master/package.mo)
Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo)
Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Running command: "" <> buildModelFMU(Chemical.Examples.AcidBase.CarbonDioxideInBlood,fileNamePrefix="Chemical_Chemical_Examples_AcidBase_CarbonDioxideInBlood",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(Chemical.Examples.AcidBase.CarbonDioxideInBlood,fileNamePrefix="Chemical_Chemical_Examples_AcidBase_CarbonDioxideInBlood",fmuType="me",version="2.0",platforms={"static"})
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001426/0.001426, allocations: 108.6 kB / 15.73 MB, free: 76 kB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.00131/0.00131, allocations: 190.3 kB / 16.66 MB, free: 6.59 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.495/1.495, allocations: 222.9 MB / 240.4 MB, free: 4.332 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical 1.4.1-master/package.mo): time 0.1922/0.1922, allocations: 15.33 MB / 305.9 MB, free: 15.3 MB / 254.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.002048/0.002048, allocations: 67.89 kB / 424.7 MB, free: 13.59 MB / 366.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2692/0.2713, allocations: 53.61 MB / 478.3 MB, free: 25.68 MB / 366.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical 1.4.1-master/package.mo:4740:7-4740:66:writable] Warning: An inner declaration for outer component system could not be found and was automatically generated.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical 1.4.1-master/package.mo:4740:7-4740:66:writable] Notification: The diagnostics message for the missing inner is: 
Your model is using an outer "system" component but
an inner "system" component is not defined.
For simulation drag Modelica.Fluid.System into your model
to specify system properties.
Notification: Performance of NFInst.instantiate(Chemical.Examples.AcidBase.CarbonDioxideInBlood): time 0.03627/0.3076, allocations: 34.21 MB / 0.5005 GB, free: 0.4922 MB / 366.1 MB
Notification: Performance of NFInst.instExpressions: time 0.0618/0.3694, allocations: 47.41 MB / 0.5468 GB, free: 0.9023 MB / 414.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003156/0.3726, allocations: 35.81 kB / 0.5469 GB, free: 0.8672 MB / 414.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.00439/0.377, allocations: 1.016 MB / 0.5478 GB, free: 15.84 MB / 430.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.01232/0.3893, allocations: 3.709 MB / 0.5515 GB, free: 12.11 MB / 430.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.01806/0.4074, allocations: 6.372 MB / 0.5577 GB, free: 5.699 MB / 430.1 MB
Notification: Performance of NFFlatten.flatten: time 0.007523/0.415, allocations: 4.539 MB / 0.5621 GB, free: 1.141 MB / 430.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.005233/0.4202, allocations: 2.659 MB / 0.5647 GB, free: 14.42 MB / 446.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.004089/0.4243, allocations: 2.233 MB / 0.5669 GB, free: 12.18 MB / 446.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.005001/0.4294, allocations: 2.562 MB / 0.5694 GB, free: 9.613 MB / 446.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.001462/0.4308, allocations: 416 kB / 0.5698 GB, free: 9.207 MB / 446.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.01702/0.4479, allocations: 5.285 MB / 0.575 GB, free: 3.914 MB / 446.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.00167/0.4496, allocations: 0.9854 MB / 0.5759 GB, free: 2.926 MB / 446.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.002964/0.4526, allocations: 2.023 MB / 0.5779 GB, free: 0.8945 MB / 446.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.02324/0.4758, allocations: 9.93 MB / 0.5876 GB, free: 6.926 MB / 462.1 MB
Notification: Performance of FrontEnd - DAE generated: time 6.482e-06/0.4759, allocations: 0 / 0.5876 GB, free: 6.926 MB / 462.1 MB
Notification: Performance of FrontEnd: time 1.903e-06/0.4759, allocations: 0 / 0.5876 GB, free: 6.926 MB / 462.1 MB
Notification: Performance of Transformations before backend: time 0.0001113/0.476, allocations: 0 / 0.5876 GB, free: 6.926 MB / 462.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 803
 * Number of variables: 803
Notification: Performance of Generate backend data structure: time 0.01101/0.487, allocations: 4.883 MB / 0.5924 GB, free: 1.965 MB / 462.1 MB
Notification: Performance of prepare preOptimizeDAE: time 5.274e-05/0.4871, allocations: 12.03 kB / 0.5924 GB, free: 1.953 MB / 462.1 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0005728/0.4877, allocations: 426.6 kB / 0.5928 GB, free: 1.523 MB / 462.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003907/0.4916, allocations: 0.8526 MB / 0.5936 GB, free: 0.668 MB / 462.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.003092/0.4947, allocations: 1.663 MB / 0.5952 GB, free: 14.95 MB / 478.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002902/0.495, allocations: 302.2 kB / 0.5955 GB, free: 14.64 MB / 478.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0006116/0.4956, allocations: 329.8 kB / 0.5958 GB, free: 14.32 MB / 478.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.008087/0.5037, allocations: 4.469 MB / 0.6002 GB, free: 9.781 MB / 478.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 5.51e-05/0.5038, allocations: 7.984 kB / 0.6002 GB, free: 9.773 MB / 478.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003542/0.5042, allocations: 124 kB / 0.6003 GB, free: 9.652 MB / 478.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 6.929e-05/0.5042, allocations: 80 kB / 0.6004 GB, free: 9.574 MB / 478.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01023/0.5145, allocations: 6.111 MB / 0.6064 GB, free: 3.453 MB / 478.1 MB
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.2395/0.754, allocations: 14 MB / 0.62 GB, free: 107.6 MB / 478.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.008862/0.7629, allocations: 6.314 MB / 0.6262 GB, free: 104.6 MB / 478.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.003018/0.7659, allocations: 2.237 MB / 0.6284 GB, free: 103.7 MB / 478.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.01994/0.7859, allocations: 14.79 MB / 0.6428 GB, free: 92.08 MB / 478.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.991e-05/0.7859, allocations: 63.2 kB / 0.6429 GB, free: 92.02 MB / 478.1 MB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.001742/0.7877, allocations: 384.6 kB / 0.6433 GB, free: 91.84 MB / 478.1 MB
Notification: Performance of pre-optimization done (n=284): time 7.774e-06/0.7877, allocations: 0 / 0.6433 GB, free: 91.84 MB / 478.1 MB
Notification: Performance of matching and sorting (n=387): time 0.08569/0.8734, allocations: 23.91 MB / 0.6666 GB, free: 77.52 MB / 478.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.821e-05/0.8735, allocations: 94.45 kB / 0.6667 GB, free: 77.41 MB / 478.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001793/0.8753, allocations: 1.703 MB / 0.6684 GB, free: 75.68 MB / 478.1 MB
Notification: Performance of collectPreVariables (initialization): time 0.0006669/0.876, allocations: 89.7 kB / 0.6685 GB, free: 75.59 MB / 478.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0006021/0.8766, allocations: 1.349 MB / 0.6698 GB, free: 74.39 MB / 478.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.001006/0.8776, allocations: 1.374 MB / 0.6711 GB, free: 73.2 MB / 478.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0009865/0.8786, allocations: 0.7759 MB / 0.6719 GB, free: 72.41 MB / 478.1 MB
Notification: Performance of setup shared object (initialization): time 4.758e-05/0.8787, allocations: 305.1 kB / 0.6722 GB, free: 72.11 MB / 478.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.00238/0.881, allocations: 1.824 MB / 0.6739 GB, free: 70.28 MB / 478.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002882/0.8839, allocations: 2.818 MB / 0.6767 GB, free: 67.06 MB / 478.1 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.005735/0.8897, allocations: 4.935 MB / 0.6815 GB, free: 61.76 MB / 478.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.759e-05/0.8897, allocations: 8 kB / 0.6815 GB, free: 61.75 MB / 478.1 MB
Notification: Performance of matching and sorting (n=542) (initialization): time 0.01705/0.9068, allocations: 6.819 MB / 0.6882 GB, free: 54.94 MB / 478.1 MB
Notification: Performance of prepare postOptimizeDAE: time 4.067e-05/0.9069, allocations: 18.72 kB / 0.6882 GB, free: 54.93 MB / 478.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.07e-05/0.9069, allocations: 37.33 kB / 0.6882 GB, free: 54.89 MB / 478.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01062/0.9175, allocations: 2.285 MB / 0.6905 GB, free: 52.64 MB / 478.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003496/0.9211, allocations: 0.8919 MB / 0.6913 GB, free: 51.75 MB / 478.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02224/0.9433, allocations: 18.41 MB / 0.7093 GB, free: 32.43 MB / 478.1 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00343/0.9468, allocations: 147.9 kB / 0.7095 GB, free: 32.28 MB / 478.1 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0005603/0.9474, allocations: 234.5 kB / 0.7097 GB, free: 32.05 MB / 478.1 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 133
 * 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 (469):
 * Single equations (assignments): 460
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 9
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 4 systems
   {(3,16,77.8%), (1,3,100.0%), (2,6,100.0%), (1,3,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 5 systems
   {(3,26), (1,3), (1,6), (1,2), (1,3)}
Notification: Performance of prepare postOptimizeDAE: time 0.001349/0.9487, allocations: 0.601 MB / 0.7103 GB, free: 31.46 MB / 478.1 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0007404/0.9495, allocations: 282.2 kB / 0.7105 GB, free: 31.19 MB / 478.1 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01584/0.9653, allocations: 6.581 MB / 0.717 GB, free: 24.7 MB / 478.1 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 3.407e-05/0.9654, allocations: 40 kB / 0.717 GB, free: 24.66 MB / 478.1 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.813e-05/0.9654, allocations: 11.98 kB / 0.717 GB, free: 24.65 MB / 478.1 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 8.597e-05/0.9655, allocations: 19.92 kB / 0.717 GB, free: 24.63 MB / 478.1 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.02138/0.9869, allocations: 10.65 MB / 0.7274 GB, free: 13.96 MB / 478.1 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.324e-05/0.987, allocations: 7.938 kB / 0.7274 GB, free: 13.96 MB / 478.1 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002908/0.9899, allocations: 0.6568 MB / 0.7281 GB, free: 13.3 MB / 478.1 MB
Notification: Performance of postOpt tearingSystem (simulation): time 0.009328/0.9992, allocations: 2.014 MB / 0.73 GB, free: 11.31 MB / 478.1 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0006778/0.9999, allocations: 139.4 kB / 0.7302 GB, free: 11.18 MB / 478.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.02105/1.021, allocations: 17.03 MB / 0.7468 GB, free: 9.223 MB / 494.1 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 8.776e-06/1.021, allocations: 10.59 kB / 0.7468 GB, free: 9.215 MB / 494.1 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.02216/1.043, allocations: 8.498 MB / 0.7551 GB, free: 0.6172 MB / 494.1 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.002342/1.046, allocations: 0.7017 MB / 0.7558 GB, free: 15.9 MB / 0.4981 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0005494/1.046, allocations: 83.98 kB / 0.7559 GB, free: 15.82 MB / 0.4981 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002068/1.048, allocations: 99.92 kB / 0.756 GB, free: 15.72 MB / 0.4981 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0008153/1.049, allocations: 337.5 kB / 0.7563 GB, free: 15.39 MB / 0.4981 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0003317/1.049, allocations: 162 kB / 0.7565 GB, free: 15.24 MB / 0.4981 GB
Notification: Performance of sorting global known variables: time 0.001638/1.051, allocations: 1.113 MB / 0.7575 GB, free: 14.1 MB / 0.4981 GB
Notification: Performance of sort global known variables: time 2.7e-07/1.051, allocations: 0 / 0.7575 GB, free: 14.1 MB / 0.4981 GB
Notification: Performance of remove unused functions: time 0.007706/1.059, allocations: 2.209 MB / 0.7597 GB, free: 11.92 MB / 0.4981 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 18
 * Number of states: 14 (blood_erythrocytes.temperature,blood_erythrocytes.mass,blood_plasma.temperature,blood_plasma.mass,HCO3.logn,CO2.logn,H2O.logn,HCO3_E.logn,CO2_E.logn,H2O_E.logn,Cl_E.logn,Cl.logn,others_E.logn,others_P.logn)
 * 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 (354):
 * Single equations (assignments): 345
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 9
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 4 systems
   {(3,16,77.8%), (1,3,100.0%), (2,6,100.0%), (1,3,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 5 systems
   {(2,8), (4,30), (1,3), (1,2), (1,3)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.02696/1.086, allocations: 11.17 MB / 0.7706 GB, free: 1.004 MB / 0.4981 GB
Notification: Performance of simCode: created initialization part: time 0.01197/1.098, allocations: 5.856 MB / 0.7763 GB, free: 11.05 MB / 0.5137 GB
Notification: Performance of simCode: created event and clocks part: time 8.516e-06/1.098, allocations: 3.938 kB / 0.7763 GB, free: 11.05 MB / 0.5137 GB
Notification: Performance of simCode: created simulation system equations: time 0.007158/1.105, allocations: 3.555 MB / 0.7798 GB, free: 7.41 MB / 0.5137 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003139/1.108, allocations: 0.5541 MB / 0.7803 GB, free: 6.891 MB / 0.5137 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.07781/1.186, allocations: 31.22 MB / 0.8108 GB, free: 6.445 MB / 0.545 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001817/1.188, allocations: 1.888 MB / 0.8127 GB, free: 4.523 MB / 0.545 GB
Notification: Performance of simCode: alias equations: time 0.002928/1.191, allocations: 0.6679 MB / 0.8133 GB, free: 3.883 MB / 0.545 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.002467/1.193, allocations: 1.549 MB / 0.8148 GB, free: 2.332 MB / 0.545 GB
Notification: Performance of SimCode: time 8.21e-07/1.193, allocations: 0 / 0.8148 GB, free: 2.332 MB / 0.545 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.4223/1.616, allocations: 110.9 MB / 0.9232 GB, free: 101.9 MB / 0.545 GB
Notification: Performance of buildModelFMU: Generate platform static: time 49.48/51.1, allocations: 0 / 0.9232 GB, free: 101.9 MB / 0.545 GB
(rm -f Chemical_Chemical.Examples.AcidBase.CarbonDioxideInBlood.pipe ; mkfifo Chemical_Chemical.Examples.AcidBase.CarbonDioxideInBlood.pipe ; head -c 1048576 < Chemical_Chemical.Examples.AcidBase.CarbonDioxideInBlood.pipe >> ../files/Chemical_Chemical.Examples.AcidBase.CarbonDioxideInBlood.sim & python3 -m fmpy simulate  --output-file Chemical_Chemical.Examples.AcidBase.CarbonDioxideInBlood_res.csv --start-time 0 --stop-time 3 --timeout 50 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 0.0012 Chemical_Chemical_Examples_AcidBase_CarbonDioxideInBlood.fmu > Chemical_Chemical.Examples.AcidBase.CarbonDioxideInBlood.pipe 2>&1)