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.06566/0.06566, allocations: 11.15 MB / 30.94 MB, free: 4.305 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.0009788/0.0009788, allocations: 100.5 kB / 38.66 MB, free: 6.758 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.00118/0.00118, allocations: 156.6 kB / 46.45 MB, free: 10.05 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.9066/0.9066, allocations: 177.2 MB / 231.3 MB, free: 4.648 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.1012/0.1012, allocations: 17.64 MB / 309.9 MB, free: 8.57 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.254e-06/2.254e-06, allocations: 0 / 391.7 MB, free: 45.93 MB / 330.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.091e-05/2.316e-05, allocations: 2.875 kB / 391.7 MB, free: 45.92 MB / 330.7 MB
Notification: Performance of NFInst.instantiate(Physiolibrary.Organs.Lungs.Examples.LungsTest): time 0.06181/0.06183, allocations: 51.34 MB / 443.1 MB, free: 10.5 MB / 346.7 MB
Notification: Performance of NFInst.instExpressions: time 0.02565/0.08749, allocations: 19.33 MB / 462.4 MB, free: 7.105 MB / 362.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003924/0.09141, allocations: 95.44 kB / 462.5 MB, free: 7.012 MB / 362.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.001883/0.09329, allocations: 0.9424 MB / 463.4 MB, free: 6.062 MB / 362.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.01152/0.1048, allocations: 5.47 MB / 468.9 MB, free: 0.5586 MB / 362.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.00781/0.1126, allocations: 4.382 MB / 473.3 MB, free: 12.16 MB / 378.7 MB
Notification: Performance of NFFlatten.flatten: time 0.01032/0.1229, allocations: 10.62 MB / 483.9 MB, free: 1.512 MB / 378.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.01017/0.1331, allocations: 8.426 MB / 492.3 MB, free: 8.977 MB / 394.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.2672/0.4003, allocations: 38.91 MB / 0.5188 GB, free: 40.59 MB / 410.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.1179/0.5182, allocations: 55.58 MB / 0.5731 GB, free: 12.3 MB / 410.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.005875/0.5241, allocations: 1.823 MB / 0.5748 GB, free: 12.3 MB / 410.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.2281/0.7522, allocations: 96.49 MB / 0.6691 GB, free: 8.609 MB / 490.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.01025/0.7625, allocations: 10.42 MB / 0.6792 GB, free: 1.309 MB / 490.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.3076/1.07, allocations: 8.098 MB / 0.6871 GB, free: 120 MB / 490.8 MB
Notification: Performance of NFConvertDAE.convert: time 0.03752/1.108, allocations: 24.88 MB / 0.7114 GB, free: 118.4 MB / 490.8 MB
Notification: Performance of FrontEnd - DAE generated: time 7.985e-06/1.108, allocations: 0 / 0.7114 GB, free: 118.4 MB / 490.8 MB
Notification: Performance of FrontEnd: time 1.804e-06/1.108, allocations: 0.5625 kB / 0.7114 GB, free: 118.4 MB / 490.8 MB
Notification: Performance of Transformations before backend: time 0.001082/1.109, allocations: 0 / 0.7114 GB, free: 118.4 MB / 490.8 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 7.118/8.226, allocations: 1.769 GB / 2.48 GB, free: 82.32 MB / 0.5263 GB
Notification: Performance of prepare preOptimizeDAE: time 5.041e-05/8.226, allocations: 12.03 kB / 2.48 GB, free: 82.31 MB / 0.5263 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.008248/8.234, allocations: 3.089 MB / 2.483 GB, free: 79.77 MB / 0.5263 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.02181/8.256, allocations: 11.73 MB / 2.494 GB, free: 72.16 MB / 0.5263 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001019/8.257, allocations: 1.102 MB / 2.496 GB, free: 71.52 MB / 0.5263 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.006316/8.264, allocations: 1.084 MB / 2.497 GB, free: 70.79 MB / 0.5263 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.03962/8.303, allocations: 15.29 MB / 2.512 GB, free: 56.7 MB / 0.5263 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0005833/8.304, allocations: 63.11 kB / 2.512 GB, free: 56.66 MB / 0.5263 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.004226/8.308, allocations: 430.1 kB / 2.512 GB, free: 56.57 MB / 0.5263 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0005202/8.309, allocations: 0.5469 MB / 2.513 GB, free: 56.08 MB / 0.5263 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02763/8.336, allocations: 11.85 MB / 2.524 GB, free: 44.96 MB / 0.5263 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.3885/8.725, allocations: 89.04 MB / 2.611 GB, free: 121.8 MB / 0.5263 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01533/8.74, allocations: 7.436 MB / 2.618 GB, free: 121.5 MB / 0.5263 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.007795/8.748, allocations: 4.163 MB / 2.622 GB, free: 121.4 MB / 0.5263 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.04611/8.794, allocations: 32.25 MB / 2.654 GB, free: 103.3 MB / 0.5263 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0001047/8.794, allocations: 128.6 kB / 2.654 GB, free: 103.2 MB / 0.5263 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.008826/8.803, allocations: 2.603 MB / 2.657 GB, free: 102.3 MB / 0.5263 GB
Notification: Performance of pre-optimization done (n=1142): time 3.731e-05/8.803, allocations: 0 / 2.657 GB, free: 102.3 MB / 0.5263 GB
Notification: Performance of matching and sorting (n=1142): time 0.03758/8.84, allocations: 19.38 MB / 2.675 GB, free: 88.71 MB / 0.5263 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.111e-05/8.841, allocations: 146.7 kB / 2.676 GB, free: 88.55 MB / 0.5263 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.02286/8.863, allocations: 15.32 MB / 2.691 GB, free: 75.59 MB / 0.5263 GB
Notification: Performance of collectPreVariables (initialization): time 0.004469/8.868, allocations: 193.7 kB / 2.691 GB, free: 75.39 MB / 0.5263 GB
Notification: Performance of collectInitialEqns (initialization): time 0.004836/8.873, allocations: 6.368 MB / 2.697 GB, free: 69.67 MB / 0.5263 GB
Notification: Performance of collectInitialBindings (initialization): time 0.007825/8.881, allocations: 4.616 MB / 2.701 GB, free: 65.3 MB / 0.5263 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.01218/8.893, allocations: 7.402 MB / 2.709 GB, free: 58.72 MB / 0.5263 GB
Notification: Performance of setup shared object (initialization): time 5.442e-05/8.893, allocations: 480.7 kB / 2.709 GB, free: 58.25 MB / 0.5263 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01137/8.904, allocations: 8.396 MB / 2.717 GB, free: 49.86 MB / 0.5263 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01567/8.92, allocations: 14.61 MB / 2.732 GB, free: 34.06 MB / 0.5263 GB
Error: Initialization problem is structural singular. Please, check the initial conditions.
Error: No system for the symbolic initialization was generated
"
[Timeout remaining time 635]
[Calling sys.exit(0), Time elapsed: 26.625337756238878]