Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr OpenIPSL_2.0.0_OpenIPSL.Examples.PSATSystems.TwoArea.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.09889/0.09889, allocations: 12.37 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.001463/0.001463, allocations: 112.9 kB / 38.07 MB, free: 1.082 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.511/1.511, allocations: 207.7 MB / 251.7 MB, free: 7.234 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.001593/0.001593, allocations: 224.3 kB / 307 MB, free: 264 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.3136/0.3136, allocations: 79.74 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.TwoArea.FifthOrder_AVRI,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_2.0.0_OpenIPSL.Examples.PSATSystems.TwoArea.FifthOrder_AVRI")
translateModel(OpenIPSL.Examples.PSATSystems.TwoArea.FifthOrder_AVRI,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_2.0.0_OpenIPSL.Examples.PSATSystems.TwoArea.FifthOrder_AVRI") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.198e-05/2.198e-05, allocations: 2.281 kB / 0.5888 GB, free: 6.922 MB / 398.1 MB
Notification: Performance of NFInst.instantiate(OpenIPSL.Examples.PSATSystems.TwoArea.FifthOrder_AVRI): time 0.02002/0.02004, allocations: 18.41 MB / 0.6068 GB, free: 4.43 MB / 414.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01366/0.03371, allocations: 4.78 MB / 0.6115 GB, free: 15.63 MB / 430.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004556/0.03826, allocations: 47.94 kB / 0.6115 GB, free: 15.58 MB / 430.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.003163/0.04143, allocations: 0.8789 MB / 0.6124 GB, free: 14.7 MB / 430.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/Electrical/Branches/PSAT/TwoWindingTransformer.mo:44:3-44:83:writable] Warning: In relation Tr16.m <> 1.0, <> on Real numbers is only allowed inside functions.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/Electrical/Branches/PSAT/TwoWindingTransformer.mo:44:3-44:83:writable] Warning: In relation Tr67.m <> 1.0, <> on Real numbers is only allowed inside functions.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/Electrical/Branches/PSAT/TwoWindingTransformer.mo:44:3-44:83:writable] Warning: In relation Tr78.m <> 1.0, <> on Real numbers is only allowed inside functions.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/Electrical/Branches/PSAT/TwoWindingTransformer.mo:44:3-44:83:writable] Warning: In relation Tr89.m <> 1.0, <> on Real numbers is only allowed inside functions.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/Electrical/Branches/PSAT/TwoWindingTransformer.mo:44:3-44:83:writable] Warning: In relation Tr49.m <> 1.0, <> on Real numbers is only allowed inside functions.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/Electrical/Branches/PSAT/TwoWindingTransformer.mo:44:3-44:83:writable] Warning: In relation Tr528.m <> 1.0, <> on Real numbers is only allowed inside functions.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/Electrical/Branches/PSAT/TwoWindingTransformer.mo:44:3-44:83:writable] Warning: In relation Tr2829.m <> 1.0, <> on Real numbers is only allowed inside functions.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/Electrical/Branches/PSAT/TwoWindingTransformer.mo:44:3-44:83:writable] Warning: In relation Tr2930.m <> 1.0, <> on Real numbers is only allowed inside functions.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/Electrical/Branches/PSAT/TwoWindingTransformer.mo:44:3-44:83:writable] Warning: In relation Tr3031.m <> 1.0, <> on Real numbers is only allowed inside functions.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/Electrical/Branches/PSAT/TwoWindingTransformer.mo:44:3-44:83:writable] Warning: In relation Tr231.m <> 1.0, <> on Real numbers is only allowed inside functions.
Notification: Performance of NFTyping.typeBindings: time 0.009098/0.05052, allocations: 2.274 MB / 0.6146 GB, free: 12.41 MB / 430.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.006194/0.05672, allocations: 2.091 MB / 0.6167 GB, free: 10.36 MB / 430.1 MB
Notification: Performance of NFFlatten.flatten: time 0.0116/0.06831, allocations: 6.926 MB / 0.6234 GB, free: 3.406 MB / 430.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.003262/0.07158, allocations: 0.7484 MB / 0.6242 GB, free: 2.602 MB / 430.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.005369/0.07695, allocations: 2.61 MB / 0.6267 GB, free: 15.98 MB / 446.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.004783/0.08173, allocations: 2.696 MB / 0.6293 GB, free: 13.27 MB / 446.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.001608/0.08334, allocations: 380 kB / 0.6297 GB, free: 12.9 MB / 446.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.002332/0.08567, allocations: 0.578 MB / 0.6303 GB, free: 12.32 MB / 446.1 MB
Notification: Performance of combineBinaries: time 0.01112/0.09679, allocations: 11.85 MB / 0.6418 GB, free: 352 kB / 446.1 MB
Notification: Performance of replaceArrayConstructors: time 0.2653/0.3621, allocations: 7.585 MB / 0.6492 GB, free: 27.95 MB / 446.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.001978/0.3641, allocations: 361.1 kB / 0.6496 GB, free: 27.95 MB / 446.1 MB
Notification: Performance of FrontEnd: time 0.0008452/0.3649, allocations: 120.7 kB / 0.6497 GB, free: 27.95 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: 891 (846)
 * Number of variables: 891 (889)
