Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr OpenIPSL_dev_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.001394/0.001394, 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.477/1.477, allocations: 230.6 MB / 253.5 MB, free: 14.44 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.001651/0.001651, allocations: 208.5 kB / 310.1 MB, free: 3.059 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.623/0.623, allocations: 107.2 MB / 473.7 MB, free: 29.7 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.TwoAreaOld.FourthOrder_AVRI,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_dev_OpenIPSL.Examples.PSATSystems.TwoAreaOld.FourthOrder_AVRI") translateModel(OpenIPSL.Examples.PSATSystems.TwoAreaOld.FourthOrder_AVRI,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_dev_OpenIPSL.Examples.PSATSystems.TwoAreaOld.FourthOrder_AVRI") [Timeout 660] "Notification: Performance of FrontEnd - Absyn->SCode: time 1.473e-05/1.473e-05, allocations: 6.219 kB / 0.6343 GB, free: 29.5 MB / 446.1 MB Notification: Performance of NFInst.instantiate(OpenIPSL.Examples.PSATSystems.TwoAreaOld.FourthOrder_AVRI): time 0.005491/0.005506, allocations: 5.694 MB / 0.6399 GB, free: 25.64 MB / 446.1 MB Notification: Performance of NFInst.instExpressions: time 0.003627/0.009133, allocations: 1.95 MB / 0.6418 GB, free: 24.3 MB / 446.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.0005091/0.009642, allocations: 14.62 kB / 0.6418 GB, free: 24.29 MB / 446.1 MB Notification: Performance of NFTyping.typeComponents: time 0.0006299/0.01027, allocations: 241.6 kB / 0.642 GB, free: 24.16 MB / 446.1 MB Notification: Performance of NFTyping.typeBindings: time 0.001894/0.01217, allocations: 0.8467 MB / 0.6429 GB, free: 23.61 MB / 446.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.00132/0.01349, allocations: 0.6378 MB / 0.6435 GB, free: 23.29 MB / 446.1 MB Notification: Performance of NFFlatten.flatten: time 0.001738/0.01522, allocations: 1.906 MB / 0.6453 GB, free: 22.37 MB / 446.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.0003719/0.0156, allocations: 190.8 kB / 0.6455 GB, free: 22.27 MB / 446.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.0007997/0.0164, allocations: 0.7364 MB / 0.6462 GB, free: 21.91 MB / 446.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.0007182/0.01711, allocations: 0.7393 MB / 0.647 GB, free: 21.59 MB / 446.1 MB Notification: Performance of NFPackage.collectConstants: time 0.0001684/0.01728, allocations: 104.4 kB / 0.6471 GB, free: 21.59 MB / 446.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.0005147/0.0178, allocations: 267.2 kB / 0.6473 GB, free: 21.54 MB / 446.1 MB Notification: Performance of combineBinaries: time 0.001809/0.01961, allocations: 3.043 MB / 0.6503 GB, free: 19.5 MB / 446.1 MB Notification: Performance of replaceArrayConstructors: time 0.0007877/0.02039, allocations: 1.865 MB / 0.6521 GB, free: 18.18 MB / 446.1 MB Notification: Performance of NFVerifyModel.verify: time 0.0001852/0.02058, allocations: 83.75 kB / 0.6522 GB, free: 18.18 MB / 446.1 MB Notification: Performance of FrontEnd: time 0.0001487/0.02073, allocations: 36.78 kB / 0.6522 GB, free: 18.18 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.004548/0.02528, allocations: 6.59 MB / 0.6587 GB, free: 13.57 MB / 446.1 MB Notification: Performance of [SIM] FunctionAlias: time 0.0006907/0.02597, allocations: 0.776 MB / 0.6594 GB, free: 12.96 MB / 446.1 MB Notification: Performance of [SIM] Early Inline: time 0.003959/0.02993, allocations: 6.243 MB / 0.6655 GB, free: 7.156 MB / 446.1 MB Notification: Performance of [SIM] Simplify 1: time 0.0009402/0.03087, allocations: 0.834 MB / 0.6663 GB, free: 6.246 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.003943/0.03481, allocations: 4.549 MB / 0.6708 GB, free: 1.262 MB / 446.1 MB Notification: Performance of [SIM] Simplify 2: time 0.0007606/0.03557, allocations: 0.7535 MB / 0.6715 GB, free: 456 kB / 446.1 MB Notification: Performance of [SIM] Remove Stream: time 0.0002485/0.03582, allocations: 367.9 kB / 0.6719 GB, free: 56 kB / 446.1 MB Notification: Performance of [SIM] Detect States: time 0.001055/0.03687, allocations: 0.9527 MB / 0.6728 GB, free: 15.04 MB / 462.1 MB Notification: Performance of [SIM] Events: time 0.0005741/0.03745, allocations: 399 kB / 0.6732 GB, free: 14.64 MB / 462.1 MB Notification: Performance of [SIM] Partitioning: time 0.00182/0.03927, allocations: 1.519 MB / 0.6747 GB, free: 13.09 MB / 462.1 MB Notification: Performance of [SIM] Causalize: time 0.004282/0.04355, allocations: 2.788 MB / 0.6774 GB, free: 10.26 MB / 462.1 MB Notification: Performance of [SIM] After Index Reduction Inline: time 0.003197/0.04675, allocations: 3.083 MB / 0.6804 GB, free: 7.172 MB / 462.1 MB Notification: Performance of [INI] Simplify: time 0.005109/0.05186, allocations: 2.856 MB / 0.6832 GB, free: 4.121 MB / 462.1 MB Notification: Performance of [INI] Inline: time 0.007972/0.05983, allocations: 7.033 MB / 0.69 GB, free: 13.06 MB / 478.1 MB Notification: Performance of [INI] Partitioning: time 0.0003458/0.06017, allocations: 108.7 kB / 0.6902 GB, free: 12.92 MB / 478.1 MB Notification: Performance of [INI] Cleanup: time 0.001633/0.06181, allocations: 1.331 MB / 0.6915 GB, free: 11.57 MB / 478.1 MB Notification: Performance of [INI] Causalize: time 0.03022/0.09203, allocations: 18.82 MB / 0.7098 GB, free: 8.23 MB / 494.1 MB Notification: Performance of [INI] Tearing: time 0.003407/0.09544, allocations: 2.811 MB / 0.7126 GB, free: 5.469 MB / 494.1 MB Notification: Performance of [SIM] Initialization: time 1.693e-06/0.09544, allocations: 0 / 0.7126 GB, free: 5.469 MB / 494.1 MB Notification: Performance of [SIM] DAE-Mode: time 0.002446/0.09788, allocations: 1.765 MB / 0.7143 GB, free: 3.727 MB / 494.1 MB Notification: Performance of [SIM] Remove Dummies: time 8.787e-06/0.09789, allocations: 0.6562 kB / 0.7143 GB, free: 3.727 MB / 494.1 MB Notification: Performance of [SIM] Tearing: time 0.001005/0.0989, allocations: 0.8372 MB / 0.7151 GB, free: 2.902 MB / 494.1 MB Notification: Performance of [SIM] Categorize: time 2.147e-05/0.09892, allocations: 11.98 kB / 0.7151 GB, free: 2.891 MB / 494.1 MB Notification: Performance of [SIM] Solve: time 0.009088/0.108, allocations: 5.959 MB / 0.7209 GB, free: 12.95 MB / 0.4981 GB 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.3305549999931827] Failed to read output from testmodel.py, exit status != 0: 0.11660820100223646 0.132272783 0.10837357700000001 Calling exit ...