Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr OpenIPSL_2.0.0_OpenIPSL.Examples.PSATSystems.TwoAreaOld.FourthOrder_AVRII.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.09949/0.09949, allocations: 12.36 MB / 32.03 MB, free: 6.406 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.001401/0.001401, allocations: 109 kB / 38.06 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.52/1.52, allocations: 207.7 MB / 251.7 MB, free: 7.23 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.001893/0.001893, allocations: 224.4 kB / 307 MB, free: 252 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.3209/0.3209, allocations: 79.73 MB / 441.8 MB, free: 12.25 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.FourthOrder_AVRII,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_2.0.0_OpenIPSL.Examples.PSATSystems.TwoAreaOld.FourthOrder_AVRII") translateModel(OpenIPSL.Examples.PSATSystems.TwoAreaOld.FourthOrder_AVRII,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_2.0.0_OpenIPSL.Examples.PSATSystems.TwoAreaOld.FourthOrder_AVRII") [Timeout 660] "Notification: Performance of FrontEnd - Absyn->SCode: time 2.396e-05/2.396e-05, allocations: 2.281 kB / 0.5887 GB, free: 7.027 MB / 398.1 MB Notification: Performance of NFInst.instantiate(OpenIPSL.Examples.PSATSystems.TwoAreaOld.FourthOrder_AVRII): time 0.007854/0.007877, allocations: 5.817 MB / 0.5944 GB, free: 1.176 MB / 398.1 MB Notification: Performance of NFInst.instExpressions: time 0.004217/0.01209, allocations: 1.866 MB / 0.5962 GB, free: 15.3 MB / 414.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.0004457/0.01254, allocations: 8 kB / 0.5962 GB, free: 15.29 MB / 414.1 MB Notification: Performance of NFTyping.typeComponents: time 0.0007414/0.01328, allocations: 249.9 kB / 0.5965 GB, free: 15.05 MB / 414.1 MB Notification: Performance of NFTyping.typeBindings: time 0.002007/0.01529, allocations: 0.8312 MB / 0.5973 GB, free: 14.21 MB / 414.1 MB [/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/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.001307/0.01659, allocations: 0.6307 MB / 0.5979 GB, free: 13.59 MB / 414.1 MB Notification: Performance of NFFlatten.flatten: time 0.001952/0.01855, allocations: 1.924 MB / 0.5998 GB, free: 11.66 MB / 414.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.0004044/0.01895, allocations: 199.3 kB / 0.6 GB, free: 11.46 MB / 414.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.0008567/0.01981, allocations: 0.7431 MB / 0.6007 GB, free: 10.71 MB / 414.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.0008358/0.02064, allocations: 0.7501 MB / 0.6014 GB, free: 9.957 MB / 414.1 MB Notification: Performance of NFPackage.collectConstants: time 0.000174/0.02082, allocations: 108 kB / 0.6015 GB, free: 9.852 MB / 414.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.0004786/0.0213, allocations: 251.9 kB / 0.6018 GB, free: 9.605 MB / 414.1 MB Notification: Performance of combineBinaries: time 0.002621/0.02392, allocations: 3.118 MB / 0.6048 GB, free: 6.457 MB / 414.1 MB Notification: Performance of replaceArrayConstructors: time 0.001474/0.02539, allocations: 1.905 MB / 0.6067 GB, free: 4.527 MB / 414.1 MB Notification: Performance of NFVerifyModel.verify: time 0.000193/0.02558, allocations: 88 kB / 0.6068 GB, free: 4.441 MB / 414.1 MB Notification: Performance of FrontEnd: time 0.000177/0.02576, allocations: 43.75 kB / 0.6068 GB, free: 4.398 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: 190 (178) * Number of variables: 190 (190) Notification: Performance of [SIM] Bindings: time 0.006335/0.0321, allocations: 6.751 MB / 0.6134 GB, free: 13.39 MB / 430.1 MB Notification: Performance of [SIM] FunctionAlias: time 0.00094/0.03304, allocations: 0.7576 MB / 0.6141 GB, free: 12.61 MB / 430.1 MB Notification: Performance of [SIM] Early Inline: time 0.006428/0.03946, allocations: 6.313 MB / 0.6203 GB, free: 6.258 MB / 430.1 MB Notification: Performance of [SIM] Simplify 1: time 0.001368/0.04083, allocations: 0.8741 MB / 0.6212 GB, free: 5.316 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.006401/0.04723, allocations: 4.649 MB / 0.6257 GB, free: 224 kB / 430.1 MB Notification: Performance of [SIM] Simplify 2: time 0.001113/0.04835, allocations: 0.7919 MB / 0.6265 GB, free: 15.36 MB / 446.1 MB Notification: Performance of [SIM] Remove Stream: time 0.000408/0.04875, allocations: 376 kB / 0.6268 GB, free: 14.95 MB / 446.1 MB Notification: Performance of [SIM] Detect States: time 0.001032/0.04979, allocations: 0.977 MB / 0.6278 GB, free: 13.91 MB / 446.1 MB Notification: Performance of [SIM] Events: time 0.0006017/0.05039, allocations: 433.6 kB / 0.6282 GB, free: 13.49 MB / 446.1 MB Notification: Performance of [SIM] Partitioning: time 0.001703/0.05209, allocations: 1.543 MB / 0.6297 GB, free: 11.93 MB / 446.1 MB Notification: Performance of [SIM] Causalize: time 0.004012/0.0561, allocations: 2.819 MB / 0.6325 GB, free: 9.074 MB / 446.1 MB Notification: Performance of [SIM] After Index Reduction Inline: time 0.003127/0.05923, allocations: 3.165 MB / 0.6355 GB, free: 5.902 MB / 446.1 MB Notification: Performance of [INI] Simplify: time 0.005247/0.06448, allocations: 2.936 MB / 0.6384 GB, free: 2.75 MB / 446.1 MB Notification: Performance of [INI] Inline: time 0.297/0.3614, allocations: 7.152 MB / 0.6454 GB, free: 43.68 MB / 446.1 MB Notification: Performance of [INI] Partitioning: time 0.0004041/0.3618, allocations: 100.7 kB / 0.6455 GB, free: 43.61 MB / 446.1 MB Notification: Performance of [INI] Cleanup: time 0.001022/0.3629, allocations: 0.9376 MB / 0.6464 GB, free: 43.61 MB / 446.1 MB Notification: Performance of [INI] Causalize: time 0.0144/0.3773, allocations: 9.621 MB / 0.6558 GB, free: 41.98 MB / 446.1 MB Notification: Performance of [INI] Tearing: time 0.00176/0.379, allocations: 1.42 MB / 0.6572 GB, free: 41.76 MB / 446.1 MB Notification: Performance of [SIM] Initialization: time 2.245e-06/0.379, allocations: 0 / 0.6572 GB, free: 41.76 MB / 446.1 MB Notification: Performance of [SIM] DAE-Mode: time 0.002582/0.3816, allocations: 1.834 MB / 0.659 GB, free: 41.15 MB / 446.1 MB Notification: Performance of [SIM] Remove Dummies: time 8.195e-06/0.3816, allocations: 4.641 kB / 0.659 GB, free: 41.14 MB / 446.1 MB Notification: Performance of [SIM] Tearing: time 0.001042/0.3826, allocations: 0.9121 MB / 0.6599 GB, free: 40.84 MB / 446.1 MB Notification: Performance of [SIM] Categorize: time 1.903e-05/0.3827, allocations: 5.609 kB / 0.6599 GB, free: 40.84 MB / 446.1 MB Notification: Performance of [SIM] Solve: time 0.007441/0.3901, allocations: 6.143 MB / 0.6659 GB, free: 38.82 MB / 446.1 MB Error: Internal error NBJacobian.SparsityColoring.PartialD2ColoringAlgC.getIndices failed because cref aVRTypeII.vref0 is neither a seed nor a partial candidate! " [Timeout remaining time 660] [Calling sys.exit(0), Time elapsed: 3.5153727929573506] Failed to read output from testmodel.py, exit status != 0: 0.3987892829463817 0.40760541800000005 0.379792752 Calling exit ...