Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr OpenIPSL_OpenIPSL.Examples.PSATSystems.TwoArea.FifthOrder_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.001638/0.001638, 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.429/1.429, allocations: 230.7 MB / 253.5 MB, free: 14.27 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.001612/0.001612, allocations: 205.9 kB / 310.1 MB, free: 3.062 MB / 238.1 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.0.1/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.0.1/package.mo): time 0.4701/0.4701, allocations: 79.75 MB / 446.3 MB, free: 40.38 MB / 350.1 MB
"
[Timeout remaining time 179]
Using package OpenIPSL with version 3.0.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.0.1/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.FifthOrder_AVRI,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_OpenIPSL.Examples.PSATSystems.TwoArea.FifthOrder_AVRI")
translateModel(OpenIPSL.Examples.PSATSystems.TwoArea.FifthOrder_AVRI,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_OpenIPSL.Examples.PSATSystems.TwoArea.FifthOrder_AVRI") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 1.928e-05/1.928e-05, allocations: 3.375 kB / 0.5943 GB, free: 38.33 MB / 446.1 MB
Notification: Performance of NFInst.instantiate(OpenIPSL.Examples.PSATSystems.TwoArea.FifthOrder_AVRI): time 0.0157/0.01572, allocations: 18.36 MB / 0.6122 GB, free: 26.92 MB / 446.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01135/0.02706, allocations: 4.858 MB / 0.6169 GB, free: 23.45 MB / 446.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.005065/0.03213, allocations: 47.47 kB / 0.617 GB, free: 23.45 MB / 446.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.003278/0.03541, allocations: 0.8819 MB / 0.6178 GB, free: 22.98 MB / 446.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.0.1/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 3.0.1/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 3.0.1/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 3.0.1/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 3.0.1/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 3.0.1/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 3.0.1/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 3.0.1/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 3.0.1/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 3.0.1/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.008631/0.04404, allocations: 2.283 MB / 0.6201 GB, free: 21.36 MB / 446.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.005986/0.05002, allocations: 2.094 MB / 0.6221 GB, free: 20.28 MB / 446.1 MB
Notification: Performance of NFFlatten.flatten: time 0.008688/0.05871, allocations: 6.926 MB / 0.6289 GB, free: 16.79 MB / 446.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.002364/0.06108, allocations: 0.758 MB / 0.6296 GB, free: 16.37 MB / 446.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.004193/0.06527, allocations: 2.611 MB / 0.6322 GB, free: 15.06 MB / 446.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.004499/0.06977, allocations: 2.696 MB / 0.6348 GB, free: 13.8 MB / 446.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.002147/0.07191, allocations: 376.8 kB / 0.6352 GB, free: 13.8 MB / 446.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.003589/0.0755, allocations: 0.5859 MB / 0.6357 GB, free: 13.76 MB / 446.1 MB
Notification: Performance of combineBinaries: time 0.01227/0.08778, allocations: 11.84 MB / 0.6473 GB, free: 5.711 MB / 446.1 MB
Notification: Performance of replaceArrayConstructors: time 0.006664/0.09444, allocations: 7.59 MB / 0.6547 GB, free: 340 kB / 446.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.002513/0.09695, allocations: 360.2 kB / 0.6551 GB, free: 340 kB / 446.1 MB
Notification: Performance of FrontEnd: time 0.0009609/0.09791, allocations: 122.9 kB / 0.6552 GB, free: 328 kB / 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.03867/0.1366, allocations: 26.98 MB / 0.6815 GB, free: 13.51 MB / 478.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.009384/0.146, allocations: 3.617 MB / 0.6851 GB, free: 10.52 MB / 478.1 MB
Notification: Performance of [SIM] Early Inline: time 0.04389/0.1899, allocations: 31.04 MB / 0.7154 GB, free: 13.33 MB / 0.4981 GB
Notification: Performance of [SIM] Simplify 1: time 0.008115/0.198, allocations: 3.676 MB / 0.719 GB, free: 9.527 MB / 0.4981 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.03152/0.2295, allocations: 20.35 MB / 0.7388 GB, free: 3.41 MB / 0.5137 GB
Notification: Performance of [SIM] Simplify 2: time 0.006409/0.2359, allocations: 3.377 MB / 0.7421 GB, free: 15.88 MB / 0.5294 GB
Notification: Performance of [SIM] Remove Stream: time 0.002873/0.2388, allocations: 1.573 MB / 0.7437 GB, free: 14.21 MB / 0.5294 GB
Notification: Performance of [SIM] Detect States: time 0.005597/0.2444, allocations: 4.167 MB / 0.7477 GB, free: 9.938 MB / 0.5294 GB
Notification: Performance of [SIM] Events: time 0.003361/0.2477, allocations: 1.859 MB / 0.7495 GB, free: 8.059 MB / 0.5294 GB
Notification: Performance of [SIM] Partitioning: time 0.01268/0.2604, allocations: 7.14 MB / 0.7565 GB, free: 0.8281 MB / 0.5294 GB
Notification: Performance of [SIM] Causalize: time 0.02599/0.2864, allocations: 13.67 MB / 0.7699 GB, free: 2.961 MB / 0.545 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.01869/0.3051, allocations: 14.53 MB / 0.7841 GB, free: 4.422 MB / 0.5606 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.02168/0.3268, allocations: 9.353 MB / 0.7932 GB, free: 10.66 MB / 0.5762 GB
Notification: Performance of [INI] Inline: time 0.3006/0.6273, allocations: 27.74 MB / 0.8203 GB, free: 140.7 MB / 0.5919 GB
Notification: Performance of [INI] Partitioning: time 0.00135/0.6287, allocations: 364.1 kB / 0.8206 GB, free: 140.5 MB / 0.5919 GB
Notification: Performance of [INI] Cleanup: time 0.0088/0.6375, allocations: 5.629 MB / 0.8261 GB, free: 140.3 MB / 0.5919 GB
Notification: Performance of [INI] Causalize: time 0.1276/0.7651, allocations: 72.19 MB / 0.8966 GB, free: 113.6 MB / 0.5919 GB
Notification: Performance of [INI] Tearing: time 0.01352/0.7787, allocations: 13.37 MB / 0.9097 GB, free: 102.9 MB / 0.5919 GB
Notification: Performance of [SIM] Initialization: time 2.154e-06/0.7787, allocations: 0 / 0.9097 GB, free: 102.9 MB / 0.5919 GB
Notification: Performance of [SIM] DAE-Mode: time 0.01056/0.7892, allocations: 8.401 MB / 0.9179 GB, free: 95.66 MB / 0.5919 GB
Notification: Performance of [SIM] Remove Dummies: time 5.657e-05/0.7893, allocations: 6.859 kB / 0.9179 GB, free: 95.65 MB / 0.5919 GB
Notification: Performance of [SIM] Tearing: time 0.004707/0.794, allocations: 4.27 MB / 0.9221 GB, free: 91.99 MB / 0.5919 GB
Notification: Performance of [SIM] Categorize: time 5.757e-05/0.794, allocations: 22.81 kB / 0.9221 GB, free: 91.97 MB / 0.5919 GB
Notification: Performance of [SIM] Solve: time 0.03395/0.828, allocations: 25.08 MB / 0.9466 GB, free: 68.71 MB / 0.5919 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.8710615059826523]
Failed to read output from testmodel.py, exit status != 0:
0.8414016569731757 0.850967697 0.750702156
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f79acf4afb0>