Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Physiolibrary_Physiolibrary.Organs.Lungs.Examples.LungsTest.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.06159/0.06159, allocations: 11.15 MB / 31.25 MB, free: 4.938 MB / 24.77 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.0009861/0.0009861, allocations: 100.7 kB / 38.88 MB, free: 7.391 MB / 33.03 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.001378/0.001378, allocations: 160.5 kB / 46.58 MB, free: 10.75 MB / 44.04 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.037/1.037, allocations: 177.1 MB / 231.3 MB, free: 6.441 MB / 202.7 MB
"
[Timeout remaining time 179]
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.2574/0.2574, allocations: 17.63 MB / 309.8 MB, free: 1.805 MB / 266.7 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.Organs.Lungs.Examples.LungsTest,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Physiolibrary_Physiolibrary.Organs.Lungs.Examples.LungsTest")
translateModel(Physiolibrary.Organs.Lungs.Examples.LungsTest,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Physiolibrary_Physiolibrary.Organs.Lungs.Examples.LungsTest") [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 4.018e-06/4.018e-06, allocations: 0 / 391.1 MB, free: 5.121 MB / 346.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 3.246e-05/3.648e-05, allocations: 6.25 kB / 391.2 MB, free: 5.113 MB / 346.7 MB
Notification: Performance of NFInst.instantiate(Physiolibrary.Organs.Lungs.Examples.LungsTest): time 0.3217/0.3218, allocations: 137.3 MB / 0.516 GB, free: 33.13 MB / 410.7 MB
Notification: Performance of NFInst.instExpressions: time 0.06542/0.3872, allocations: 68.99 MB / 0.5834 GB, free: 276 kB / 426.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.005179/0.3924, allocations: 95.44 kB / 0.5835 GB, free: 180 kB / 426.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.004938/0.3973, allocations: 1.441 MB / 0.5849 GB, free: 14.73 MB / 442.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.02151/0.4188, allocations: 8.375 MB / 0.5931 GB, free: 6.309 MB / 442.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.01664/0.4354, allocations: 7.925 MB / 0.6008 GB, free: 14.36 MB / 458.7 MB
Notification: Performance of NFFlatten.flatten: time 0.01203/0.4475, allocations: 10.65 MB / 0.6112 GB, free: 3.68 MB / 458.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.01184/0.4593, allocations: 8.429 MB / 0.6195 GB, free: 11.15 MB / 474.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.5833/1.043, allocations: 130.7 MB / 0.7471 GB, free: 15.63 MB / 0.5261 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.1573/1.2, allocations: 55.77 MB / 0.8016 GB, free: 3.395 MB / 0.5573 GB
Notification: Performance of NFPackage.collectConstants: time 0.005587/1.206, allocations: 1.827 MB / 0.8033 GB, free: 1.57 MB / 0.5573 GB
Notification: Performance of NFFlatten.collectFunctions: time 1.498/2.703, allocations: 393.8 MB / 1.188 GB, free: 66.02 MB / 0.5886 GB
Notification: Performance of NFScalarize.scalarize: time 0.01041/2.714, allocations: 10.42 MB / 1.198 GB, free: 62.18 MB / 0.5886 GB
Notification: Performance of NFVerifyModel.verify: time 0.01207/2.726, allocations: 8.099 MB / 1.206 GB, free: 58.39 MB / 0.5886 GB
Notification: Performance of NFConvertDAE.convert: time 0.03662/2.762, allocations: 29.55 MB / 1.235 GB, free: 34.43 MB / 0.5886 GB
Notification: Performance of FrontEnd - DAE generated: time 7.003e-06/2.762, allocations: 0 / 1.235 GB, free: 34.43 MB / 0.5886 GB
Notification: Performance of FrontEnd: time 1.984e-06/2.762, allocations: 0 / 1.235 GB, free: 34.43 MB / 0.5886 GB
Notification: Performance of Transformations before backend: time 0.0006726/2.763, allocations: 0 / 1.235 GB, free: 34.43 MB / 0.5886 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2952
 * Number of variables: 2952
Notification: Performance of Generate backend data structure: time 11.61/14.37, allocations: 4.62 GB / 5.855 GB, free: 173.9 MB / 0.5888 GB
Notification: Performance of prepare preOptimizeDAE: time 5.526e-05/14.37, allocations: 16.02 kB / 5.855 GB, free: 173.9 MB / 0.5888 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.006776/14.38, allocations: 3.089 MB / 5.858 GB, free: 170.9 MB / 0.5888 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01732/14.4, allocations: 16.57 MB / 5.874 GB, free: 155.4 MB / 0.5888 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0005874/14.4, allocations: 1.112 MB / 5.876 GB, free: 154.3 MB / 0.5888 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.00215/14.4, allocations: 1.082 MB / 5.877 GB, free: 153.2 MB / 0.5888 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02923/14.43, allocations: 16.83 MB / 5.893 GB, free: 135.6 MB / 0.5888 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.000279/14.43, allocations: 63.59 kB / 5.893 GB, free: 135.5 MB / 0.5888 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.00208/14.43, allocations: 424 kB / 5.894 GB, free: 135.1 MB / 0.5888 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0004866/14.43, allocations: 0.6169 MB / 5.894 GB, free: 134.5 MB / 0.5888 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0296/14.46, allocations: 14.49 MB / 5.908 GB, free: 120 MB / 0.5888 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.1292/14.59, allocations: 98.9 MB / 6.005 GB, free: 17.7 MB / 0.5888 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01458/14.61, allocations: 8.317 MB / 6.013 GB, free: 9.305 MB / 0.5888 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.008849/14.61, allocations: 4.962 MB / 6.018 GB, free: 4.34 MB / 0.5888 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.2775/14.89, allocations: 34.87 MB / 6.052 GB, free: 225 MB / 0.5888 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.000118/14.89, allocations: 133.9 kB / 6.052 GB, free: 224.9 MB / 0.5888 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.01205/14.9, allocations: 2.606 MB / 6.055 GB, free: 224.5 MB / 0.5888 GB
Notification: Performance of pre-optimization done (n=1141): time 3.703e-05/14.9, allocations: 3.719 kB / 6.055 GB, free: 224.5 MB / 0.5888 GB
Notification: Performance of matching and sorting (n=1141): time 0.07951/14.98, allocations: 22.02 MB / 6.076 GB, free: 220.2 MB / 0.5888 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001205/14.98, allocations: 147.7 kB / 6.076 GB, free: 220.1 MB / 0.5888 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.03356/15.02, allocations: 19.06 MB / 6.095 GB, free: 214.6 MB / 0.5888 GB
Notification: Performance of collectPreVariables (initialization): time 0.004763/15.02, allocations: 197.4 kB / 6.095 GB, free: 214.4 MB / 0.5888 GB
Notification: Performance of collectInitialEqns (initialization): time 0.005897/15.03, allocations: 6.297 MB / 6.101 GB, free: 210.5 MB / 0.5888 GB
Notification: Performance of collectInitialBindings (initialization): time 0.007253/15.03, allocations: 4.644 MB / 6.106 GB, free: 207.5 MB / 0.5888 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.02062/15.06, allocations: 7.213 MB / 6.113 GB, free: 204.6 MB / 0.5888 GB
Notification: Performance of setup shared object (initialization): time 5.935e-05/15.06, allocations: 484.6 kB / 6.113 GB, free: 204.1 MB / 0.5888 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.02096/15.08, allocations: 10.85 MB / 6.124 GB, free: 195.4 MB / 0.5888 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.02602/15.1, allocations: 16.97 MB / 6.14 GB, free: 178.4 MB / 0.5888 GB
Error: Initialization problem is structural singular. Please, check the initial conditions.
Error: No system for the symbolic initialization was generated
"
[Timeout remaining time 628]
[Calling sys.exit(0), Time elapsed: 33.69522150908597]