Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.ESDC1A.conf.json
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/ModelicaServices 4.0.0+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/Complex 4.0.0+maint.om/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 Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.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.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.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-master/package.mo)
Running command: translateModel(OpenIPSL.Tests.Controls.PSSE.ES.ESDC1A,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.ESDC1A")
translateModel(OpenIPSL.Tests.Controls.PSSE.ES.ESDC1A,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.ESDC1A")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0-master/package.mo): time 0.08184/0.08184, allocations: 12.6 MB / 28.9 MB, free: 0.6172 MB / 19.63 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001296/0.001296, allocations: 111.5 kB / 32.5 MB, free: 3.559 MB / 26.18 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.405/1.405, allocations: 205.1 MB / 241.1 MB, free: 12.36 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.002364/0.002364, allocations: 191.5 kB / 291.4 MB, free: 13.38 MB / 238.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/package.mo): time 0.4556/0.4556, allocations: 78.51 MB / 420 MB, free: 11.21 MB / 302.1 MB
Notification: Modelica_Synchronous requested package ModelicaServices of version 3.2.3. ModelicaServices 4.0.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Modelica requested package Complex of version 3.2.3. Complex 4.0.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Modelica requested package ModelicaServices of version 3.2.3. ModelicaServices 4.0.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: OpenIPSL requested package Complex of version 3.2.3. Complex 4.0.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.004092/0.004092, allocations: 139.6 kB / 0.5565 GB, free: 28.4 MB / 398.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1082/0.1123, allocations: 68.14 MB / 0.6231 GB, free: 15.37 MB / 446.1 MB
Notification: Performance of NFInst.instantiate(OpenIPSL.Tests.Controls.PSSE.ES.ESDC1A): time 0.01048/0.1228, allocations: 8.821 MB / 0.6317 GB, free: 6.5 MB / 446.1 MB
Notification: Performance of NFInst.instExpressions: time 0.00605/0.1288, allocations: 2.814 MB / 0.6345 GB, free: 3.676 MB / 446.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001187/0.13, allocations: 15.94 kB / 0.6345 GB, free: 3.66 MB / 446.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.000988/0.131, allocations: 349 kB / 0.6348 GB, free: 3.316 MB / 446.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.003493/0.1345, allocations: 1.302 MB / 0.6361 GB, free: 2.016 MB / 446.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.002084/0.1366, allocations: 0.8606 MB / 0.6369 GB, free: 1.164 MB / 446.1 MB
Notification: Performance of NFFlatten.flatten: time 0.003553/0.1401, allocations: 2.564 MB / 0.6394 GB, free: 14.59 MB / 462.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0006148/0.1407, allocations: 346.1 kB / 0.6397 GB, free: 14.22 MB / 462.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001359/0.1421, allocations: 0.965 MB / 0.6407 GB, free: 13.25 MB / 462.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.00153/0.1436, allocations: 1.217 MB / 0.6419 GB, free: 12.03 MB / 462.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.00037/0.144, allocations: 200 kB / 0.6421 GB, free: 11.84 MB / 462.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0008556/0.1449, allocations: 471.7 kB / 0.6425 GB, free: 11.38 MB / 462.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.0004817/0.1453, allocations: 0.502 MB / 0.643 GB, free: 10.87 MB / 462.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.001027/0.1464, allocations: 0.9906 MB / 0.644 GB, free: 9.875 MB / 462.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.003221/0.1496, allocations: 2.576 MB / 0.6465 GB, free: 7.289 MB / 462.1 MB
Notification: Performance of FrontEnd - DAE generated: time 5.45e-06/0.1496, allocations: 4 kB / 0.6465 GB, free: 7.285 MB / 462.1 MB
Notification: Performance of FrontEnd: time 1.272e-06/0.1496, allocations: 0 / 0.6465 GB, free: 7.285 MB / 462.1 MB
Notification: Performance of Transformations before backend: time 4.829e-05/0.1496, allocations: 4 kB / 0.6465 GB, free: 7.281 MB / 462.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 263
 * Number of variables: 263
Notification: Performance of Generate backend data structure: time 0.01573/0.1654, allocations: 4.111 MB / 0.6505 GB, free: 3.109 MB / 462.1 MB
Notification: Performance of prepare preOptimizeDAE: time 4.001e-05/0.1654, allocations: 15.98 kB / 0.6505 GB, free: 3.094 MB / 462.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004985/0.1704, allocations: 0.7754 MB / 0.6513 GB, free: 2.316 MB / 462.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002748/0.1731, allocations: 1.232 MB / 0.6525 GB, free: 1.035 MB / 462.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.000577/0.1737, allocations: 458.5 kB / 0.6529 GB, free: 0.5117 MB / 462.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003076/0.174, allocations: 120 kB / 0.653 GB, free: 404 kB / 462.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003565/0.1776, allocations: 1.523 MB / 0.6545 GB, free: 14.82 MB / 478.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 2.378e-05/0.1776, allocations: 0 / 0.6545 GB, free: 14.82 MB / 478.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001511/0.1778, allocations: 48 kB / 0.6546 GB, free: 14.77 MB / 478.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 2.572e-05/0.1778, allocations: 28 kB / 0.6546 GB, free: 14.75 MB / 478.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003457/0.1813, allocations: 1.413 MB / 0.656 GB, free: 13.32 MB / 478.1 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.01107/0.1923, allocations: 5.407 MB / 0.6613 GB, free: 7.68 MB / 478.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.01027/0.2026, allocations: 2.965 MB / 0.6642 GB, free: 4.574 MB / 478.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002586/0.2052, allocations: 0.8813 MB / 0.665 GB, free: 3.688 MB / 478.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0007173/0.2059, allocations: 0.7258 MB / 0.6657 GB, free: 2.793 MB / 478.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.002794/0.2087, allocations: 1.122 MB / 0.6668 GB, free: 1.648 MB / 478.1 MB
Notification: Performance of pre-optimization done (n=133): time 4.969e-06/0.2087, allocations: 4 kB / 0.6668 GB, free: 1.645 MB / 478.1 MB
Notification: Performance of matching and sorting (n=133): time 0.04423/0.2529, allocations: 9.733 MB / 0.6763 GB, free: 7.875 MB / 494.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 9.539e-05/0.253, allocations: 120.1 kB / 0.6764 GB, free: 7.734 MB / 494.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002647/0.2557, allocations: 1.543 MB / 0.6779 GB, free: 6.184 MB / 494.1 MB
Notification: Performance of collectPreVariables (initialization): time 0.0003031/0.256, allocations: 53.7 kB / 0.678 GB, free: 6.125 MB / 494.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0006095/0.2566, allocations: 0.6563 MB / 0.6786 GB, free: 5.465 MB / 494.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0006448/0.2572, allocations: 0.4996 MB / 0.6791 GB, free: 4.961 MB / 494.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0007298/0.258, allocations: 371.6 kB / 0.6795 GB, free: 4.59 MB / 494.1 MB
Notification: Performance of setup shared object (initialization): time 0.0001383/0.2581, allocations: 305.1 kB / 0.6798 GB, free: 4.289 MB / 494.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002594/0.2607, allocations: 1.046 MB / 0.6808 GB, free: 3.238 MB / 494.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003005/0.2637, allocations: 1.27 MB / 0.682 GB, free: 1.902 MB / 494.1 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.005642/0.2693, allocations: 2.228 MB / 0.6842 GB, free: 15.62 MB / 0.4981 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.135e-06/0.2693, allocations: 0 / 0.6842 GB, free: 15.62 MB / 0.4981 GB
Notification: Performance of matching and sorting (n=261) (initialization): time 0.01088/0.2802, allocations: 3.801 MB / 0.6879 GB, free: 11.8 MB / 0.4981 GB
Notification: Performance of prepare postOptimizeDAE: time 2.78e-05/0.2802, allocations: 8 kB / 0.6879 GB, free: 11.8 MB / 0.4981 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.074e-05/0.2803, allocations: 7.938 kB / 0.6879 GB, free: 11.79 MB / 0.4981 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01062/0.2909, allocations: 2.679 MB / 0.6906 GB, free: 9.102 MB / 0.4981 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001969/0.2929, allocations: 359.5 kB / 0.6909 GB, free: 8.75 MB / 0.4981 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.007208/0.3001, allocations: 2.695 MB / 0.6935 GB, free: 6.023 MB / 0.4981 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002669/0.3027, allocations: 278.6 kB / 0.6938 GB, free: 5.75 MB / 0.4981 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002411/0.303, allocations: 75.97 kB / 0.6939 GB, free: 5.676 MB / 0.4981 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 17
 * Number of states: 0 ()
 * Number of discrete variables: 3 ($whenCondition2,$whenCondition1,eSDC1A.rotatingExciterLimited.sISO.local_reset)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (204):
 * Single equations (assignments): 202
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 1
 * 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): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(30,26)}
