Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr OpenIPSL_OpenIPSL.Examples.PSATSystems.TwoAreaOld.FourthOrder_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.001648/0.001648, 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.45/1.45, 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.001474/0.001474, allocations: 221.5 kB / 310.1 MB, free: 3.012 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.4753/0.4753, allocations: 79.76 MB / 446.3 MB, free: 40.25 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.Examples.PSATSystems.TwoAreaOld.FourthOrder_AVRI,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_OpenIPSL.Examples.PSATSystems.TwoAreaOld.FourthOrder_AVRI") translateModel(OpenIPSL.Examples.PSATSystems.TwoAreaOld.FourthOrder_AVRI,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_OpenIPSL.Examples.PSATSystems.TwoAreaOld.FourthOrder_AVRI") [Timeout 660] "Notification: Performance of FrontEnd - Absyn->SCode: time 2.154e-05/2.154e-05, allocations: 3.156 kB / 0.5941 GB, free: 38.49 MB / 446.1 MB Notification: Performance of NFInst.instantiate(OpenIPSL.Examples.PSATSystems.TwoAreaOld.FourthOrder_AVRI): time 0.00632/0.006341, allocations: 5.667 MB / 0.5997 GB, free: 35.62 MB / 446.1 MB Notification: Performance of NFInst.instExpressions: time 0.004192/0.01053, allocations: 1.939 MB / 0.6016 GB, free: 34.31 MB / 446.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.0008269/0.01136, allocations: 15.62 kB / 0.6016 GB, free: 34.3 MB / 446.1 MB Notification: Performance of NFTyping.typeComponents: time 0.0008248/0.01219, allocations: 246 kB / 0.6018 GB, free: 34.18 MB / 446.1 MB Notification: Performance of NFTyping.typeBindings: time 0.002122/0.01431, allocations: 0.8318 MB / 0.6026 GB, free: 33.64 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 order4.xq <> order4.x1q, <> on Real numbers is only allowed inside functions. Notification: Performance of NFTyping.typeClassSections: time 0.001427/0.01573, allocations: 0.657 MB / 0.6033 GB, free: 33.32 MB / 446.1 MB Notification: Performance of NFFlatten.flatten: time 0.001968/0.0177, allocations: 1.906 MB / 0.6051 GB, free: 32.42 MB / 446.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.0003703/0.01807, allocations: 192.5 kB / 0.6053 GB, free: 32.32 MB / 446.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.0008145/0.01889, allocations: 0.7384 MB / 0.606 GB, free: 31.96 MB / 446.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.0007225/0.01961, allocations: 0.7401 MB / 0.6068 GB, free: 31.63 MB / 446.1 MB Notification: Performance of NFPackage.collectConstants: time 0.0001595/0.01977, allocations: 104.8 kB / 0.6069 GB, free: 31.63 MB / 446.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.0005132/0.02028, allocations: 264 kB / 0.6071 GB, free: 31.59 MB / 446.1 MB Notification: Performance of combineBinaries: time 0.001504/0.02179, allocations: 3.047 MB / 0.6101 GB, free: 29.55 MB / 446.1 MB Notification: Performance of replaceArrayConstructors: time 0.0006699/0.02246, allocations: 1.862 MB / 0.6119 GB, free: 28.23 MB / 446.1 MB Notification: Performance of NFVerifyModel.verify: time 0.0001517/0.02261, allocations: 84.84 kB / 0.612 GB, free: 28.23 MB / 446.1 MB Notification: Performance of FrontEnd: time 0.0001374/0.02274, allocations: 36.81 kB / 0.612 GB, free: 28.23 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: 187 (174) * Number of variables: 187 (185) Notification: Performance of [SIM] Bindings: time 0.004068/0.02681, allocations: 6.589 MB / 0.6185 GB, free: 23.78 MB / 446.1 MB Notification: Performance of [SIM] FunctionAlias: time 0.0006796/0.02749, allocations: 0.7802 MB / 0.6192 GB, free: 23.33 MB / 446.1 MB Notification: Performance of [SIM] Early Inline: time 0.004081/0.03157, allocations: 6.25 MB / 0.6253 GB, free: 20.12 MB / 446.1 MB Notification: Performance of [SIM] Simplify 1: time 0.0009418/0.03251, allocations: 0.8369 MB / 0.6261 GB, free: 19.78 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.004094/0.03661, allocations: 4.537 MB / 0.6306 GB, free: 17.03 MB / 446.1 MB Notification: Performance of [SIM] Simplify 2: time 0.0007781/0.03739, allocations: 0.7642 MB / 0.6313 GB, free: 16.75 MB / 446.1 MB Notification: Performance of [SIM] Remove Stream: time 0.0002655/0.03765, allocations: 382.5 kB / 0.6317 GB, free: 16.51 MB / 446.1 MB Notification: Performance of [SIM] Detect States: time 0.0006468/0.0383, allocations: 0.9416 MB / 0.6326 GB, free: 15.9 MB / 446.1 MB Notification: Performance of [SIM] Events: time 0.0003937/0.03869, allocations: 406.9 kB / 0.633 GB, free: 15.7 MB / 446.1 MB Notification: Performance of [SIM] Partitioning: time 0.001215/0.03991, allocations: 1.52 MB / 0.6345 GB, free: 15.03 MB / 446.1 MB Notification: Performance of [SIM] Causalize: time 0.003152/0.04306, allocations: 2.79 MB / 0.6372 GB, free: 14.28 MB / 446.1 MB Notification: Performance of [SIM] After Index Reduction Inline: time 0.001846/0.04491, allocations: 3.088 MB / 0.6402 GB, free: 12.62 MB / 446.1 MB Notification: Performance of [INI] Simplify: time 0.004316/0.04922, allocations: 2.85 MB / 0.643 GB, free: 11.2 MB / 446.1 MB Notification: Performance of [INI] Inline: time 0.006036/0.05526, allocations: 7.052 MB / 0.6499 GB, free: 7.445 MB / 446.1 MB Notification: Performance of [INI] Partitioning: time 0.0002388/0.0555, allocations: 97.16 kB / 0.65 GB, free: 7.367 MB / 446.1 MB Notification: Performance of [INI] Cleanup: time 0.001548/0.05705, allocations: 1.344 MB / 0.6513 GB, free: 6.602 MB / 446.1 MB Notification: Performance of [INI] Causalize: time 0.02779/0.08484, allocations: 18.83 MB / 0.6697 GB, free: 11.34 MB / 462.1 MB Notification: Performance of [INI] Tearing: time 0.003426/0.08826, allocations: 2.822 MB / 0.6724 GB, free: 8.586 MB / 462.1 MB Notification: Performance of [SIM] Initialization: time 2.505e-06/0.08826, allocations: 0 / 0.6724 GB, free: 8.586 MB / 462.1 MB Notification: Performance of [SIM] DAE-Mode: time 0.00251/0.09077, allocations: 1.768 MB / 0.6742 GB, free: 6.836 MB / 462.1 MB Notification: Performance of [SIM] Remove Dummies: time 1.064e-05/0.09078, allocations: 4.656 kB / 0.6742 GB, free: 6.832 MB / 462.1 MB Notification: Performance of [SIM] Tearing: time 0.0009725/0.09176, allocations: 0.8445 MB / 0.675 GB, free: 6 MB / 462.1 MB Notification: Performance of [SIM] Categorize: time 2.328e-05/0.09178, allocations: 7.984 kB / 0.675 GB, free: 5.992 MB / 462.1 MB Notification: Performance of [SIM] Solve: time 0.008876/0.1007, allocations: 5.969 MB / 0.6808 GB, free: 44 kB / 462.1 MB Error: Internal error NBJacobian.SparsityColoring.PartialD2ColoringAlgC.getIndices failed because cref aVRTypeIchange1_1.vref0 is neither a seed nor a partial candidate! " [Timeout remaining time 660] [Calling sys.exit(0), Time elapsed: 3.166292448004242] Failed to read output from testmodel.py, exit status != 0: 0.10936164698796347 0.12410364400000001 0.098310957 Calling exit ...