Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Pharmacolibrary_Pharmacolibrary.Examples.Pharmacogenomics.PK_2C_generic.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.001785/0.001785, allocations: 88.84 kB / 20.18 MB, free: 4.363 MB / 18.57 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.001937/0.001937, allocations: 169.4 kB / 23.49 MB, free: 1.059 MB / 18.57 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.476/1.476, allocations: 177.1 MB / 203.8 MB, free: 5.625 MB / 186.7 MB " [Timeout remaining time 178] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Pharmacolibrary 25.9.0/package.mo", uses=false) [Timeout 180] "[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Pharmacolibrary 25.9.0/Examples/package.order:0:0-0:0:readonly] Warning: The package.order file does not list all .mo files and directories (containing package.mo) present in its directory. Missing names are: Paracetamol_Experiment Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Pharmacolibrary 25.9.0/package.mo): time 3.239/3.239, allocations: 274.5 MB / 0.5222 GB, free: 14.18 MB / 458.7 MB " [Timeout remaining time 176] Using package Pharmacolibrary with version 25.09 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Pharmacolibrary 25.9.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) Running command: translateModel(Pharmacolibrary.Examples.Pharmacogenomics.PK_2C_generic,tolerance=1e-12,outputFormat="empty",numberOfIntervals=864,variableFilter="",fileNamePrefix="Pharmacolibrary_Pharmacolibrary.Examples.Pharmacogenomics.PK_2C_generic") translateModel(Pharmacolibrary.Examples.Pharmacogenomics.PK_2C_generic,tolerance=1e-12,outputFormat="empty",numberOfIntervals=864,variableFilter="",fileNamePrefix="Pharmacolibrary_Pharmacolibrary.Examples.Pharmacogenomics.PK_2C_generic") [Timeout 660] "Notification: Performance of FrontEnd - Absyn->SCode: time 1.725e-05/1.725e-05, allocations: 2.312 kB / 0.6479 GB, free: 39.05 MB / 0.5262 GB Notification: Performance of NFInst.instantiate(Pharmacolibrary.Examples.Pharmacogenomics.PK_2C_generic): time 0.01037/0.01039, allocations: 13.35 MB / 0.6609 GB, free: 30.3 MB / 0.5262 GB Notification: Performance of NFInst.instExpressions: time 0.004528/0.01492, allocations: 2.682 MB / 0.6635 GB, free: 28.39 MB / 0.5262 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.00101/0.01593, allocations: 18.19 kB / 0.6636 GB, free: 28.39 MB / 0.5262 GB Notification: Performance of NFTyping.typeComponents: time 0.0005334/0.01646, allocations: 310.8 kB / 0.6639 GB, free: 28.22 MB / 0.5262 GB Notification: Performance of NFTyping.typeBindings: time 0.001527/0.01799, allocations: 0.9039 MB / 0.6647 GB, free: 27.55 MB / 0.5262 GB Notification: Performance of NFTyping.typeClassSections: time 0.001007/0.01899, allocations: 0.6816 MB / 0.6654 GB, free: 27.09 MB / 0.5262 GB Notification: Performance of NFFlatten.flatten: time 0.00271/0.0217, allocations: 3.664 MB / 0.669 GB, free: 25.11 MB / 0.5262 GB Notification: Performance of NFFlatten.resolveConnections: time 0.0006759/0.02238, allocations: 419 kB / 0.6694 GB, free: 24.85 MB / 0.5262 GB Notification: Performance of NFEvalConstants.evaluate: time 0.001722/0.0241, allocations: 1.657 MB / 0.671 GB, free: 24.11 MB / 0.5262 GB Notification: Performance of NFSimplifyModel.simplify: time 0.001101/0.0252, allocations: 0.9326 MB / 0.6719 GB, free: 23.78 MB / 0.5262 GB Notification: Performance of NFPackage.collectConstants: time 0.0003061/0.02551, allocations: 283.8 kB / 0.6722 GB, free: 23.78 MB / 0.5262 GB Notification: Performance of NFFlatten.collectFunctions: time 0.000422/0.02593, allocations: 285.2 kB / 0.6725 GB, free: 23.78 MB / 0.5262 GB Notification: Performance of combineBinaries: time 0.002869/0.0288, allocations: 3.9 MB / 0.6763 GB, free: 21.43 MB / 0.5262 GB Notification: Performance of replaceArrayConstructors: time 0.001598/0.0304, allocations: 2.153 MB / 0.6784 GB, free: 20.12 MB / 0.5262 GB Notification: Performance of NFVerifyModel.verify: time 0.0007138/0.03111, allocations: 257.6 kB / 0.6786 GB, free: 20.12 MB / 0.5262 GB Notification: Performance of FrontEnd: time 0.0003297/0.03144, allocations: 55.62 kB / 0.6787 GB, free: 20.12 MB / 0.5262 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 402 (384) * Number of variables: 402 (402) Notification: Performance of [SIM] Bindings: time 0.006944/0.03838, allocations: 9.496 MB / 0.6879 GB, free: 13.82 MB / 0.5262 GB Notification: Performance of [SIM] FunctionAlias: time 0.00106/0.03944, allocations: 1.245 MB / 0.6892 GB, free: 13.07 MB / 0.5262 GB Notification: Performance of [SIM] Early Inline: time 0.004552/0.044, allocations: 5.799 MB / 0.6948 GB, free: 9.098 MB / 0.5262 GB Notification: Performance of [SIM] Simplify 1: time 0.00114/0.04514, allocations: 0.7391 MB / 0.6955 GB, free: 8.617 MB / 0.5262 GB Notification: Performance of [SIM] Alias: time 0.007199/0.05233, allocations: 7.279 MB / 0.7026 GB, free: 0.8164 MB / 0.5262 GB Notification: Performance of [SIM] Simplify 2: time 0.000625/0.05296, allocations: 0.5988 MB / 0.7032 GB, free: 184 kB / 0.5262 GB Notification: Performance of [SIM] Remove Stream: time 0.000683/0.05364, allocations: 0.5949 MB / 0.7038 GB, free: 15.55 MB / 0.5418 GB Notification: Performance of [SIM] Detect States: time 0.003117/0.05676, allocations: 2.359 MB / 0.7061 GB, free: 13.11 MB / 0.5418 GB Notification: Performance of [SIM] Events: time 0.001386/0.05815, allocations: 1.038 MB / 0.7071 GB, free: 12.09 MB / 0.5418 GB Notification: Performance of [SIM] Partitioning: time 0.00356/0.06171, allocations: 2.497 MB / 0.7096 GB, free: 9.398 MB / 0.5418 GB Notification: Performance of [SIM] Causalize: time 0.01244/0.07414, allocations: 7.295 MB / 0.7167 GB, free: 1.625 MB / 0.5418 GB Notification: Performance of [SIM] After Index Reduction Inline: time 0.005355/0.0795, allocations: 4.641 MB / 0.7212 GB, free: 12.98 MB / 0.5574 GB Notification: Performance of [INI] Simplify: time 0.005719/0.08522, allocations: 3.166 MB / 0.7243 GB, free: 9.668 MB / 0.5574 GB Notification: Performance of [INI] Inline: time 0.007885/0.0931, allocations: 6.893 MB / 0.731 GB, free: 2.758 MB / 0.5574 GB Notification: Performance of [INI] Partitioning: time 0.0005011/0.0936, allocations: 159.7 kB / 0.7312 GB, free: 2.562 MB / 0.5574 GB Notification: Performance of [INI] Cleanup: time 0.001902/0.09551, allocations: 1.585 MB / 0.7327 GB, free: 0.9766 MB / 0.5574 GB Error: Internal error NBResolveSingularities.balanceInitialization failed because following non-fixable variables could not be solved: [DISC] (1) discrete Real ref_low.peripheral.Cmin (min = -1e-9) [DISC] (1) discrete Real ref_low.peripheral.Cmax (min = -1e-9) [DISC] (1) discrete Real ref_low.periodicDose.absorptionLumen.Cmin (min = -1e-9) [DISC] (1) discrete Real ref_low.periodicDose.absorptionLumen.Cmax (min = -1e-9) [DISC] (1) discrete Real ref_low.central.Cmin (min = -1e-9) [DISC] (1) discrete Real ref_low.central.Cmax (min = -1e-9) [DISC] (1) discrete Real ref_high.peripheral.Cmin (min = -1e-9) [DISC] (1) discrete Real ref_high.peripheral.Cmax (min = -1e-9) [DISC] (1) discrete Real ref_high.periodicDose.absorptionLumen.Cmin (min = -1e-9) [DISC] (1) discrete Real ref_high.periodicDose.absorptionLumen.Cmax (min = -1e-9) [DISC] (1) discrete Real ref_high.central.Cmin (min = -1e-9) [DISC] (1) discrete Real ref_high.central.Cmax (min = -1e-9) [DISC] (1) discrete Real ref.peripheral.Cmin (min = -1e-9) [DISC] (1) discrete Real ref.peripheral.Cmax (min = -1e-9) [DISC] (1) discrete Real ref.periodicDose.absorptionLumen.Cmin (min = -1e-9) [DISC] (1) discrete Real ref.periodicDose.absorptionLumen.Cmax (min = -1e-9) [DISC] (1) discrete Real ref.central.Cmin (min = -1e-9) [DISC] (1) discrete Real ref.central.Cmax (min = -1e-9) [DISC] (1) discrete Real patient_low.peripheral.Cmin (min = -1e-9) [DISC] (1) discrete Real patient_low.peripheral.Cmax (min = -1e-9) [DISC] (1) discrete Real patient_low.periodicDose.absorptionLumen.Cmin (min = -1e-9) [DISC] (1) discrete Real patient_low.periodicDose.absorptionLumen.Cmax (min = -1e-9) [DISC] (1) discrete Real patient_low.central.Cmin (min = -1e-9) [DISC] (1) discrete Real patient_low.central.Cmax (min = -1e-9) [DISC] (1) discrete Real patient_high.peripheral.Cmin (min = -1e-9) [DISC] (1) discrete Real patient_high.peripheral.Cmax (min = -1e-9) [DISC] (1) discrete Real patient_high.periodicDose.absorptionLumen.Cmin (min = -1e-9) [DISC] (1) discrete Real patient_high.periodicDose.absorptionLumen.Cmax (min = -1e-9) [DISC] (1) discrete Real patient_high.central.Cmin (min = -1e-9) [DISC] (1) discrete Real patient_high.central.Cmax (min = -1e-9) [DISC] (1) discrete Real patient.peripheral.Cmin (min = -1e-9) [DISC] (1) discrete Real patient.peripheral.Cmax (min = -1e-9) [DISC] (1) discrete Real patient.periodicDose.absorptionLumen.Cmin (min = -1e-9) [DISC] (1) discrete Real patient.periodicDose.absorptionLumen.Cmax (min = -1e-9) [DISC] (1) discrete Real patient.central.Cmin (min = -1e-9) [DISC] (1) discrete Real patient.central.Cmax (min = -1e-9) Following equations were created by fixing variables: [SCAL] (1) $PRE.patient.central.rising = $START.patient.central.rising; ($RES_SRT_839) [SCAL] (1) $PRE.patient.periodicDose.absorptionLumen.rising = $START.patient.periodicDose.absorptionLumen.rising; ($RES_SRT_838) [SCAL] (1) $PRE.patient.peripheral.rising = $START.patient.peripheral.rising; ($RES_SRT_837) [SCAL] (1) $PRE.patient_high.central.rising = $START.patient_high.central.rising; ($RES_SRT_836) [SCAL] (1) $PRE.patient_high.periodicDose.absorptionLumen.rising = $START.patient_high.periodicDose.absorptionLumen.rising; ($RES_SRT_835) [SCAL] (1) $PRE.patient_high.peripheral.rising = $START.patient_high.peripheral.rising; ($RES_SRT_834) [SCAL] (1) $PRE.patient_low.central.rising = $START.patient_low.central.rising; ($RES_SRT_833) [SCAL] (1) $PRE.patient_low.periodicDose.absorptionLumen.rising = $START.patient_low.periodicDose.absorptionLumen.rising; ($RES_SRT_832) [SCAL] (1) $PRE.patient_low.peripheral.rising = $START.patient_low.peripheral.rising; ($RES_SRT_831) [SCAL] (1) $PRE.ref.central.rising = $START.ref.central.rising; ($RES_SRT_830) [SCAL] (1) $PRE.ref.periodicDose.absorptionLumen.rising = $START.ref.periodicDose.absorptionLumen.rising; ($RES_SRT_829) [SCAL] (1) $PRE.ref.peripheral.rising = $START.ref.peripheral.rising; ($RES_SRT_828) [SCAL] (1) $PRE.ref_high.central.rising = $START.ref_high.central.rising; ($RES_SRT_827) [SCAL] (1) $PRE.ref_high.periodicDose.absorptionLumen.rising = $START.ref_high.periodicDose.absorptionLumen.rising; ($RES_SRT_826) [SCAL] (1) $PRE.ref_high.peripheral.rising = $START.ref_high.peripheral.rising; ($RES_SRT_825) [SCAL] (1) $PRE.ref_low.central.rising = $START.ref_low.central.rising; ($RES_SRT_824) [SCAL] (1) $PRE.ref_low.periodicDose.absorptionLumen.rising = $START.ref_low.periodicDose.absorptionLumen.rising; ($RES_SRT_823) [SCAL] (1) $PRE.ref_low.peripheral.rising = $START.ref_low.peripheral.rising; ($RES_SRT_822) [SCAL] (1) ref_low.peripheral.AUC = $START.ref_low.peripheral.AUC; ($RES_SRT_821) [SCAL] (1) ref_low.periodicDose.variableDose.TotalCumulativeMass = $START.ref_low.periodicDose.variableDose.TotalCumulativeMass; ($RES_SRT_820) [SCAL] (1) ref_low.periodicDose.absorptionLumen.AUC = $START.ref_low.periodicDose.absorptionLumen.AUC; ($RES_SRT_819) [SCAL] (1) ref_low.periodicDose.TotalCumulativeMass = $START.ref_low.periodicDose.TotalCumulativeMass; ($RES_SRT_818) [SCAL] (1) ref_low.central.AUC = $START.ref_low.central.AUC; ($RES_SRT_817) [SCAL] (1) ref_high.peripheral.AUC = $START.ref_high.peripheral.AUC; ($RES_SRT_816) [SCAL] (1) ref_high.periodicDose.variableDose.TotalCumulativeMass = $START.ref_high.periodicDose.variableDose.TotalCumulativeMass; ($RES_SRT_815) [SCAL] (1) ref_high.periodicDose.absorptionLumen.AUC = $START.ref_high.periodicDose.absorptionLumen.AUC; ($RES_SRT_814) [SCAL] (1) ref_high.periodicDose.TotalCumulativeMass = $START.ref_high.periodicDose.TotalCumulativeMass; ($RES_SRT_813) [SCAL] (1) ref_high.central.AUC = $START.ref_high.central.AUC; ($RES_SRT_812) [SCAL] (1) ref.peripheral.AUC = $START.ref.peripheral.AUC; ($RES_SRT_811) [SCAL] (1) ref.periodicDose.variableDose.TotalCumulativeMass = $START.ref.periodicDose.variableDose.TotalCumulativeMass; ($RES_SRT_810) [SCAL] (1) ref.periodicDose.absorptionLumen.AUC = $START.ref.periodicDose.absorptionLumen.AUC; ($RES_SRT_809) [SCAL] (1) ref.periodicDose.TotalCumulativeMass = $START.ref.periodicDose.TotalCumulativeMass; ($RES_SRT_808) [SCAL] (1) ref.central.AUC = $START.ref.central.AUC; ($RES_SRT_807) [SCAL] (1) patient_low.peripheral.AUC = $START.patient_low.peripheral.AUC; ($RES_SRT_806) [SCAL] (1) patient_low.periodicDose.variableDose.TotalCumulativeMass = $START.patient_low.periodicDose.variableDose.TotalCumulativeMass; ($RES_SRT_805) [SCAL] (1) patient_low.periodicDose.absorptionLumen.AUC = $START.patient_low.periodicDose.absorptionLumen.AUC; ($RES_SRT_804) [SCAL] (1) patient_low.periodicDose.TotalCumulativeMass = $START.patient_low.periodicDose.TotalCumulativeMass; ($RES_SRT_803) [SCAL] (1) patient_low.central.AUC = $START.patient_low.central.AUC; ($RES_SRT_802) [SCAL] (1) patient_high.peripheral.AUC = $START.patient_high.peripheral.AUC; ($RES_SRT_801) [SCAL] (1) patient_high.periodicDose.variableDose.TotalCumulativeMass = $START.patient_high.periodicDose.variableDose.TotalCumulativeMass; ($RES_SRT_800) [SCAL] (1) patient_high.periodicDose.absorptionLumen.AUC = $START.patient_high.periodicDose.absorptionLumen.AUC; ($RES_SRT_799) [SCAL] (1) patient_high.periodicDose.TotalCumulativeMass = $START.patient_high.periodicDose.TotalCumulativeMass; ($RES_SRT_798) [SCAL] (1) patient_high.central.AUC = $START.patient_high.central.AUC; ($RES_SRT_797) [SCAL] (1) patient.peripheral.AUC = $START.patient.peripheral.AUC; ($RES_SRT_796) [SCAL] (1) patient.periodicDose.variableDose.TotalCumulativeMass = $START.patient.periodicDose.variableDose.TotalCumulativeMass; ($RES_SRT_795) [SCAL] (1) patient.periodicDose.absorptionLumen.AUC = $START.patient.periodicDose.absorptionLumen.AUC; ($RES_SRT_794) [SCAL] (1) patient.periodicDose.TotalCumulativeMass = $START.patient.periodicDose.TotalCumulativeMass; ($RES_SRT_793) [SCAL] (1) patient.central.AUC = $START.patient.central.AUC; ($RES_SRT_792) Use -d=bltdump for more verbose debug output. Error: Internal error NBInitialization.main failed to apply modules! " [Timeout remaining time 660] [Calling sys.exit(0), Time elapsed: 5.7554221181198955]