Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr OpenIPSL_2.0.0_OpenIPSL.Examples.PSATSystems.Discretization.FourthOrder_AVRII_Discrete.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0-master/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/package.mo", uses=false)
Using package OpenIPSL with version 2.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/package.mo)
Using package Modelica_Synchronous with version 0.93.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0-master/package.mo)
Using package ModelicaServices with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+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 Complex with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo)
Running command: translateModel(OpenIPSL.Examples.PSATSystems.Discretization.FourthOrder_AVRII_Discrete,tolerance=0.001,outputFormat="empty",numberOfIntervals=4000,variableFilter="",fileNamePrefix="OpenIPSL_2.0.0_OpenIPSL.Examples.PSATSystems.Discretization.FourthOrder_AVRII_Discrete")
translateModel(OpenIPSL.Examples.PSATSystems.Discretization.FourthOrder_AVRII_Discrete,tolerance=0.001,outputFormat="empty",numberOfIntervals=4000,variableFilter="",fileNamePrefix="OpenIPSL_2.0.0_OpenIPSL.Examples.PSATSystems.Discretization.FourthOrder_AVRII_Discrete")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.001285/0.001285, allocations: 183 kB / 15.98 MB, free: 5.762 MB / 13.93 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.418/1.418, allocations: 205.1 MB / 221.8 MB, free: 8.48 MB / 186.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.001021/0.001021, allocations: 106.3 kB / 269.2 MB, free: 8.43 MB / 218.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0-master/package.mo): time 0.06937/0.06937, allocations: 12.6 MB / 329.1 MB, free: 12.39 MB / 282.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/package.mo): time 0.2918/0.2918, allocations: 78.52 MB / 457.8 MB, free: 13.72 MB / 314.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.001808/0.001808, allocations: 105.8 kB / 0.5254 GB, free: 19.7 MB / 330.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1546/0.1564, allocations: 68.14 MB / 0.592 GB, free: 15.63 MB / 394.7 MB
Notification: Performance of NFInst.instantiate(OpenIPSL.Examples.PSATSystems.Discretization.FourthOrder_AVRII_Discrete): time 0.007913/0.1644, allocations: 6.549 MB / 0.5984 GB, free: 9.039 MB / 394.7 MB
Notification: Performance of NFInst.instExpressions: time 0.004514/0.1689, allocations: 1.858 MB / 0.6002 GB, free: 7.176 MB / 394.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001474/0.1704, allocations: 12 kB / 0.6002 GB, free: 7.164 MB / 394.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.0008954/0.1714, allocations: 162.9 kB / 0.6004 GB, free: 7.004 MB / 394.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.002778/0.1742, allocations: 0.6778 MB / 0.601 GB, free: 6.332 MB / 394.7 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.001621/0.1758, allocations: 0.5531 MB / 0.6016 GB, free: 5.785 MB / 394.7 MB
Notification: Performance of NFFlatten.flatten: time 0.00265/0.1785, allocations: 1.331 MB / 0.6029 GB, free: 4.449 MB / 394.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0006665/0.1792, allocations: 252.9 kB / 0.6031 GB, free: 4.191 MB / 394.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001278/0.1805, allocations: 0.5365 MB / 0.6036 GB, free: 3.652 MB / 394.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.001154/0.1816, allocations: 0.7193 MB / 0.6043 GB, free: 2.93 MB / 394.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0003477/0.182, allocations: 68 kB / 0.6044 GB, free: 2.863 MB / 394.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0007187/0.1827, allocations: 199.8 kB / 0.6046 GB, free: 2.668 MB / 394.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.000344/0.1831, allocations: 246.8 kB / 0.6048 GB, free: 2.426 MB / 394.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.0007751/0.1839, allocations: 0.5745 MB / 0.6054 GB, free: 1.848 MB / 394.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.001776/0.1857, allocations: 1.44 MB / 0.6068 GB, free: 412 kB / 394.7 MB
Notification: Performance of FrontEnd - DAE generated: time 6.913e-06/0.1857, allocations: 0 / 0.6068 GB, free: 412 kB / 394.7 MB
Notification: Performance of FrontEnd: time 1.242e-06/0.1857, allocations: 0 / 0.6068 GB, free: 412 kB / 394.7 MB
Notification: Performance of Transformations before backend: time 7.89e-05/0.1858, allocations: 0 / 0.6068 GB, free: 412 kB / 394.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 178
 * Number of variables: 178