Notification: Performance of [SIM] Bindings: time 0.0305/0.3954, allocations: 26.99 MB / 0.6761 GB, free: 15.73 MB / 446.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.00691/0.4023, allocations: 3.611 MB / 0.6796 GB, free: 13.98 MB / 446.1 MB
Notification: Performance of [SIM] Early Inline: time 0.04117/0.4435, allocations: 31.04 MB / 0.7099 GB, free: 10.8 MB / 462.1 MB
Notification: Performance of [SIM] Simplify 1: time 0.008654/0.4521, allocations: 3.672 MB / 0.7135 GB, free: 8.562 MB / 462.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.03176/0.4839, allocations: 20.37 MB / 0.7334 GB, free: 2.871 MB / 478.1 MB
Notification: Performance of [SIM] Simplify 2: time 0.006611/0.4905, allocations: 3.359 MB / 0.7367 GB, free: 15.4 MB / 494.1 MB
Notification: Performance of [SIM] Remove Stream: time 0.002859/0.4934, allocations: 1.575 MB / 0.7382 GB, free: 13.75 MB / 494.1 MB
Notification: Performance of [SIM] Detect States: time 0.00532/0.4987, allocations: 4.173 MB / 0.7423 GB, free: 9.488 MB / 494.1 MB
Notification: Performance of [SIM] Events: time 0.003072/0.5018, allocations: 1.86 MB / 0.7441 GB, free: 7.734 MB / 494.1 MB
Notification: Performance of [SIM] Partitioning: time 0.01111/0.5129, allocations: 7.142 MB / 0.7511 GB, free: 0.5273 MB / 494.1 MB
Notification: Performance of [SIM] Causalize: time 0.02487/0.5377, allocations: 13.69 MB / 0.7644 GB, free: 2.832 MB / 0.4981 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.01816/0.5559, allocations: 14.53 MB / 0.7786 GB, free: 4.336 MB / 0.5137 GB
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/NBackEnd/Classes/NBEquation.mo:623:7-623:72:writable] Warning: In relation Tr16.m <> 1.0, <> on Real numbers is only allowed inside functions.
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/NBackEnd/Classes/NBEquation.mo:623:7-623:72:writable] Warning: In relation Tr67.m <> 1.0, <> on Real numbers is only allowed inside functions.
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/NBackEnd/Classes/NBEquation.mo:623:7-623:72:writable] Warning: In relation Tr78.m <> 1.0, <> on Real numbers is only allowed inside functions.
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/NBackEnd/Classes/NBEquation.mo:623:7-623:72:writable] Warning: In relation Tr89.m <> 1.0, <> on Real numbers is only allowed inside functions.
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/NBackEnd/Classes/NBEquation.mo:623:7-623:72:writable] Warning: In relation Tr49.m <> 1.0, <> on Real numbers is only allowed inside functions.
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/NBackEnd/Classes/NBEquation.mo:623:7-623:72:writable] Warning: In relation Tr528.m <> 1.0, <> on Real numbers is only allowed inside functions.
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/NBackEnd/Classes/NBEquation.mo:623:7-623:72:writable] Warning: In relation Tr2829.m <> 1.0, <> on Real numbers is only allowed inside functions.
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/NBackEnd/Classes/NBEquation.mo:623:7-623:72:writable] Warning: In relation Tr2930.m <> 1.0, <> on Real numbers is only allowed inside functions.
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/NBackEnd/Classes/NBEquation.mo:623:7-623:72:writable] Warning: In relation Tr3031.m <> 1.0, <> on Real numbers is only allowed inside functions.
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/NBackEnd/Classes/NBEquation.mo:623:7-623:72:writable] Warning: In relation Tr231.m <> 1.0, <> on Real numbers is only allowed inside functions.
Notification: Performance of [INI] Simplify: time 0.01913/0.575, allocations: 9.346 MB / 0.7877 GB, free: 10.85 MB / 0.5294 GB
Notification: Performance of [INI] Inline: time 0.03585/0.6109, allocations: 27.73 MB / 0.8148 GB, free: 15.19 MB / 0.5606 GB
Notification: Performance of [INI] Partitioning: time 0.001621/0.6125, allocations: 365.2 kB / 0.8152 GB, free: 14.76 MB / 0.5606 GB
Notification: Performance of [INI] Cleanup: time 0.008876/0.6214, allocations: 5.615 MB / 0.8207 GB, free: 9.137 MB / 0.5606 GB
Notification: Performance of [INI] Causalize: time 0.4845/1.106, allocations: 72.11 MB / 0.8911 GB, free: 157.5 MB / 0.6075 GB
Notification: Performance of [INI] Tearing: time 0.01966/1.126, allocations: 13.37 MB / 0.9041 GB, free: 154.2 MB / 0.6075 GB
Notification: Performance of [SIM] Initialization: time 3.998e-06/1.126, allocations: 3.969 kB / 0.9041 GB, free: 154.2 MB / 0.6075 GB
Notification: Performance of [SIM] DAE-Mode: time 0.01104/1.137, allocations: 8.402 MB / 0.9123 GB, free: 151.7 MB / 0.6075 GB
Notification: Performance of [SIM] Remove Dummies: time 4.524e-05/1.137, allocations: 5.812 kB / 0.9123 GB, free: 151.7 MB / 0.6075 GB
Notification: Performance of [SIM] Tearing: time 0.005248/1.142, allocations: 4.269 MB / 0.9165 GB, free: 150.4 MB / 0.6075 GB
Notification: Performance of [SIM] Categorize: time 8.101e-05/1.142, allocations: 23.47 kB / 0.9165 GB, free: 150.4 MB / 0.6075 GB
Notification: Performance of [SIM] Solve: time 0.03584/1.178, allocations: 25.1 MB / 0.9411 GB, free: 141.1 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: 4.239559621026274]
Failed to read output from testmodel.py, exit status != 0:
1.1938349409610964 1.203598154 0.836339286
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f0577b1afb0>