Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr OpenIPSL_2.0.0_OpenIPSL.Examples.PSATSystems.TwoAreaOld.FifthOrder_AVRII.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/package.mo): time 0.09499/0.09499, allocations: 12.36 MB / 32.03 MB, free: 6.41 MB / 26.18 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.001362/0.001362, allocations: 112.9 kB / 38.07 MB, free: 1.086 MB / 26.18 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.511/1.511, allocations: 207.7 MB / 251.7 MB, free: 7.211 MB / 190.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.001909/0.001909, allocations: 220.4 kB / 307 MB, free: 240 kB / 238.1 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/package.mo): time 0.3282/0.3282, allocations: 79.74 MB / 441.8 MB, free: 12.22 MB / 318.1 MB " [Timeout remaining time 179] Using package OpenIPSL with version 2.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/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 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+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 Modelica_Synchronous with version 0.93.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/package.mo) Running command: translateModel(OpenIPSL.Examples.PSATSystems.TwoAreaOld.FifthOrder_AVRII,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_2.0.0_OpenIPSL.Examples.PSATSystems.TwoAreaOld.FifthOrder_AVRII") translateModel(OpenIPSL.Examples.PSATSystems.TwoAreaOld.FifthOrder_AVRII,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_2.0.0_OpenIPSL.Examples.PSATSystems.TwoAreaOld.FifthOrder_AVRII") [Timeout 660] "Notification: Performance of FrontEnd - Absyn->SCode: time 2.51e-05/2.51e-05, allocations: 2.281 kB / 0.5887 GB, free: 7.02 MB / 398.1 MB Notification: Performance of NFInst.instantiate(OpenIPSL.Examples.PSATSystems.TwoAreaOld.FifthOrder_AVRII): time 0.00909/0.009115, allocations: 5.887 MB / 0.5945 GB, free: 1.094 MB / 398.1 MB Notification: Performance of NFInst.instExpressions: time 0.005263/0.01438, allocations: 1.901 MB / 0.5963 GB, free: 15.18 MB / 414.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.001336/0.01571, allocations: 8 kB / 0.5964 GB, free: 15.18 MB / 414.1 MB Notification: Performance of NFTyping.typeComponents: time 0.001267/0.01698, allocations: 245.9 kB / 0.5966 GB, free: 14.93 MB / 414.1 MB Notification: Performance of NFTyping.typeBindings: time 0.003367/0.02035, allocations: 0.8313 MB / 0.5974 GB, free: 14.1 MB / 414.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.001703/0.02205, allocations: 0.638 MB / 0.598 GB, free: 13.47 MB / 414.1 MB Notification: Performance of NFFlatten.flatten: time 0.002773/0.02483, allocations: 1.983 MB / 0.6 GB, free: 11.48 MB / 414.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.0004507/0.02528, allocations: 191.4 kB / 0.6001 GB, free: 11.28 MB / 414.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.001109/0.02638, allocations: 0.7626 MB / 0.6009 GB, free: 10.52 MB / 414.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.0009126/0.0273, allocations: 0.7734 MB / 0.6016 GB, free: 9.738 MB / 414.1 MB Notification: Performance of NFPackage.collectConstants: time 0.0001799/0.02748, allocations: 120 kB / 0.6018 GB, free: 9.621 MB / 414.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.0005938/0.02807, allocations: 263.8 kB / 0.602 GB, free: 9.363 MB / 414.1 MB Notification: Performance of combineBinaries: time 0.002827/0.0309, allocations: 3.238 MB / 0.6052 GB, free: 6.094 MB / 414.1 MB Notification: Performance of replaceArrayConstructors: time 0.001654/0.03255, allocations: 1.935 MB / 0.6071 GB, free: 4.133 MB / 414.1 MB Notification: Performance of NFVerifyModel.verify: time 0.000288/0.03284, allocations: 88 kB / 0.6071 GB, free: 4.047 MB / 414.1 MB Notification: Performance of FrontEnd: time 0.0002103/0.03305, allocations: 35.88 kB / 0.6072 GB, free: 4.012 MB / 414.1 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 191 (179) * Number of variables: 191 (191) Notification: Performance of [SIM] Bindings: time 0.007102/0.04015, allocations: 6.876 MB / 0.6139 GB, free: 12.88 MB / 430.1 MB Notification: Performance of [SIM] FunctionAlias: time 0.001049/0.0412, allocations: 0.821 MB / 0.6147 GB, free: 12.03 MB / 430.1 MB Notification: Performance of [SIM] Early Inline: time 0.006911/0.04811, allocations: 6.422 MB / 0.621 GB, free: 5.57 MB / 430.1 MB Notification: Performance of [SIM] Simplify 1: time 0.001494/0.04961, allocations: 0.9498 MB / 0.6219 GB, free: 4.566 MB / 430.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.006635/0.05624, allocations: 4.715 MB / 0.6265 GB, free: 15.4 MB / 446.1 MB Notification: Performance of [SIM] Simplify 2: time 0.001228/0.05747, allocations: 0.8758 MB / 0.6274 GB, free: 14.46 MB / 446.1 MB Notification: Performance of [SIM] Remove Stream: time 0.0004693/0.05794, allocations: 388 kB / 0.6277 GB, free: 14.05 MB / 446.1 MB Notification: Performance of [SIM] Detect States: time 0.001084/0.05902, allocations: 1.004 MB / 0.6287 GB, free: 12.98 MB / 446.1 MB Notification: Performance of [SIM] Events: time 0.0006311/0.05965, allocations: 457.6 kB / 0.6291 GB, free: 12.53 MB / 446.1 MB Notification: Performance of [SIM] Partitioning: time 0.001804/0.06146, allocations: 1.582 MB / 0.6307 GB, free: 10.93 MB / 446.1 MB Notification: Performance of [SIM] Causalize: time 0.004052/0.06551, allocations: 2.843 MB / 0.6335 GB, free: 8.043 MB / 446.1 MB Notification: Performance of [SIM] After Index Reduction Inline: time 0.003175/0.06868, allocations: 3.255 MB / 0.6366 GB, free: 4.781 MB / 446.1 MB Notification: Performance of [INI] Simplify: time 0.005586/0.07427, allocations: 3.148 MB / 0.6397 GB, free: 1.422 MB / 446.1 MB Notification: Performance of [INI] Inline: time 0.3022/0.3765, allocations: 7.33 MB / 0.6469 GB, free: 43.74 MB / 446.1 MB Notification: Performance of [INI] Partitioning: time 0.0003755/0.3768, allocations: 105.4 kB / 0.647 GB, free: 43.68 MB / 446.1 MB Notification: Performance of [INI] Cleanup: time 0.001119/0.378, allocations: 0.9673 MB / 0.6479 GB, free: 43.32 MB / 446.1 MB Notification: Performance of [INI] Causalize: time 0.01641/0.3944, allocations: 9.856 MB / 0.6575 GB, free: 41.09 MB / 446.1 MB Notification: Performance of [INI] Tearing: time 0.001785/0.3962, allocations: 1.411 MB / 0.6589 GB, free: 40.86 MB / 446.1 MB Notification: Performance of [SIM] Initialization: time 1.854e-06/0.3962, allocations: 0 / 0.6589 GB, free: 40.86 MB / 446.1 MB Notification: Performance of [SIM] DAE-Mode: time 0.002671/0.3988, allocations: 1.945 MB / 0.6608 GB, free: 40.21 MB / 446.1 MB Notification: Performance of [SIM] Remove Dummies: time 8.896e-06/0.3988, allocations: 1.906 kB / 0.6608 GB, free: 40.21 MB / 446.1 MB Notification: Performance of [SIM] Tearing: time 0.001023/0.3999, allocations: 0.9289 MB / 0.6617 GB, free: 39.89 MB / 446.1 MB Notification: Performance of [SIM] Categorize: time 2.289e-05/0.3999, allocations: 5.625 kB / 0.6617 GB, free: 39.89 MB / 446.1 MB Notification: Performance of [SIM] Solve: time 0.00888/0.4088, allocations: 6.843 MB / 0.6684 GB, free: 37.61 MB / 446.1 MB Error: Internal error NBJacobian.SparsityColoring.PartialD2ColoringAlgC.getIndices failed because cref aVRTypeII.vref0 is neither a seed nor a partial candidate! " [Timeout remaining time 660] [Calling sys.exit(0), Time elapsed: 3.5564613780006766] Failed to read output from testmodel.py, exit status != 0: 0.41823524999199435 0.42692823300000005 0.39175214900000005 Calling exit ...