Notification: Performance of prepare postOptimizeDAE: time 0.0007584/0.3037, allocations: 326.9 kB / 0.6942 GB, free: 5.348 MB / 0.4981 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0004221/0.3042, allocations: 182.8 kB / 0.6944 GB, free: 5.168 MB / 0.4981 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01845/0.3226, allocations: 4.911 MB / 0.6992 GB, free: 240 kB / 0.4981 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.308e-05/0.3226, allocations: 16 kB / 0.6992 GB, free: 224 kB / 0.4981 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 7.073e-06/0.3226, allocations: 0 / 0.6992 GB, free: 224 kB / 0.4981 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 3.88e-05/0.3227, allocations: 11.97 kB / 0.6992 GB, free: 212 kB / 0.4981 GB
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.02196/0.3446, allocations: 7.081 MB / 0.7061 GB, free: 8.996 MB / 0.5137 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.609e-05/0.3447, allocations: 3.938 kB / 0.7061 GB, free: 8.992 MB / 0.5137 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001162/0.3458, allocations: 167.8 kB / 0.7063 GB, free: 8.828 MB / 0.5137 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.008298/0.3541, allocations: 2.138 MB / 0.7083 GB, free: 6.688 MB / 0.5137 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0002849/0.3544, allocations: 28 kB / 0.7084 GB, free: 6.66 MB / 0.5137 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.2773/0.6317, allocations: 10.06 MB / 0.7182 GB, free: 82.09 MB / 0.5137 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.457e-06/0.6318, allocations: 4.438 kB / 0.7182 GB, free: 82.09 MB / 0.5137 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.02084/0.6526, allocations: 6.092 MB / 0.7242 GB, free: 81.09 MB / 0.5137 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0005626/0.6532, allocations: 300.8 kB / 0.7244 GB, free: 80.91 MB / 0.5137 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0004356/0.6536, allocations: 31.12 kB / 0.7245 GB, free: 80.89 MB / 0.5137 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001866/0.6555, allocations: 143.5 kB / 0.7246 GB, free: 80.88 MB / 0.5137 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0009543/0.6564, allocations: 271.3 kB / 0.7249 GB, free: 80.81 MB / 0.5137 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001411/0.6566, allocations: 39.91 kB / 0.7249 GB, free: 80.8 MB / 0.5137 GB
Notification: Performance of sorting global known variables: time 0.00179/0.6583, allocations: 1.032 MB / 0.7259 GB, free: 80.41 MB / 0.5137 GB
Notification: Performance of sort global known variables: time 9e-08/0.6583, allocations: 0 / 0.7259 GB, free: 80.41 MB / 0.5137 GB
Notification: Performance of remove unused functions: time 0.00179/0.6601, allocations: 0.5648 MB / 0.7265 GB, free: 80.34 MB / 0.5137 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 3
 * Number of states: 14 (gENCLS.omega,gENCLS.delta,gENCLS.eq,gENROE.w,gENROE.delta,gENROE.Epd,gENROE.Epq,gENROE.PSIkd,gENROE.PSIkq,eSDC1A.imDerivativeLag.x,eSDC1A.imLeadLag.TF.x_scaled[1],eSDC1A.simpleLagLim.state,eSDC1A.rotatingExciterLimited.sISO.y,eSDC1A.TransducerDelay.state)
 * Number of discrete variables: 2 ($whenCondition1,$whenCondition2)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (90):
 * Single equations (assignments): 89
 * 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): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(26,23)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.0004711/0.6606, allocations: 178.7 kB / 0.7266 GB, free: 80.22 MB / 0.5137 GB
