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.07296/0.07296, allocations: 11.16 MB / 30.72 MB, free: 4.914 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.0009802/0.0009802, allocations: 103.4 kB / 38.43 MB, free: 7.363 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.001197/0.001197, allocations: 160.5 kB / 46.19 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 0.9143/0.9143, allocations: 177.2 MB / 231 MB, free: 4.793 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.09018/0.09018, allocations: 17.63 MB / 309.6 MB, free: 8.762 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 1.533e-06/1.533e-06, allocations: 0 / 391.2 MB, free: 46.21 MB / 330.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.621e-05/1.774e-05, allocations: 5.484 kB / 391.3 MB, free: 46.21 MB / 330.7 MB
Notification: Performance of NFInst.instantiate(Physiolibrary.Organs.Lungs.Examples.LungsTest): time 0.02715/0.02717, allocations: 52.25 MB / 443.5 MB, free: 9.879 MB / 346.7 MB
Notification: Performance of NFInst.instExpressions: time 0.0184/0.04556, allocations: 19.54 MB / 463 MB, free: 6.27 MB / 362.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001192/0.04676, allocations: 91.44 kB / 463.1 MB, free: 6.18 MB / 362.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.001598/0.04835, allocations: 0.9578 MB / 464.1 MB, free: 5.215 MB / 362.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.008428/0.05678, allocations: 5.459 MB / 469.6 MB, free: 15.72 MB / 378.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.004953/0.06173, allocations: 4.392 MB / 473.9 MB, free: 11.32 MB / 378.7 MB
Notification: Performance of NFFlatten.flatten: time 0.008146/0.06988, allocations: 10.62 MB / 484.6 MB, free: 0.6758 MB / 378.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.009198/0.07908, allocations: 8.43 MB / 493 MB, free: 8.137 MB / 394.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.2247/0.3038, allocations: 38.9 MB / 0.5194 GB, free: 39.51 MB / 410.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.1121/0.416, allocations: 55.47 MB / 0.5736 GB, free: 11.21 MB / 410.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.004108/0.4201, allocations: 1.83 MB / 0.5754 GB, free: 11.21 MB / 410.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.2372/0.6573, allocations: 96.48 MB / 0.6696 GB, free: 8.645 MB / 490.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.009433/0.6667, allocations: 10.41 MB / 0.6798 GB, free: 0.9805 MB / 490.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.2816/0.9483, allocations: 8.101 MB / 0.6877 GB, free: 119.5 MB / 490.8 MB
Notification: Performance of NFConvertDAE.convert: time 0.03903/0.9873, allocations: 24.88 MB / 0.712 GB, free: 117.8 MB / 490.8 MB
Notification: Performance of FrontEnd - DAE generated: time 7.524e-06/0.9873, allocations: 0 / 0.712 GB, free: 117.8 MB / 490.8 MB
Notification: Performance of FrontEnd: time 1.653e-06/0.9873, allocations: 3.312 kB / 0.712 GB, free: 117.8 MB / 490.8 MB
Notification: Performance of Transformations before backend: time 0.0009486/0.9883, allocations: 0 / 0.712 GB, free: 117.8 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 13.06/14.05, allocations: 4.62 GB / 5.332 GB, free: 111.6 MB / 0.5263 GB
Notification: Performance of prepare preOptimizeDAE: time 4.646e-05/14.05, allocations: 8.688 kB / 5.332 GB, free: 111.6 MB / 0.5263 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01418/14.06, allocations: 3.092 MB / 5.335 GB, free: 109.1 MB / 0.5263 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.02576/14.09, allocations: 16.53 MB / 5.351 GB, free: 97.43 MB / 0.5263 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0008999/14.09, allocations: 1.104 MB / 5.352 GB, free: 96.79 MB / 0.5263 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.00433/14.09, allocations: 1.083 MB / 5.353 GB, free: 96.06 MB / 0.5263 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02937/14.12, allocations: 16.84 MB / 5.37 GB, free: 79.12 MB / 0.5263 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0002072/14.12, allocations: 62.89 kB / 5.37 GB, free: 79.07 MB / 0.5263 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001919/14.13, allocations: 432 kB / 5.37 GB, free: 78.65 MB / 0.5263 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.000398/14.13, allocations: 0.6019 MB / 5.371 GB, free: 78.05 MB / 0.5263 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03764/14.16, allocations: 14.5 MB / 5.385 GB, free: 63.68 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.3673/14.53, allocations: 98.75 MB / 5.481 GB, free: 121.3 MB / 0.5263 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01621/14.55, allocations: 8.321 MB / 5.489 GB, free: 121 MB / 0.5263 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0118/14.56, allocations: 4.963 MB / 5.494 GB, free: 121 MB / 0.5263 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.05884/14.62, allocations: 34.21 MB / 5.528 GB, free: 104.3 MB / 0.5263 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 9.237e-05/14.62, allocations: 132.1 kB / 5.528 GB, free: 104.2 MB / 0.5263 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.008193/14.63, allocations: 2.607 MB / 5.53 GB, free: 103.6 MB / 0.5263 GB
Notification: Performance of pre-optimization done (n=1142): time 2.443e-05/14.63, allocations: 3.844 kB / 5.53 GB, free: 103.6 MB / 0.5263 GB
Notification: Performance of matching and sorting (n=1142): time 0.06207/14.69, allocations: 22.03 MB / 5.552 GB, free: 89.45 MB / 0.5263 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.73e-05/14.69, allocations: 148.3 kB / 5.552 GB, free: 89.3 MB / 0.5263 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.03129/14.72, allocations: 19.06 MB / 5.571 GB, free: 70.48 MB / 0.5263 GB
Notification: Performance of collectPreVariables (initialization): time 0.004147/14.72, allocations: 189.7 kB / 5.571 GB, free: 70.29 MB / 0.5263 GB
Notification: Performance of collectInitialEqns (initialization): time 0.00586/14.73, allocations: 6.296 MB / 5.577 GB, free: 64.12 MB / 0.5263 GB
Notification: Performance of collectInitialBindings (initialization): time 0.007243/14.74, allocations: 4.649 MB / 5.581 GB, free: 59.53 MB / 0.5263 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.02654/14.76, allocations: 7.22 MB / 5.588 GB, free: 52.29 MB / 0.5263 GB
Notification: Performance of setup shared object (initialization): time 4.422e-05/14.76, allocations: 480.7 kB / 5.589 GB, free: 51.82 MB / 0.5263 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01994/14.78, allocations: 10.86 MB / 5.6 GB, free: 40.96 MB / 0.5263 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.02452/14.81, allocations: 16.97 MB / 5.616 GB, free: 22.23 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 631]
[Calling sys.exit(0), Time elapsed: 30.865394324995577]