Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr OpenIPSL_2.0.0_OpenIPSL.Examples.PSATSystems.TwoAreaOld.FifthOrder_AVRI.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.1017/0.1017, 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.001448/0.001448, allocations: 120.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.524/1.524, allocations: 207.7 MB / 251.7 MB, free: 7.215 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.001959/0.001959, allocations: 208.4 kB / 307 MB, free: 248 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.3329/0.3329, allocations: 79.74 MB / 441.8 MB, free: 12.23 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_AVRI,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_2.0.0_OpenIPSL.Examples.PSATSystems.TwoAreaOld.FifthOrder_AVRI") translateModel(OpenIPSL.Examples.PSATSystems.TwoAreaOld.FifthOrder_AVRI,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_2.0.0_OpenIPSL.Examples.PSATSystems.TwoAreaOld.FifthOrder_AVRI") [Timeout 660] "Notification: Performance of FrontEnd - Absyn->SCode: time 2.986e-05/2.986e-05, allocations: 2.281 kB / 0.5887 GB, free: 7.031 MB / 398.1 MB Notification: Performance of NFInst.instantiate(OpenIPSL.Examples.PSATSystems.TwoAreaOld.FifthOrder_AVRI): time 0.008067/0.008097, allocations: 5.781 MB / 0.5944 GB, free: 1.215 MB / 398.1 MB Notification: Performance of NFInst.instExpressions: time 0.004813/0.01291, allocations: 1.921 MB / 0.5963 GB, free: 15.29 MB / 414.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.0007515/0.01366, allocations: 8 kB / 0.5963 GB, free: 15.28 MB / 414.1 MB Notification: Performance of NFTyping.typeComponents: time 0.0007781/0.01444, allocations: 242 kB / 0.5965 GB, free: 15.04 MB / 414.1 MB Notification: Performance of NFTyping.typeBindings: time 0.002266/0.01671, allocations: 0.846 MB / 0.5973 GB, free: 14.2 MB / 414.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.001519/0.01822, allocations: 0.6544 MB / 0.598 GB, free: 13.55 MB / 414.1 MB Notification: Performance of NFFlatten.flatten: time 0.002255/0.02048, allocations: 1.952 MB / 0.5999 GB, free: 11.59 MB / 414.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.0004098/0.02089, allocations: 191.1 kB / 0.6 GB, free: 11.39 MB / 414.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.000927/0.02182, allocations: 0.7509 MB / 0.6008 GB, free: 10.64 MB / 414.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.0008623/0.02268, allocations: 0.7658 MB / 0.6015 GB, free: 9.867 MB / 414.1 MB Notification: Performance of NFPackage.collectConstants: time 0.0001731/0.02285, allocations: 116 kB / 0.6016 GB, free: 9.754 MB / 414.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.0005187/0.02337, allocations: 255.8 kB / 0.6019 GB, free: 9.504 MB / 414.1 MB Notification: Performance of combineBinaries: time 0.002583/0.02595, allocations: 3.165 MB / 0.605 GB, free: 6.309 MB / 414.1 MB Notification: Performance of replaceArrayConstructors: time 0.001496/0.02745, allocations: 1.901 MB / 0.6068 GB, free: 4.383 MB / 414.1 MB Notification: Performance of NFVerifyModel.verify: time 0.000187/0.02764, allocations: 84 kB / 0.6069 GB, free: 4.301 MB / 414.1 MB Notification: Performance of FrontEnd: time 0.0001744/0.02781, allocations: 39.81 kB / 0.6069 GB, free: 4.262 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: 188 (175) * Number of variables: 188 (186) Notification: Performance of [SIM] Bindings: time 0.006738/0.03455, allocations: 6.808 MB / 0.6136 GB, free: 13.2 MB / 430.1 MB Notification: Performance of [SIM] FunctionAlias: time 0.0009861/0.03553, allocations: 0.7693 MB / 0.6143 GB, free: 12.4 MB / 430.1 MB Notification: Performance of [SIM] Early Inline: time 0.006643/0.04218, allocations: 6.356 MB / 0.6206 GB, free: 6.016 MB / 430.1 MB Notification: Performance of [SIM] Simplify 1: time 0.001556/0.04373, allocations: 0.9139 MB / 0.6214 GB, free: 5.039 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.006963/0.0507, allocations: 4.616 MB / 0.626 GB, free: 15.97 MB / 446.1 MB Notification: Performance of [SIM] Simplify 2: time 0.001652/0.05235, allocations: 0.8643 MB / 0.6268 GB, free: 15.06 MB / 446.1 MB Notification: Performance of [SIM] Remove Stream: time 0.0004809/0.05283, allocations: 380 kB / 0.6272 GB, free: 14.65 MB / 446.1 MB Notification: Performance of [SIM] Detect States: time 0.001259/0.05409, allocations: 0.9881 MB / 0.6281 GB, free: 13.6 MB / 446.1 MB Notification: Performance of [SIM] Events: time 0.0007091/0.0548, allocations: 414.9 kB / 0.6285 GB, free: 13.2 MB / 446.1 MB Notification: Performance of [SIM] Partitioning: time 0.001995/0.05679, allocations: 1.57 MB / 0.6301 GB, free: 11.59 MB / 446.1 MB Notification: Performance of [SIM] Causalize: time 0.004711/0.0615, allocations: 2.816 MB / 0.6328 GB, free: 8.73 MB / 446.1 MB Notification: Performance of [SIM] After Index Reduction Inline: time 0.003951/0.06545, allocations: 3.181 MB / 0.6359 GB, free: 5.543 MB / 446.1 MB Notification: Performance of [INI] Simplify: time 0.006756/0.07221, allocations: 3.029 MB / 0.6389 GB, free: 2.309 MB / 446.1 MB Notification: Performance of [INI] Inline: time 0.2814/0.3536, allocations: 7.238 MB / 0.6459 GB, free: 43.73 MB / 446.1 MB Notification: Performance of [INI] Partitioning: time 0.0004177/0.354, allocations: 100.1 kB / 0.646 GB, free: 43.66 MB / 446.1 MB Notification: Performance of [INI] Cleanup: time 0.002039/0.356, allocations: 1.39 MB / 0.6474 GB, free: 43.63 MB / 446.1 MB Notification: Performance of [INI] Causalize: time 0.03228/0.3883, allocations: 19.2 MB / 0.6661 GB, free: 39.15 MB / 446.1 MB Notification: Performance of [INI] Tearing: time 0.002633/0.391, allocations: 2.786 MB / 0.6689 GB, free: 38.41 MB / 446.1 MB Notification: Performance of [SIM] Initialization: time 2.114e-06/0.391, allocations: 0 / 0.6689 GB, free: 38.41 MB / 446.1 MB Notification: Performance of [SIM] DAE-Mode: time 0.001964/0.3929, allocations: 1.89 MB / 0.6707 GB, free: 37.75 MB / 446.1 MB Notification: Performance of [SIM] Remove Dummies: time 1.007e-05/0.3929, allocations: 4.469 kB / 0.6707 GB, free: 37.75 MB / 446.1 MB Notification: Performance of [SIM] Tearing: time 0.0006408/0.3936, allocations: 0.8591 MB / 0.6716 GB, free: 37.44 MB / 446.1 MB Notification: Performance of [SIM] Categorize: time 1.878e-05/0.3936, allocations: 9.125 kB / 0.6716 GB, free: 37.44 MB / 446.1 MB Notification: Performance of [SIM] Solve: time 0.007577/0.4012, allocations: 6.78 MB / 0.6782 GB, free: 33.46 MB / 446.1 MB 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.5340902670286596] Failed to read output from testmodel.py, exit status != 0: 0.4098626769846305 0.418177442 0.388264559 Calling exit ...