Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr OpenIPSL_OpenIPSL.Tests.Controls.PSAT.OEL.AVRTypeII_OEL_Test.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.001599/0.001599, 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.423/1.423, allocations: 230.6 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.001519/0.001519, allocations: 219.5 kB / 310.1 MB, free: 3.051 MB / 238.1 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.0.1/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.0.1/package.mo): time 0.4635/0.4635, allocations: 79.75 MB / 446.3 MB, free: 40.36 MB / 350.1 MB " [Timeout remaining time 179] Using package OpenIPSL with version 3.0.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.0.1/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.Tests.Controls.PSAT.OEL.AVRTypeII_OEL_Test,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_OpenIPSL.Tests.Controls.PSAT.OEL.AVRTypeII_OEL_Test") translateModel(OpenIPSL.Tests.Controls.PSAT.OEL.AVRTypeII_OEL_Test,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_OpenIPSL.Tests.Controls.PSAT.OEL.AVRTypeII_OEL_Test") [Timeout 660] "Notification: Performance of FrontEnd - Absyn->SCode: time 1.603e-05/1.603e-05, allocations: 3.266 kB / 0.5941 GB, free: 38.5 MB / 446.1 MB Notification: Performance of NFInst.instantiate(OpenIPSL.Tests.Controls.PSAT.OEL.AVRTypeII_OEL_Test): time 0.005732/0.005748, allocations: 6.154 MB / 0.6002 GB, free: 35.3 MB / 446.1 MB Notification: Performance of NFInst.instExpressions: time 0.003155/0.008903, allocations: 2.085 MB / 0.6022 GB, free: 33.88 MB / 446.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.0003646/0.009268, allocations: 21.38 kB / 0.6022 GB, free: 33.88 MB / 446.1 MB Notification: Performance of NFTyping.typeComponents: time 0.0005476/0.009815, allocations: 250.8 kB / 0.6025 GB, free: 33.74 MB / 446.1 MB Notification: Performance of NFTyping.typeBindings: time 0.001482/0.0113, allocations: 0.8163 MB / 0.6032 GB, free: 33.21 MB / 446.1 MB [/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.0.1/Electrical/Machines/PSAT/Order4.mo:25:3-30:9:writable] Warning: In relation generator.xq <> generator.x1q, <> on Real numbers is only allowed inside functions. Notification: Performance of NFTyping.typeClassSections: time 0.001303/0.0126, allocations: 0.7486 MB / 0.604 GB, free: 32.83 MB / 446.1 MB Notification: Performance of NFFlatten.flatten: time 0.001501/0.0141, allocations: 2.117 MB / 0.606 GB, free: 31.8 MB / 446.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.0004024/0.0145, allocations: 240.1 kB / 0.6063 GB, free: 31.66 MB / 446.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.0007376/0.01524, allocations: 0.8125 MB / 0.6071 GB, free: 31.27 MB / 446.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.0006747/0.01592, allocations: 0.7592 MB / 0.6078 GB, free: 30.92 MB / 446.1 MB Notification: Performance of NFPackage.collectConstants: time 0.0001654/0.01608, allocations: 125 kB / 0.6079 GB, free: 30.91 MB / 446.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.0004128/0.01649, allocations: 284 kB / 0.6082 GB, free: 30.87 MB / 446.1 MB Notification: Performance of combineBinaries: time 0.001365/0.01786, allocations: 3.25 MB / 0.6114 GB, free: 28.66 MB / 446.1 MB Notification: Performance of replaceArrayConstructors: time 0.0005782/0.01844, allocations: 2.011 MB / 0.6133 GB, free: 27.24 MB / 446.1 MB Notification: Performance of NFVerifyModel.verify: time 0.0001402/0.01858, allocations: 92.69 kB / 0.6134 GB, free: 27.24 MB / 446.1 MB Notification: Performance of FrontEnd: time 0.0001233/0.0187, allocations: 49.19 kB / 0.6135 GB, free: 27.22 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: 219 (207) * Number of variables: 219 (219) Notification: Performance of [SIM] Bindings: time 0.003833/0.02253, allocations: 7.268 MB / 0.6206 GB, free: 22.32 MB / 446.1 MB Notification: Performance of [SIM] FunctionAlias: time 0.0006129/0.02315, allocations: 0.8241 MB / 0.6214 GB, free: 21.85 MB / 446.1 MB Notification: Performance of [SIM] Early Inline: time 0.004509/0.02766, allocations: 7.609 MB / 0.6288 GB, free: 17.91 MB / 446.1 MB Notification: Performance of [SIM] Simplify 1: time 0.001085/0.02874, allocations: 1.057 MB / 0.6298 GB, free: 17.51 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.004265/0.03301, allocations: 5.307 MB / 0.635 GB, free: 14.3 MB / 446.1 MB Notification: Performance of [SIM] Simplify 2: time 0.0008722/0.03388, allocations: 0.9165 MB / 0.6359 GB, free: 13.95 MB / 446.1 MB Notification: Performance of [SIM] Remove Stream: time 0.000283/0.03416, allocations: 430.4 kB / 0.6363 GB, free: 13.67 MB / 446.1 MB Notification: Performance of [SIM] Detect States: time 0.0006558/0.03482, allocations: 1.097 MB / 0.6374 GB, free: 12.96 MB / 446.1 MB Notification: Performance of [SIM] Events: time 0.0005016/0.03532, allocations: 0.5194 MB / 0.6379 GB, free: 12.67 MB / 446.1 MB Notification: Performance of [SIM] Partitioning: time 0.0013/0.03662, allocations: 1.788 MB / 0.6397 GB, free: 11.9 MB / 446.1 MB Notification: Performance of [SIM] Causalize: time 0.003775/0.04039, allocations: 3.276 MB / 0.6429 GB, free: 11.04 MB / 446.1 MB Notification: Performance of [SIM] After Index Reduction Inline: time 0.002297/0.04269, allocations: 3.695 MB / 0.6465 GB, free: 9.031 MB / 446.1 MB Notification: Performance of [INI] Simplify: time 0.003883/0.04657, allocations: 2.853 MB / 0.6492 GB, free: 7.582 MB / 446.1 MB Notification: Performance of [INI] Inline: time 0.005927/0.0525, allocations: 7.424 MB / 0.6565 GB, free: 3.516 MB / 446.1 MB Notification: Performance of [INI] Partitioning: time 0.0002068/0.05271, allocations: 98.62 kB / 0.6566 GB, free: 3.445 MB / 446.1 MB Notification: Performance of [INI] Cleanup: time 0.0008165/0.05352, allocations: 1.049 MB / 0.6576 GB, free: 2.855 MB / 446.1 MB Notification: Performance of [INI] Causalize: time 0.0126/0.06613, allocations: 9.763 MB / 0.6671 GB, free: 14.12 MB / 462.1 MB Notification: Performance of [INI] Tearing: time 0.001895/0.06802, allocations: 1.594 MB / 0.6687 GB, free: 12.6 MB / 462.1 MB Notification: Performance of [SIM] Initialization: time 1.232e-06/0.06802, allocations: 0 / 0.6687 GB, free: 12.6 MB / 462.1 MB Notification: Performance of [SIM] DAE-Mode: time 0.002911/0.07093, allocations: 2.176 MB / 0.6708 GB, free: 10.46 MB / 462.1 MB Notification: Performance of [SIM] Remove Dummies: time 6.633e-06/0.07094, allocations: 1 kB / 0.6708 GB, free: 10.46 MB / 462.1 MB Notification: Performance of [SIM] Tearing: time 0.001669/0.07261, allocations: 1.335 MB / 0.6721 GB, free: 9.156 MB / 462.1 MB Notification: Performance of [SIM] Categorize: time 1.383e-05/0.07262, allocations: 8 kB / 0.6721 GB, free: 9.148 MB / 462.1 MB Notification: Performance of [SIM] Solve: time 0.008454/0.08108, allocations: 6.74 MB / 0.6787 GB, free: 2.438 MB / 462.1 MB Error: Internal error NBJacobian.SparsityColoring.PartialD2ColoringAlgC.getIndices failed because cref exciter_Type_II.vref0 is neither a seed nor a partial candidate! " [Timeout remaining time 660] [Calling sys.exit(0), Time elapsed: 2.972106220026035] Failed to read output from testmodel.py, exit status != 0: 0.08912141196196899 0.10414340399999994 0.08245885999999994 Calling exit ...