Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr OpenIPSL_dev_OpenIPSL.Examples.PSATSystems.TwoArea.ThirdOrder_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.001742/0.001742, allocations: 104.3 kB / 19.76 MB, free: 1.906 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.486/1.486, 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.0016/0.0016, allocations: 211.4 kB / 310.1 MB, free: 3.066 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.6173/0.6173, allocations: 107.2 MB / 473.7 MB, free: 29.84 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.TwoArea.ThirdOrder_AVRI,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_dev_OpenIPSL.Examples.PSATSystems.TwoArea.ThirdOrder_AVRI") translateModel(OpenIPSL.Examples.PSATSystems.TwoArea.ThirdOrder_AVRI,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_dev_OpenIPSL.Examples.PSATSystems.TwoArea.ThirdOrder_AVRI") [Timeout 660] "Notification: Performance of FrontEnd - Absyn->SCode: time 1.651e-05/1.651e-05, allocations: 5.781 kB / 0.6344 GB, free: 29.31 MB / 446.1 MB Notification: Performance of NFInst.instantiate(OpenIPSL.Examples.PSATSystems.TwoArea.ThirdOrder_AVRI): time 0.01492/0.01493, allocations: 18.27 MB / 0.6523 GB, free: 16.96 MB / 446.1 MB Notification: Performance of NFInst.instExpressions: time 0.01162/0.02656, allocations: 4.857 MB / 0.657 GB, free: 13.43 MB / 446.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.004588/0.03115, allocations: 47.34 kB / 0.6571 GB, free: 13.43 MB / 446.1 MB Notification: Performance of NFTyping.typeComponents: time 0.002783/0.03393, allocations: 0.8797 MB / 0.6579 GB, free: 12.74 MB / 446.1 MB Notification: Performance of NFTyping.typeBindings: time 0.008167/0.04209, allocations: 2.274 MB / 0.6601 GB, free: 10.79 MB / 446.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.005605/0.0477, allocations: 2.074 MB / 0.6622 GB, free: 9.297 MB / 446.1 MB Notification: Performance of NFFlatten.flatten: time 0.008453/0.05615, allocations: 6.873 MB / 0.6689 GB, free: 4.012 MB / 446.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.00163/0.05778, allocations: 0.7535 MB / 0.6696 GB, free: 3.203 MB / 446.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.003245/0.06103, allocations: 2.598 MB / 0.6722 GB, free: 0.5938 MB / 446.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.004152/0.06518, allocations: 2.673 MB / 0.6748 GB, free: 13.91 MB / 462.1 MB Notification: Performance of NFPackage.collectConstants: time 0.001581/0.06676, allocations: 375.9 kB / 0.6751 GB, free: 13.54 MB / 462.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.002249/0.06901, allocations: 0.5858 MB / 0.6757 GB, free: 12.95 MB / 462.1 MB Notification: Performance of combineBinaries: time 0.01253/0.08154, allocations: 11.75 MB / 0.6872 GB, free: 1.082 MB / 462.1 MB Notification: Performance of replaceArrayConstructors: time 0.007826/0.08937, allocations: 7.564 MB / 0.6946 GB, free: 9.414 MB / 478.1 MB Notification: Performance of NFVerifyModel.verify: time 0.002063/0.09143, allocations: 356 kB / 0.6949 GB, free: 9.066 MB / 478.1 MB Notification: Performance of FrontEnd: time 0.001066/0.0925, allocations: 119.9 kB / 0.695 GB, free: 8.949 MB / 478.1 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 889 (844) * Number of variables: 889 (887) Notification: Performance of [SIM] Bindings: time 0.03222/0.1247, allocations: 26.99 MB / 0.7214 GB, free: 13.35 MB / 0.4981 GB Notification: Performance of [SIM] FunctionAlias: time 0.00524/0.13, allocations: 3.457 MB / 0.7247 GB, free: 9.84 MB / 0.4981 GB Notification: Performance of [SIM] Early Inline: time 0.04041/0.1704, allocations: 30.92 MB / 0.7549 GB, free: 10.82 MB / 0.5294 GB Notification: Performance of [SIM] Simplify 1: time 0.00727/0.1776, allocations: 3.578 MB / 0.7584 GB, free: 7.086 MB / 0.5294 GB Warning: NBAlias.setStartFixed: Alias set with conflicting unfixed start values detected. Use -d=dumprepl for more information. Notification: Performance of [SIM] Alias: time 0.02991/0.2076, allocations: 20.3 MB / 0.7783 GB, free: 0.9727 MB / 0.545 GB Notification: Performance of [SIM] Simplify 2: time 0.005704/0.2133, allocations: 3.274 MB / 0.7815 GB, free: 13.54 MB / 0.5606 GB Notification: Performance of [SIM] Remove Stream: time 0.002559/0.2158, allocations: 1.565 MB / 0.783 GB, free: 11.89 MB / 0.5606 GB Notification: Performance of [SIM] Detect States: time 0.004925/0.2207, allocations: 4.147 MB / 0.787 GB, free: 7.621 MB / 0.5606 GB Notification: Performance of [SIM] Events: time 0.002975/0.2237, allocations: 1.843 MB / 0.7888 GB, free: 5.758 MB / 0.5606 GB Notification: Performance of [SIM] Partitioning: time 0.009804/0.2335, allocations: 7.097 MB / 0.7958 GB, free: 14.57 MB / 0.5762 GB Notification: Performance of [SIM] Causalize: time 0.02285/0.2564, allocations: 13.64 MB / 0.8091 GB, free: 0.7305 MB / 0.5762 GB Notification: Performance of [SIM] After Index Reduction Inline: time 0.2805/0.5369, allocations: 14.42 MB / 0.8232 GB, free: 116 MB / 0.5762 GB Notification: Performance of [INI] Simplify: time 0.01803/0.5549, allocations: 9.216 MB / 0.8322 GB, free: 113.2 MB / 0.5762 GB Notification: Performance of [INI] Inline: time 0.0246/0.5795, allocations: 27.58 MB / 0.8591 GB, free: 94.86 MB / 0.5762 GB Notification: Performance of [INI] Partitioning: time 0.001186/0.5807, allocations: 356.6 kB / 0.8594 GB, free: 94.63 MB / 0.5762 GB Notification: Performance of [INI] Cleanup: time 0.005473/0.5862, allocations: 5.58 MB / 0.8649 GB, free: 89.94 MB / 0.5762 GB Notification: Performance of [INI] Causalize: time 0.08912/0.6753, allocations: 71.89 MB / 0.9351 GB, free: 25.36 MB / 0.5762 GB Notification: Performance of [INI] Tearing: time 0.01122/0.6865, allocations: 13.25 MB / 0.948 GB, free: 12.44 MB / 0.5762 GB Notification: Performance of [SIM] Initialization: time 2.274e-06/0.6865, allocations: 0 / 0.948 GB, free: 12.44 MB / 0.5762 GB Notification: Performance of [SIM] DAE-Mode: time 0.008225/0.6947, allocations: 8.308 MB / 0.9561 GB, free: 4.25 MB / 0.5762 GB Notification: Performance of [SIM] Remove Dummies: time 2.484e-05/0.6948, allocations: 2.844 kB / 0.9561 GB, free: 4.246 MB / 0.5762 GB Notification: Performance of [SIM] Tearing: time 0.003704/0.6985, allocations: 4.279 MB / 0.9603 GB, free: 60 kB / 0.5762 GB Notification: Performance of [SIM] Categorize: time 3.807e-05/0.6985, allocations: 27.98 kB / 0.9603 GB, free: 32 kB / 0.5762 GB Notification: Performance of [SIM] Solve: time 0.03814/0.7366, allocations: 24.67 MB / 0.9844 GB, free: 7.48 MB / 0.6075 GB Error: Internal error NBJacobian.SparsityColoring.PartialD2ColoringAlgC.getIndices failed because cref aVRTypeI.vref0 is neither a seed nor a partial candidate! " [Timeout remaining time 659] [Calling sys.exit(0), Time elapsed: 3.980521834047977] Failed to read output from testmodel.py, exit status != 0: 0.7501438570325263 0.7645921130000001 0.668956273 Calling exit ...