Notification: Performance of simCode: created initialization part: time 0.00972/0.6703, allocations: 2.861 MB / 0.7294 GB, free: 79.43 MB / 0.5137 GB
Notification: Performance of simCode: created event and clocks part: time 5.23e-06/0.6703, allocations: 3.781 kB / 0.7294 GB, free: 79.43 MB / 0.5137 GB
Notification: Performance of simCode: created simulation system equations: time 0.006577/0.6769, allocations: 1.91 MB / 0.7313 GB, free: 78.8 MB / 0.5137 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001455/0.6784, allocations: 153 kB / 0.7314 GB, free: 78.71 MB / 0.5137 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.006598/0.685, allocations: 3.379 MB / 0.7347 GB, free: 76.92 MB / 0.5137 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0007478/0.6857, allocations: 1.277 MB / 0.736 GB, free: 76.18 MB / 0.5137 GB
Notification: Performance of simCode: alias equations: time 0.0006815/0.6864, allocations: 160.8 kB / 0.7361 GB, free: 76.15 MB / 0.5137 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0004875/0.6869, allocations: 107.2 kB / 0.7362 GB, free: 76.13 MB / 0.5137 GB
Notification: Performance of SimCode: time 7.52e-07/0.6869, allocations: 0 / 0.7362 GB, free: 76.13 MB / 0.5137 GB
Notification: Performance of Templates: time 0.04126/0.7281, allocations: 31.97 MB / 0.7675 GB, free: 51.22 MB / 0.5137 GB
make -j1 -f OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.ESDC1A.makefile
(rm -f OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.ESDC1A.pipe ; mkfifo OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.ESDC1A.pipe ; head -c 1048576 < OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.ESDC1A.pipe >> ../files/OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.ESDC1A.sim & ./OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.ESDC1A  -abortSlowSimulation -alarm=480 -s gbode -lv LOG_STATS > OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.ESDC1A.pipe 2>&1)