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.09615/0.09615, allocations: 11.16 MB / 30.51 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.001819/0.001819, allocations: 95.06 kB / 38.14 MB, free: 7.207 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.00197/0.00197, allocations: 156.5 kB / 45.86 MB, free: 10.6 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.532/1.532, allocations: 177.1 MB / 230.6 MB, free: 4.789 MB / 202.7 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.1607/0.1607, allocations: 17.62 MB / 309.1 MB, free: 8.805 MB / 282.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 2.415e-06/2.415e-06, allocations: 0 / 390.4 MB, free: 46.58 MB / 330.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.871e-05/3.113e-05, allocations: 5.375 kB / 390.4 MB, free: 46.57 MB / 330.7 MB
Notification: Performance of NFInst.instantiate(Physiolibrary.Organs.Lungs.Examples.LungsTest): time 0.1662/0.1662, allocations: 137.1 MB / 0.5152 GB, free: 5.113 MB / 426.7 MB
Notification: Performance of NFInst.instExpressions: time 0.2787/0.445, allocations: 68.94 MB / 0.5825 GB, free: 12.12 MB / 426.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.005098/0.4501, allocations: 92.22 kB / 0.5826 GB, free: 12.12 MB / 426.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.004596/0.4547, allocations: 1.447 MB / 0.584 GB, free: 12.02 MB / 426.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.02317/0.4778, allocations: 8.365 MB / 0.5922 GB, free: 10.39 MB / 426.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.01837/0.4962, allocations: 7.916 MB / 0.5999 GB, free: 6.645 MB / 426.7 MB
Notification: Performance of NFFlatten.flatten: time 0.01323/0.5094, allocations: 10.64 MB / 0.6103 GB, free: 0.5 MB / 426.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.01588/0.5253, allocations: 8.6 MB / 0.6187 GB, free: 11.11 MB / 442.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 1.192/1.717, allocations: 130.7 MB / 0.7463 GB, free: 77.96 MB / 0.5105 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.3301/2.047, allocations: 55.77 MB / 0.8008 GB, free: 49.49 MB / 0.5105 GB
Notification: Performance of NFPackage.collectConstants: time 0.005793/2.053, allocations: 1.824 MB / 0.8026 GB, free: 48.23 MB / 0.5105 GB
Notification: Performance of NFFlatten.collectFunctions: time 3.1/5.153, allocations: 393.8 MB / 1.187 GB, free: 124.9 MB / 0.573 GB
Notification: Performance of NFScalarize.scalarize: time 0.01143/5.165, allocations: 10.42 MB / 1.197 GB, free: 124.9 MB / 0.573 GB
Notification: Performance of NFVerifyModel.verify: time 0.02084/5.186, allocations: 8.095 MB / 1.205 GB, free: 124.9 MB / 0.573 GB
Notification: Performance of NFConvertDAE.convert: time 0.05935/5.245, allocations: 42.7 MB / 1.247 GB, free: 96.27 MB / 0.573 GB
Notification: Performance of FrontEnd - DAE generated: time 5.32e-06/5.245, allocations: 4 kB / 1.247 GB, free: 96.26 MB / 0.573 GB
Notification: Performance of FrontEnd: time 1.382e-06/5.245, allocations: 2.719 kB / 1.247 GB, free: 96.26 MB / 0.573 GB
Notification: Performance of Transformations before backend: time 0.0008518/5.246, allocations: 0 / 1.247 GB, free: 96.26 MB / 0.573 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 18.97/24.21, allocations: 4.622 GB / 5.869 GB, free: 26.07 MB / 0.5731 GB
Notification: Performance of prepare preOptimizeDAE: time 4.312e-05/24.21, allocations: 8.031 kB / 5.869 GB, free: 26.06 MB / 0.5731 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01744/24.23, allocations: 3.101 MB / 5.872 GB, free: 23.08 MB / 0.5731 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.03603/24.26, allocations: 16.67 MB / 5.888 GB, free: 7.516 MB / 0.5731 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001332/24.27, allocations: 1.104 MB / 5.889 GB, free: 6.41 MB / 0.5731 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.007507/24.27, allocations: 1.082 MB / 5.89 GB, free: 5.328 MB / 0.5731 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.2376/24.51, allocations: 23.69 MB / 5.913 GB, free: 237.6 MB / 0.5731 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0006688/24.51, allocations: 59.16 kB / 5.913 GB, free: 237.6 MB / 0.5731 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.00579/24.52, allocations: 431.2 kB / 5.914 GB, free: 237.3 MB / 0.5731 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0007116/24.52, allocations: 0.6162 MB / 5.914 GB, free: 237.2 MB / 0.5731 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.06966/24.59, allocations: 30.38 MB / 5.944 GB, free: 221.2 MB / 0.5731 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.5155/25.1, allocations: 288.8 MB / 6.226 GB, free: 178.1 MB / 0.5731 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0408/25.14, allocations: 13.48 MB / 6.239 GB, free: 172.1 MB / 0.5731 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.03435/25.18, allocations: 9.813 MB / 6.249 GB, free: 167.1 MB / 0.5731 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.1306/25.31, allocations: 38.98 MB / 6.287 GB, free: 126.9 MB / 0.5731 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0001382/25.31, allocations: 132.6 kB / 6.287 GB, free: 126.7 MB / 0.5731 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.01697/25.33, allocations: 2.607 MB / 6.29 GB, free: 124.7 MB / 0.5731 GB
Notification: Performance of pre-optimization done (n=1141): time 6.267e-05/25.33, allocations: 0 / 6.29 GB, free: 124.7 MB / 0.5731 GB
Notification: Performance of matching and sorting (n=1141): time 0.1131/25.44, allocations: 36.59 MB / 6.325 GB, free: 88.14 MB / 0.5731 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 8.03e-05/25.44, allocations: 150.6 kB / 6.326 GB, free: 87.99 MB / 0.5731 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.02989/25.47, allocations: 22.72 MB / 6.348 GB, free: 65.69 MB / 0.5731 GB
Notification: Performance of collectPreVariables (initialization): time 0.003623/25.47, allocations: 193.7 kB / 6.348 GB, free: 65.5 MB / 0.5731 GB
Notification: Performance of collectInitialEqns (initialization): time 0.005361/25.48, allocations: 6.931 MB / 6.355 GB, free: 59.27 MB / 0.5731 GB
Notification: Performance of collectInitialBindings (initialization): time 0.007131/25.49, allocations: 5.027 MB / 6.36 GB, free: 54.66 MB / 0.5731 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.1993/25.69, allocations: 8.288 MB / 6.368 GB, free: 215.5 MB / 0.5731 GB
Notification: Performance of setup shared object (initialization): time 6.363e-05/25.69, allocations: 482.5 kB / 6.368 GB, free: 215 MB / 0.5731 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.02924/25.71, allocations: 14.87 MB / 6.383 GB, free: 214.9 MB / 0.5731 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.03463/25.75, allocations: 21.78 MB / 6.404 GB, free: 207 MB / 0.5731 GB
Error: Initialization problem is structural singular. Please, check the initial conditions.
Error: No system for the symbolic initialization was generated
"
[Timeout remaining time 577]
[Calling sys.exit(0), Time elapsed: 85.66615497309249]