Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr OpenIPSL_dev_OpenIPSL.Tests.Wind.PSSE.WT4G.WT4G1.conf.json
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/Modelica 4.0.0+maint.om/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/OpenIPSL 3.1.0-master/package.mo", uses=false)
Using package OpenIPSL with version 3.1.0-dev (/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.1.0-master/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 with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/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)
Running command: translateModel(OpenIPSL.Tests.Wind.PSSE.WT4G.WT4G1,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="OpenIPSL_dev_OpenIPSL.Tests.Wind.PSSE.WT4G.WT4G1")
translateModel(OpenIPSL.Tests.Wind.PSSE.WT4G.WT4G1,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="OpenIPSL_dev_OpenIPSL.Tests.Wind.PSSE.WT4G.WT4G1")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.004675/0.004675, allocations: 172 kB / 15.11 MB, free: 5.969 MB / 13.93 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.305/1.305, allocations: 223.2 MB / 239 MB, free: 1.828 MB / 186.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.0008165/0.0008165, allocations: 109.9 kB / 290.2 MB, free: 13.97 MB / 234.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.1.0-master/package.mo): time 0.4975/0.4975, allocations: 79.43 MB / 420.8 MB, free: 43.61 MB / 330.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.000377/0.000377, allocations: 12 kB / 0.489 GB, free: 2.062 MB / 362.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3704/0.3708, allocations: 69.5 MB / 0.5569 GB, free: 38.89 MB / 426.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 0.1268/0.4977, allocations: 100.2 MB / 0.6548 GB, free: 5.434 MB / 458.7 MB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0002518/0.498, allocations: 94.03 kB / 0.6549 GB, free: 5.344 MB / 458.7 MB
Notification: Performance of FrontEnd - DAE generated: time 0.05646/0.5545, allocations: 20.82 MB / 0.6752 GB, free: 464 kB / 474.7 MB
Notification: Performance of FrontEnd: time 2.054e-06/0.5545, allocations: 0 / 0.6752 GB, free: 464 kB / 474.7 MB
Notification: Performance of Transformations before backend: time 5.089e-05/0.5546, allocations: 16 kB / 0.6752 GB, free: 448 kB / 474.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 152
 * Number of variables: 152
