Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr OpenIPSL_dev_OpenIPSL.Examples.PSATSystems.TwoAreaOld.FifthOrder_AVRI.conf.json 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.00139/0.00139, allocations: 104.3 kB / 19.77 MB, free: 2.051 MB / 14.72 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.479/1.479, allocations: 230.7 MB / 253.5 MB, free: 14.25 MB / 206.1 MB " [Timeout remaining time 178] 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.001565/0.001565, allocations: 208.2 kB / 310.1 MB, free: 3.07 MB / 238.1 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL master/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL master/package.mo): time 0.6039/0.6039, allocations: 107.2 MB / 473.7 MB, free: 29.93 MB / 350.1 MB " [Timeout remaining time 179] Using package OpenIPSL with version 3.1.0-dev (/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL master/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 Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 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) Running command: translateModel(OpenIPSL.Examples.PSATSystems.TwoAreaOld.FifthOrder_AVRI,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_dev_OpenIPSL.Examples.PSATSystems.TwoAreaOld.FifthOrder_AVRI") translateModel(OpenIPSL.Examples.PSATSystems.TwoAreaOld.FifthOrder_AVRI,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_dev_OpenIPSL.Examples.PSATSystems.TwoAreaOld.FifthOrder_AVRI") [Timeout 660] "Notification: Performance of FrontEnd - Absyn->SCode: time 1.391e-05/1.391e-05, allocations: 2.281 kB / 0.6343 GB, free: 29.45 MB / 446.1 MB Notification: Performance of NFInst.instantiate(OpenIPSL.Examples.PSATSystems.TwoAreaOld.FifthOrder_AVRI): time 0.005433/0.005447, allocations: 5.777 MB / 0.64 GB, free: 25.54 MB / 446.1 MB Notification: Performance of NFInst.instExpressions: time 0.003781/0.009228, allocations: 1.976 MB / 0.6419 GB, free: 24.17 MB / 446.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.000528/0.009756, allocations: 14.12 kB / 0.6419 GB, free: 24.17 MB / 446.1 MB Notification: Performance of NFTyping.typeComponents: time 0.0006176/0.01037, allocations: 242.1 kB / 0.6421 GB, free: 24.04 MB / 446.1 MB Notification: Performance of NFTyping.typeBindings: time 0.001842/0.01222, allocations: 0.8499 MB / 0.643 GB, free: 23.49 MB / 446.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.001291/0.01351, allocations: 0.6599 MB / 0.6436 GB, free: 23.16 MB / 446.1 MB Notification: Performance of NFFlatten.flatten: time 0.001751/0.01526, allocations: 1.956 MB / 0.6455 GB, free: 22.21 MB / 446.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.000386/0.01564, allocations: 194.8 kB / 0.6457 GB, free: 22.11 MB / 446.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.0008256/0.01647, allocations: 0.7566 MB / 0.6464 GB, free: 21.74 MB / 446.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.0007725/0.01724, allocations: 0.7636 MB / 0.6472 GB, free: 21.41 MB / 446.1 MB Notification: Performance of NFPackage.collectConstants: time 0.0001802/0.01742, allocations: 111.7 kB / 0.6473 GB, free: 21.41 MB / 446.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.0005251/0.01795, allocations: 274.7 kB / 0.6476 GB, free: 21.36 MB / 446.1 MB Notification: Performance of combineBinaries: time 0.001777/0.01972, allocations: 3.167 MB / 0.6507 GB, free: 19.27 MB / 446.1 MB Notification: Performance of replaceArrayConstructors: time 0.0008595/0.02058, allocations: 1.888 MB / 0.6525 GB, free: 17.93 MB / 446.1 MB Notification: Performance of NFVerifyModel.verify: time 0.0002185/0.0208, allocations: 84.59 kB / 0.6526 GB, free: 17.93 MB / 446.1 MB Notification: Performance of FrontEnd: time 0.0001522/0.02095, allocations: 37 kB / 0.6526 GB, free: 17.93 MB / 446.1 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 188 (175) * Number of variables: 188 (186) Notification: Performance of [SIM] Bindings: time 0.004247/0.0252, allocations: 6.788 MB / 0.6592 GB, free: 13.07 MB / 446.1 MB Notification: Performance of [SIM] FunctionAlias: time 0.0006348/0.02584, allocations: 0.7563 MB / 0.66 GB, free: 12.47 MB / 446.1 MB Notification: Performance of [SIM] Early Inline: time 0.003846/0.02968, allocations: 6.36 MB / 0.6662 GB, free: 6.469 MB / 446.1 MB Notification: Performance of [SIM] Simplify 1: time 0.0009339/0.03062, allocations: 0.9222 MB / 0.6671 GB, free: 5.477 MB / 446.1 MB Warning: NBAlias.setStartFixed: Alias set with conflicting unfixed start values detected. Use -d=dumprepl for more information. Notification: Performance of [SIM] Alias: time 0.003773/0.03439, allocations: 4.608 MB / 0.6716 GB, free: 432 kB / 446.1 MB Notification: Performance of [SIM] Simplify 2: time 0.001029/0.03542, allocations: 0.8491 MB / 0.6724 GB, free: 15.51 MB / 462.1 MB Notification: Performance of [SIM] Remove Stream: time 0.0004369/0.03586, allocations: 391.9 kB / 0.6728 GB, free: 15.09 MB / 462.1 MB Notification: Performance of [SIM] Detect States: time 0.001042/0.0369, allocations: 0.988 MB / 0.6738 GB, free: 14.04 MB / 462.1 MB Notification: Performance of [SIM] Events: time 0.0005768/0.03747, allocations: 406.9 kB / 0.6741 GB, free: 13.64 MB / 462.1 MB Notification: Performance of [SIM] Partitioning: time 0.001812/0.03929, allocations: 1.562 MB / 0.6757 GB, free: 12.05 MB / 462.1 MB Notification: Performance of [SIM] Causalize: time 0.00407/0.04335, allocations: 2.812 MB / 0.6784 GB, free: 9.188 MB / 462.1 MB Notification: Performance of [SIM] After Index Reduction Inline: time 0.003123/0.04648, allocations: 3.173 MB / 0.6815 GB, free: 6.012 MB / 462.1 MB Notification: Performance of [INI] Simplify: time 0.005009/0.05149, allocations: 3.042 MB / 0.6845 GB, free: 2.777 MB / 462.1 MB Notification: Performance of [INI] Inline: time 0.007397/0.05888, allocations: 7.271 MB / 0.6916 GB, free: 11.47 MB / 478.1 MB Notification: Performance of [INI] Partitioning: time 0.0002408/0.05912, allocations: 109 kB / 0.6917 GB, free: 11.33 MB / 478.1 MB Notification: Performance of [INI] Cleanup: time 0.001411/0.06054, allocations: 1.386 MB / 0.693 GB, free: 9.93 MB / 478.1 MB Notification: Performance of [INI] Causalize: time 0.02889/0.08942, allocations: 19.2 MB / 0.7118 GB, free: 6.199 MB / 494.1 MB Notification: Performance of [INI] Tearing: time 0.003289/0.09271, allocations: 2.774 MB / 0.7145 GB, free: 3.477 MB / 494.1 MB Notification: Performance of [SIM] Initialization: time 1.623e-06/0.09271, allocations: 0 / 0.7145 GB, free: 3.477 MB / 494.1 MB Notification: Performance of [SIM] DAE-Mode: time 0.002561/0.09528, allocations: 1.887 MB / 0.7163 GB, free: 1.621 MB / 494.1 MB Notification: Performance of [SIM] Remove Dummies: time 8.025e-06/0.09528, allocations: 0.6562 kB / 0.7163 GB, free: 1.621 MB / 494.1 MB Notification: Performance of [SIM] Tearing: time 0.0009753/0.09626, allocations: 0.8451 MB / 0.7172 GB, free: 0.7891 MB / 494.1 MB Notification: Performance of [SIM] Categorize: time 2.22e-05/0.09628, allocations: 12 kB / 0.7172 GB, free: 0.7773 MB / 494.1 MB Notification: Performance of [SIM] Solve: time 0.009211/0.1055, allocations: 6.793 MB / 0.7238 GB, free: 10.03 MB / 0.4981 GB Error: Internal error NBJacobian.SparsityColoring.PartialD2ColoringAlgC.getIndices failed because cref aVRTypeI.vref0 is neither a seed nor a partial candidate! " [Timeout remaining time 660] [Calling sys.exit(0), Time elapsed: 3.2650486580096185] Failed to read output from testmodel.py, exit status != 0: 0.11375469999620691 0.12924529599999995 0.10522861899999994 Calling exit ...