Notification: Performance of Generate backend data structure: time 0.009168/0.195, allocations: 2.489 MB / 0.6092 GB, free: 13.86 MB / 410.7 MB
Notification: Performance of prepare preOptimizeDAE: time 4.626e-05/0.195, allocations: 11.98 kB / 0.6092 GB, free: 13.84 MB / 410.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004969/0.2, allocations: 0.7594 MB / 0.61 GB, free: 13.08 MB / 410.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001924/0.2019, allocations: 0.793 MB / 0.6107 GB, free: 12.23 MB / 410.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003675/0.2023, allocations: 260.2 kB / 0.611 GB, free: 11.95 MB / 410.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003025/0.2027, allocations: 75.91 kB / 0.6111 GB, free: 11.87 MB / 410.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002727/0.2054, allocations: 1.174 MB / 0.6122 GB, free: 10.67 MB / 410.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 2.686e-05/0.2055, allocations: 3.938 kB / 0.6122 GB, free: 10.66 MB / 410.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001055/0.2056, allocations: 32 kB / 0.6122 GB, free: 10.63 MB / 410.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.6e-05/0.2056, allocations: 16 kB / 0.6123 GB, free: 10.62 MB / 410.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002099/0.2077, allocations: 0.9536 MB / 0.6132 GB, free: 9.664 MB / 410.7 MB
Warning: The model contains alias variables with redundant start and/or conflicting nominal values. It is recommended to resolve the conflicts, because otherwise the system could be hard to solve. To print the conflicting alias sets and the chosen candidates please use -d=aliasConflicts.
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.006656/0.2144, allocations: 3.546 MB / 0.6167 GB, free: 5.934 MB / 410.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.007452/0.2219, allocations: 2.311 MB / 0.6189 GB, free: 3.527 MB / 410.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001516/0.2234, allocations: 0.6556 MB / 0.6196 GB, free: 2.867 MB / 410.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001439/0.2236, allocations: 20.62 kB / 0.6196 GB, free: 2.848 MB / 410.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.339e-05/0.2236, allocations: 43.22 kB / 0.6196 GB, free: 2.797 MB / 410.7 MB
Notification: Performance of pre-optimization done (n=92): time 3.246e-06/0.2236, allocations: 3.938 kB / 0.6196 GB, free: 2.793 MB / 410.7 MB
Notification: Performance of matching and sorting (n=92): time 0.02791/0.2516, allocations: 6.733 MB / 0.6262 GB, free: 12 MB / 426.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.00013/0.2517, allocations: 105.6 kB / 0.6263 GB, free: 11.88 MB / 426.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001722/0.2535, allocations: 0.9618 MB / 0.6272 GB, free: 10.9 MB / 426.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0002625/0.2538, allocations: 45.7 kB / 0.6273 GB, free: 10.85 MB / 426.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.000416/0.2542, allocations: 464.8 kB / 0.6277 GB, free: 10.39 MB / 426.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0005507/0.2547, allocations: 315.6 kB / 0.628 GB, free: 10.07 MB / 426.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0007353/0.2555, allocations: 259.4 kB / 0.6283 GB, free: 9.816 MB / 426.7 MB
Notification: Performance of setup shared object (initialization): time 0.0001105/0.2556, allocations: 305.1 kB / 0.6286 GB, free: 9.516 MB / 426.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001579/0.2572, allocations: 0.6988 MB / 0.6292 GB, free: 8.816 MB / 426.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002009/0.2592, allocations: 0.9147 MB / 0.6301 GB, free: 7.832 MB / 426.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.02246/0.2817, allocations: 5.063 MB / 0.6351 GB, free: 2.691 MB / 426.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.823e-05/0.2818, allocations: 0 / 0.6351 GB, free: 2.691 MB / 426.7 MB
Notification: Performance of matching and sorting (n=181) (initialization): time 0.2476/0.5294, allocations: 4.145 MB / 0.6391 GB, free: 49.67 MB / 426.7 MB
Notification: Performance of prepare postOptimizeDAE: time 3.596e-05/0.5294, allocations: 6.062 kB / 0.6391 GB, free: 49.67 MB / 426.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.063e-05/0.5295, allocations: 6.5 kB / 0.6391 GB, free: 49.67 MB / 426.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.006011/0.5355, allocations: 1.505 MB / 0.6406 GB, free: 49.66 MB / 426.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00133/0.5369, allocations: 261.2 kB / 0.6409 GB, free: 49.66 MB / 426.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01903/0.5559, allocations: 7.617 MB / 0.6483 GB, free: 46.57 MB / 426.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001631/0.5576, allocations: 178 kB / 0.6485 GB, free: 46.54 MB / 426.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001742/0.5578, allocations: 54.45 kB / 0.6485 GB, free: 46.53 MB / 426.7 MB
Warning: Assuming fixed start value for the following 4 variables:
         order4.w:VARIABLE(flow=false start = 1.0 fixed = true )  "Rotor speed [pu]" type: Real
         order2.delta:VARIABLE(flow=false start = order2.delta0 unit = "rad" fixed = true )  "Rotor angle" type: Real
         order4.delta:VARIABLE(flow=false start = order4.delta0 unit = "rad" fixed = true )  "Rotor angle" type: Real
         order4.e1q:VARIABLE(start = order4.e1q0 unit = "1" fixed = true )  "q-axis transient voltage" type: Real
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 23
 * Number of states: 0 ()
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 4 (aVRTypeII.vf,aVRTypeII.vr2,aVRTypeII.vr1,aVRTypeII.vm)
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (151):
 * Single equations (assignments): 150
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 1 system
   {(18,13,25.9%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.000557/0.5583, allocations: 263.9 kB / 0.6488 GB, free: 46.32 MB / 426.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0009906/0.5593, allocations: 342.1 kB / 0.6491 GB, free: 46.21 MB / 426.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0126/0.5719, allocations: 3.58 MB / 0.6526 GB, free: 45.39 MB / 426.7 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.501e-05/0.572, allocations: 9.781 kB / 0.6526 GB, free: 45.39 MB / 426.7 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.838e-05/0.572, allocations: 6.656 kB / 0.6526 GB, free: 45.39 MB / 426.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 2.644e-05/0.5721, allocations: 8.812 kB / 0.6526 GB, free: 45.39 MB / 426.7 MB
Warning: The model contains alias variables with redundant start and/or conflicting nominal values. It is recommended to resolve the conflicts, because otherwise the system could be hard to solve. To print the conflicting alias sets and the chosen candidates please use -d=aliasConflicts.
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01608/0.5882, allocations: 5.137 MB / 0.6576 GB, free: 43.3 MB / 426.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.196e-05/0.5882, allocations: 5.312 kB / 0.6576 GB, free: 43.3 MB / 426.7 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0006851/0.5889, allocations: 109.1 kB / 0.6577 GB, free: 43.28 MB / 426.7 MB
Notification: Performance of postOpt tearingSystem (simulation): time 0.005654/0.5946, allocations: 1.58 MB / 0.6593 GB, free: 42.57 MB / 426.7 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001854/0.5948, allocations: 18.06 kB / 0.6593 GB, free: 42.56 MB / 426.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01647/0.6113, allocations: 9.891 MB / 0.669 GB, free: 35.15 MB / 426.7 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.216e-06/0.6113, allocations: 0 / 0.669 GB, free: 35.15 MB / 426.7 MB
[/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork@2/OpenModelica/OMCompiler/Compiler/BackEnd/Differentiate.mo:267:5-267:157:writable] Error: Derivative of expression "aVRTypeII.vf = previous(aVRTypeII.vf) + (aVRTypeII.vr - aVRTypeII.vf * (aVRTypeII.Ke + aVRTypeII.Se)) / aVRTypeII.Te" w.r.t. "dummyVarA" is non-existent.
Error: Internal error SymbolicJacobian.deriveAll failed
[/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork@2/OpenModelica/OMCompiler/Compiler/BackEnd/SymbolicJacobian.mo:2440:7-2440:87:writable] Error: Internal error function generateSymbolicJacobian failed
[/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork@2/OpenModelica/OMCompiler/Compiler/BackEnd/SymbolicJacobian.mo:2231:9-2231:79:writable] Error: Internal error function createJacobian failed
Notification: Performance of <failed> postOpt symbolicJacobian (simulation): time 0.02916/0.6405, allocations: 9.265 MB / 0.678 GB, free: 27.37 MB / 426.7 MB
Error: post-optimization module symbolicJacobian (simulation) failed.