Notification: Performance of Generate backend data structure: time 0.00378/0.5583, allocations: 1.492 MB / 0.6767 GB, free: 14.89 MB / 490.7 MB
Notification: Performance of prepare preOptimizeDAE: time 4.585e-05/0.5584, allocations: 12.03 kB / 0.6767 GB, free: 14.88 MB / 490.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.00163/0.56, allocations: 330.4 kB / 0.677 GB, free: 14.56 MB / 490.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001003/0.5611, allocations: 0.6175 MB / 0.6776 GB, free: 13.9 MB / 490.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003386/0.5614, allocations: 336.6 kB / 0.6779 GB, free: 13.52 MB / 490.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001063/0.5615, allocations: 63.95 kB / 0.678 GB, free: 13.45 MB / 490.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001761/0.5633, allocations: 0.954 MB / 0.6789 GB, free: 12.48 MB / 490.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 1.427e-05/0.5633, allocations: 0 / 0.6789 GB, free: 12.48 MB / 490.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 7.676e-05/0.5634, allocations: 24 kB / 0.6789 GB, free: 12.45 MB / 490.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.295e-05/0.5634, allocations: 16 kB / 0.6789 GB, free: 12.44 MB / 490.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001776/0.5652, allocations: 0.8717 MB / 0.6798 GB, free: 11.56 MB / 490.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.006094/0.5713, allocations: 3.091 MB / 0.6828 GB, free: 8.332 MB / 490.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.0074/0.5787, allocations: 2.727 MB / 0.6855 GB, free: 5.512 MB / 490.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001239/0.5789, allocations: 12.55 kB / 0.6855 GB, free: 5.5 MB / 490.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.492e-05/0.5789, allocations: 43.08 kB / 0.6855 GB, free: 5.449 MB / 490.7 MB
Notification: Performance of pre-optimization done (n=71): time 4.058e-06/0.5789, allocations: 3.984 kB / 0.6855 GB, free: 5.445 MB / 490.7 MB
Notification: Performance of matching and sorting (n=71): time 0.02255/0.6015, allocations: 6.845 MB / 0.6922 GB, free: 14.57 MB / 0.4948 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 9.813e-05/0.6016, allocations: 111.4 kB / 0.6923 GB, free: 14.43 MB / 0.4948 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001161/0.6028, allocations: 0.6405 MB / 0.6929 GB, free: 13.78 MB / 0.4948 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001801/0.603, allocations: 33.7 kB / 0.693 GB, free: 13.74 MB / 0.4948 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0003052/0.6033, allocations: 376.7 kB / 0.6933 GB, free: 13.37 MB / 0.4948 GB
Notification: Performance of collectInitialBindings (initialization): time 0.000325/0.6036, allocations: 256.3 kB / 0.6936 GB, free: 13.12 MB / 0.4948 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 5.904e-05/0.6037, allocations: 12 kB / 0.6936 GB, free: 13.11 MB / 0.4948 GB
Notification: Performance of setup shared object (initialization): time 0.0001525/0.6039, allocations: 333.9 kB / 0.6939 GB, free: 12.77 MB / 0.4948 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001201/0.6051, allocations: 0.525 MB / 0.6944 GB, free: 12.25 MB / 0.4948 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001207/0.6063, allocations: 0.6312 MB / 0.695 GB, free: 11.57 MB / 0.4948 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001147/0.6074, allocations: 0.542 MB / 0.6956 GB, free: 11.03 MB / 0.4948 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.208e-06/0.6075, allocations: 0 / 0.6956 GB, free: 11.03 MB / 0.4948 GB
Notification: Performance of matching and sorting (n=85) (initialization): time 0.01075/0.6182, allocations: 3.705 MB / 0.6992 GB, free: 7.305 MB / 0.4948 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0005017/0.6187, allocations: 1.137 MB / 0.7003 GB, free: 6.078 MB / 0.4948 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.598e-05/0.6188, allocations: 4 kB / 0.7003 GB, free: 6.074 MB / 0.4948 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.004995/0.6238, allocations: 1.632 MB / 0.7019 GB, free: 4.441 MB / 0.4948 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0005339/0.6243, allocations: 99.89 kB / 0.702 GB, free: 4.344 MB / 0.4948 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.004201/0.6285, allocations: 2.088 MB / 0.704 GB, free: 2.23 MB / 0.4948 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001241/0.6298, allocations: 159.4 kB / 0.7042 GB, free: 2.074 MB / 0.4948 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.63e-05/0.6299, allocations: 28 kB / 0.7042 GB, free: 2.047 MB / 0.4948 GB
Notification: Performance of prepare postOptimizeDAE: time 1.383e-05/0.6299, allocations: 4 kB / 0.7042 GB, free: 2.043 MB / 0.4948 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.009801/0.6397, allocations: 3.423 MB / 0.7076 GB, free: 14.61 MB / 0.5105 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.577e-05/0.6398, allocations: 4 kB / 0.7076 GB, free: 14.61 MB / 0.5105 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.004652/0.6444, allocations: 1.548 MB / 0.7091 GB, free: 13.06 MB / 0.5105 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0005192/0.645, allocations: 103.9 kB / 0.7092 GB, free: 12.96 MB / 0.5105 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01759/0.6626, allocations: 8.343 MB / 0.7173 GB, free: 4.473 MB / 0.5105 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001361/0.664, allocations: 143.5 kB / 0.7175 GB, free: 4.332 MB / 0.5105 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 7.179e-05/0.6641, allocations: 23.98 kB / 0.7175 GB, free: 4.309 MB / 0.5105 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 13
 * Number of states: 0 ()
 * Number of discrete variables: 1 (wT4G1.K.local_reset)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (51):
 * Single equations (assignments): 50
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 1 {18 17}
Notification: Performance of prepare postOptimizeDAE: time 0.0006189/0.6647, allocations: 282.3 kB / 0.7177 GB, free: 4.023 MB / 0.5105 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002761/0.665, allocations: 90.88 kB / 0.7178 GB, free: 3.934 MB / 0.5105 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01046/0.6754, allocations: 3.745 MB / 0.7215 GB, free: 176 kB / 0.5105 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.583e-05/0.6755, allocations: 8 kB / 0.7215 GB, free: 168 kB / 0.5105 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 2.996e-06/0.6755, allocations: 0 / 0.7215 GB, free: 168 kB / 0.5105 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 2.11e-05/0.6755, allocations: 3.984 kB / 0.7215 GB, free: 164 kB / 0.5105 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.01229/0.6878, allocations: 4.944 MB / 0.7263 GB, free: 11.12 MB / 0.5261 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.225e-05/0.6879, allocations: 0 / 0.7263 GB, free: 11.12 MB / 0.5261 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0004772/0.6883, allocations: 83.89 kB / 0.7264 GB, free: 11.04 MB / 0.5261 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.004546/0.6929, allocations: 1.566 MB / 0.7279 GB, free: 9.465 MB / 0.5261 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001139/0.693, allocations: 12 kB / 0.7279 GB, free: 9.453 MB / 0.5261 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01854/0.7116, allocations: 8.923 MB / 0.7367 GB, free: 392 kB / 0.5261 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.923e-06/0.7116, allocations: 0 / 0.7367 GB, free: 392 kB / 0.5261 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01206/0.7237, allocations: 4.582 MB / 0.7411 GB, free: 11.77 MB / 0.5417 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003847/0.7241, allocations: 180 kB / 0.7413 GB, free: 11.57 MB / 0.5417 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001268/0.7243, allocations: 23.89 kB / 0.7413 GB, free: 11.55 MB / 0.5417 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0009442/0.7252, allocations: 123.9 kB / 0.7414 GB, free: 11.43 MB / 0.5417 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0004762/0.7257, allocations: 152.4 kB / 0.7416 GB, free: 11.28 MB / 0.5417 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 5.518e-05/0.7258, allocations: 16 kB / 0.7416 GB, free: 11.27 MB / 0.5417 GB
Notification: Performance of sorting global known variables: time 0.0006707/0.7264, allocations: 0.5107 MB / 0.7421 GB, free: 10.76 MB / 0.5417 GB
Notification: Performance of sort global known variables: time 1.3e-07/0.7264, allocations: 0 / 0.7421 GB, free: 10.76 MB / 0.5417 GB
Notification: Performance of remove unused functions: time 0.001567/0.728, allocations: 471.2 kB / 0.7426 GB, free: 10.3 MB / 0.5417 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 2
 * Number of states: 6 (gENCLS2_1.delta,gENCLS2_1.eq,wT4G1.K1.state,wT4G1.K.y,wT4G1.K2.state,gENCLS2_1.omega)
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (39):
 * Single equations (assignments): 38
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 1 {18 19}
Notification: Performance of Backend phase and start with SimCode phase: time 0.0002445/0.7283, allocations: 145.9 kB / 0.7427 GB, free: 10.15 MB / 0.5417 GB
Notification: Performance of simCode: created initialization part: time 0.008565/0.7369, allocations: 3.065 MB / 0.7457 GB, free: 7.078 MB / 0.5417 GB
Notification: Performance of simCode: created event and clocks part: time 7.955e-06/0.7369, allocations: 0 / 0.7457 GB, free: 7.078 MB / 0.5417 GB
Notification: Performance of simCode: created simulation system equations: time 0.003828/0.7407, allocations: 1.399 MB / 0.7471 GB, free: 5.66 MB / 0.5417 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.000929/0.7417, allocations: 83.28 kB / 0.7471 GB, free: 5.582 MB / 0.5417 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.003288/0.745, allocations: 2.018 MB / 0.7491 GB, free: 3.555 MB / 0.5417 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0005287/0.7455, allocations: 1.003 MB / 0.7501 GB, free: 2.527 MB / 0.5417 GB
Notification: Performance of simCode: alias equations: time 0.0003234/0.7459, allocations: 68.89 kB / 0.7501 GB, free: 2.457 MB / 0.5417 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0001406/0.746, allocations: 47.42 kB / 0.7502 GB, free: 2.41 MB / 0.5417 GB
Notification: Performance of SimCode: time 7.31e-07/0.746, allocations: 0 / 0.7502 GB, free: 2.41 MB / 0.5417 GB
Notification: Performance of Templates: time 0.261/1.007, allocations: 19.59 MB / 0.7693 GB, free: 153.6 MB / 0.5573 GB
make -j1 -f OpenIPSL_dev_OpenIPSL.Tests.Wind.PSSE.WT4G.WT4G1.makefile
(rm -f OpenIPSL_dev_OpenIPSL.Tests.Wind.PSSE.WT4G.WT4G1.pipe ; mkfifo OpenIPSL_dev_OpenIPSL.Tests.Wind.PSSE.WT4G.WT4G1.pipe ; head -c 1048576 < OpenIPSL_dev_OpenIPSL.Tests.Wind.PSSE.WT4G.WT4G1.pipe >> ../files/OpenIPSL_dev_OpenIPSL.Tests.Wind.PSSE.WT4G.WT4G1.sim & ./OpenIPSL_dev_OpenIPSL.Tests.Wind.PSSE.WT4G.WT4G1  -abortSlowSimulation -alarm=480 -lv LOG_STATS > OpenIPSL_dev_OpenIPSL.Tests.Wind.PSSE.WT4G.WT4G1.pipe 2>&1)