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.05056/0.05056, allocations: 11.14 MB / 31.73 MB, free: 4.816 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.001256/0.001256, allocations: 89.05 kB / 39.44 MB, free: 6.918 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.001089/0.001089, allocations: 160.6 kB / 47.24 MB, free: 10.2 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 0.9112/0.9112, allocations: 177.1 MB / 232.1 MB, free: 1.703 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.08577/0.08577, allocations: 17.63 MB / 310.7 MB, free: 2.32 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 1.313e-06/1.313e-06, allocations: 0 / 392.5 MB, free: 384 kB / 346.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.255e-05/1.387e-05, allocations: 5.406 kB / 392.5 MB, free: 380 kB / 346.7 MB
Notification: Performance of NFInst.instantiate(Physiolibrary.Organs.Lungs.Examples.LungsTest): time 0.1749/0.175, allocations: 51.35 MB / 443.9 MB, free: 55.24 MB / 378.7 MB
Notification: Performance of NFInst.instExpressions: time 0.01654/0.1915, allocations: 19.31 MB / 463.2 MB, free: 44.11 MB / 378.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002177/0.1937, allocations: 93.22 kB / 463.3 MB, free: 44.07 MB / 378.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.001601/0.1953, allocations: 0.9599 MB / 464.2 MB, free: 43.59 MB / 378.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.008131/0.2034, allocations: 5.46 MB / 469.7 MB, free: 40.4 MB / 378.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.005378/0.2088, allocations: 4.383 MB / 474.1 MB, free: 37.89 MB / 378.7 MB
Notification: Performance of NFFlatten.flatten: time 0.00831/0.2171, allocations: 10.62 MB / 484.7 MB, free: 32.51 MB / 378.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.01028/0.2274, allocations: 8.426 MB / 493.1 MB, free: 27.83 MB / 378.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.07307/0.3004, allocations: 38.9 MB / 0.5195 GB, free: 12.54 MB / 394.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.1184/0.4189, allocations: 55.58 MB / 0.5738 GB, free: 4.449 MB / 442.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.004671/0.4235, allocations: 1.828 MB / 0.5756 GB, free: 2.621 MB / 442.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.3789/0.8024, allocations: 96.48 MB / 0.6698 GB, free: 34.49 MB / 442.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.008164/0.8106, allocations: 10.42 MB / 0.68 GB, free: 30.65 MB / 442.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.01119/0.8218, allocations: 8.1 MB / 0.6879 GB, free: 25.33 MB / 442.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.02504/0.8468, allocations: 24.89 MB / 0.7122 GB, free: 2.031 MB / 442.7 MB
Notification: Performance of FrontEnd - DAE generated: time 5.189e-06/0.8468, allocations: 0 / 0.7122 GB, free: 2.031 MB / 442.7 MB
Notification: Performance of FrontEnd: time 9.52e-07/0.8468, allocations: 0 / 0.7122 GB, free: 2.031 MB / 442.7 MB
Notification: Performance of Transformations before backend: time 0.0004181/0.8472, allocations: 4 kB / 0.7122 GB, free: 2.027 MB / 442.7 MB
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 8.028/8.875, allocations: 1.769 GB / 2.481 GB, free: 113.5 MB / 0.5107 GB
Notification: Performance of prepare preOptimizeDAE: time 5.227e-05/8.875, allocations: 8.031 kB / 2.481 GB, free: 113.5 MB / 0.5107 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01572/8.891, allocations: 3.093 MB / 2.484 GB, free: 111 MB / 0.5107 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.02307/8.914, allocations: 11.74 MB / 2.495 GB, free: 103.4 MB / 0.5107 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001236/8.915, allocations: 1.104 MB / 2.496 GB, free: 102.7 MB / 0.5107 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.007822/8.923, allocations: 1.082 MB / 2.497 GB, free: 101.9 MB / 0.5107 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.04081/8.964, allocations: 15.28 MB / 2.512 GB, free: 86.41 MB / 0.5107 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0005093/8.964, allocations: 61.73 kB / 2.512 GB, free: 86.37 MB / 0.5107 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.005586/8.97, allocations: 428 kB / 2.513 GB, free: 85.95 MB / 0.5107 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0004709/8.971, allocations: 0.5507 MB / 2.513 GB, free: 85.4 MB / 0.5107 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03333/9.004, allocations: 11.84 MB / 2.525 GB, free: 73.68 MB / 0.5107 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.3948/9.399, allocations: 89.05 MB / 2.612 GB, free: 106.7 MB / 0.5107 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01433/9.413, allocations: 7.426 MB / 2.619 GB, free: 106.4 MB / 0.5107 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01188/9.425, allocations: 4.17 MB / 2.623 GB, free: 106.4 MB / 0.5107 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.06423/9.489, allocations: 32.18 MB / 2.655 GB, free: 91.38 MB / 0.5107 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0001116/9.489, allocations: 129.6 kB / 2.655 GB, free: 91.27 MB / 0.5107 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.01285/9.502, allocations: 2.6 MB / 2.657 GB, free: 90.77 MB / 0.5107 GB
Notification: Performance of pre-optimization done (n=1142): time 7.724e-05/9.502, allocations: 0 / 2.657 GB, free: 90.77 MB / 0.5107 GB
Notification: Performance of matching and sorting (n=1142): time 0.06343/9.566, allocations: 19.16 MB / 2.676 GB, free: 87.12 MB / 0.5107 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 8.585e-05/9.566, allocations: 154.6 kB / 2.676 GB, free: 87.05 MB / 0.5107 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.02119/9.587, allocations: 15.32 MB / 2.691 GB, free: 79.36 MB / 0.5107 GB
Notification: Performance of collectPreVariables (initialization): time 0.003754/9.591, allocations: 189.7 kB / 2.691 GB, free: 79.17 MB / 0.5107 GB
Notification: Performance of collectInitialEqns (initialization): time 0.005368/9.596, allocations: 6.363 MB / 2.697 GB, free: 74.02 MB / 0.5107 GB
Notification: Performance of collectInitialBindings (initialization): time 0.006693/9.603, allocations: 4.623 MB / 2.702 GB, free: 69.68 MB / 0.5107 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0307/9.633, allocations: 7.405 MB / 2.709 GB, free: 63.1 MB / 0.5107 GB
Notification: Performance of setup shared object (initialization): time 0.0001264/9.634, allocations: 484 kB / 2.71 GB, free: 62.62 MB / 0.5107 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.02295/9.656, allocations: 8.388 MB / 2.718 GB, free: 54.24 MB / 0.5107 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01793/9.674, allocations: 14.61 MB / 2.732 GB, free: 38.44 MB / 0.5107 GB
Error: Initialization problem is structural singular. Please, check the initial conditions.
Error: No system for the symbolic initialization was generated
"
[Timeout remaining time 634]
[Calling sys.exit(0), Time elapsed: 27.8032824001275]