Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr OpenIPSL_dev_OpenIPSL.Tests.Renewable.PSSE.WindPlant.conf.json
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 4.0.0+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 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 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 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+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)
Running command: translateModel(OpenIPSL.Tests.Renewable.PSSE.WindPlant,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="OpenIPSL_dev_OpenIPSL.Tests.Renewable.PSSE.WindPlant")
translateModel(OpenIPSL.Tests.Renewable.PSSE.WindPlant,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="OpenIPSL_dev_OpenIPSL.Tests.Renewable.PSSE.WindPlant")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001121/0.001121, allocations: 110.7 kB / 16.42 MB, free: 6.516 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.468/1.468, allocations: 222.9 MB / 240.1 MB, free: 4.363 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001385/0.001385, allocations: 196.5 kB / 290.4 MB, free: 2.094 MB / 238.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.1.0-master/package.mo): time 0.5136/0.5136, allocations: 91.91 MB / 432.4 MB, free: 9.078 MB / 302.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001479/0.001479, allocations: 74.56 kB / 0.5734 GB, free: 33.58 MB / 430.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1113/0.1128, allocations: 71.29 MB / 0.643 GB, free: 3.551 MB / 446.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.1.0-master/Electrical/Sensors/PwVoltage.mo:3:3-4:73:writable] Warning: Components are deprecated in class.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.1.0-master/Electrical/Sensors/PwVoltage.mo:5:3-6:71:writable] Warning: Components are deprecated in class.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.1.0-master/Electrical/Sensors/PwVoltage.mo:7:3-8:72:writable] Warning: Components are deprecated in class.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.1.0-master/Electrical/Sensors/PwVoltage.mo:9:3-10:73:writable] Warning: Components are deprecated in class.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.1.0-master/Electrical/Sensors/PwVoltage.mo:12:3-12:11:writable] Warning: Equation sections are deprecated in class.
Notification: Performance of NFInst.instantiate(OpenIPSL.Tests.Renewable.PSSE.WindPlant): time 0.01457/0.1274, allocations: 13.97 MB / 0.6567 GB, free: 5.504 MB / 462.1 MB
Notification: Performance of NFInst.instExpressions: time 0.009665/0.1371, allocations: 5.007 MB / 0.6615 GB, free: 500 kB / 462.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002543/0.1397, allocations: 55.75 kB / 0.6616 GB, free: 444 kB / 462.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.00213/0.1418, allocations: 0.6079 MB / 0.6622 GB, free: 15.82 MB / 478.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.1.0-master/Electrical/Renewables/PSSE/ElectricalController/REECA1.mo:220:3-220:76:writable] Warning: In relation wind.RenewableController.vref0 == 0.0, == on Real numbers is only allowed inside functions.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.1.0-master/Electrical/Renewables/PSSE/PlantController/REPCA1.mo:143:3-143:74:writable] Warning: In relation wind.PlantController.Vref == 0.0, == on Real numbers is only allowed inside functions.
Notification: Performance of NFTyping.typeBindings: time 0.004723/0.1466, allocations: 0.9465 MB / 0.6631 GB, free: 14.86 MB / 478.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.006229/0.1528, allocations: 2.793 MB / 0.6658 GB, free: 12.09 MB / 478.1 MB
Notification: Performance of NFFlatten.flatten: time 0.006202/0.159, allocations: 4.679 MB / 0.6704 GB, free: 7.406 MB / 478.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.002667/0.1617, allocations: 1.535 MB / 0.6719 GB, free: 5.812 MB / 478.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.00231/0.164, allocations: 1.677 MB / 0.6735 GB, free: 4.129 MB / 478.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.002376/0.1664, allocations: 1.847 MB / 0.6753 GB, free: 2.273 MB / 478.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.001074/0.1675, allocations: 0.4922 MB / 0.6758 GB, free: 1.781 MB / 478.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.001264/0.1688, allocations: 0.5937 MB / 0.6764 GB, free: 1.188 MB / 478.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.00116/0.17, allocations: 0.9889 MB / 0.6774 GB, free: 200 kB / 478.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.002401/0.1724, allocations: 1.908 MB / 0.6792 GB, free: 14.27 MB / 494.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.00623/0.1786, allocations: 5.735 MB / 0.6848 GB, free: 8.523 MB / 494.1 MB
Notification: Performance of FrontEnd - DAE generated: time 7.243e-06/0.1787, allocations: 0 / 0.6848 GB, free: 8.523 MB / 494.1 MB
Notification: Performance of FrontEnd: time 1.783e-06/0.1787, allocations: 7.938 kB / 0.6848 GB, free: 8.516 MB / 494.1 MB
Notification: Performance of Transformations before backend: time 0.0001827/0.1789, allocations: 0 / 0.6848 GB, free: 8.516 MB / 494.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 616
 * Number of variables: 616
Notification: Performance of Generate backend data structure: time 0.01314/0.192, allocations: 4.577 MB / 0.6893 GB, free: 3.867 MB / 494.1 MB
Notification: Performance of prepare preOptimizeDAE: time 4.006e-05/0.192, allocations: 12.03 kB / 0.6893 GB, free: 3.855 MB / 494.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.00339/0.1954, allocations: 0.7295 MB / 0.69 GB, free: 3.121 MB / 494.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.003897/0.1994, allocations: 2.322 MB / 0.6923 GB, free: 0.7305 MB / 494.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0005479/0.1999, allocations: 0.5442 MB / 0.6928 GB, free: 112 kB / 494.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0004048/0.2003, allocations: 252 kB / 0.6931 GB, free: 15.86 MB / 0.4981 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.006754/0.2071, allocations: 3.315 MB / 0.6963 GB, free: 12.34 MB / 0.4981 GB
Notification: Performance of preOpt findStateOrder (simulation): time 4.138e-05/0.2072, allocations: 3.938 kB / 0.6963 GB, free: 12.34 MB / 0.4981 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002713/0.2074, allocations: 115.9 kB / 0.6964 GB, free: 12.22 MB / 0.4981 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.322e-05/0.2075, allocations: 60 kB / 0.6965 GB, free: 12.16 MB / 0.4981 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.006998/0.2145, allocations: 2.809 MB / 0.6992 GB, free: 9.34 MB / 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 preOpt removeSimpleEquations (simulation): time 0.01826/0.2328, allocations: 12.03 MB / 0.711 GB, free: 13 MB / 0.5137 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01227/0.245, allocations: 4.576 MB / 0.7154 GB, free: 8.219 MB / 0.5137 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.003352/0.2484, allocations: 1.404 MB / 0.7168 GB, free: 6.805 MB / 0.5137 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001352/0.2486, allocations: 46.02 kB / 0.7169 GB, free: 6.762 MB / 0.5137 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 5.225e-05/0.2486, allocations: 68.5 kB / 0.7169 GB, free: 6.684 MB / 0.5137 GB
Notification: Performance of pre-optimization done (n=206): time 3.516e-06/0.2486, allocations: 0 / 0.7169 GB, free: 6.684 MB / 0.5137 GB
Notification: Performance of matching and sorting (n=206): time 0.03448/0.2831, allocations: 9.233 MB / 0.7259 GB, free: 13.33 MB / 0.5294 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002914/0.2834, allocations: 0.7109 MB / 0.7266 GB, free: 12.46 MB / 0.5294 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.004005/0.2874, allocations: 2.599 MB / 0.7292 GB, free: 9.84 MB / 0.5294 GB
Notification: Performance of collectPreVariables (initialization): time 0.0004022/0.2879, allocations: 65.7 kB / 0.7292 GB, free: 9.77 MB / 0.5294 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001073/0.2889, allocations: 1.351 MB / 0.7306 GB, free: 8.406 MB / 0.5294 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0008036/0.2898, allocations: 0.7124 MB / 0.7313 GB, free: 7.684 MB / 0.5294 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0008328/0.2906, allocations: 492.9 kB / 0.7317 GB, free: 7.195 MB / 0.5294 GB
Notification: Performance of setup shared object (initialization): time 0.0001017/0.2907, allocations: 309.1 kB / 0.732 GB, free: 6.891 MB / 0.5294 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003463/0.2942, allocations: 1.39 MB / 0.7334 GB, free: 5.492 MB / 0.5294 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003983/0.2982, allocations: 1.967 MB / 0.7353 GB, free: 3.312 MB / 0.5294 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.006863/0.305, allocations: 3.002 MB / 0.7382 GB, free: 144 kB / 0.5294 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.664e-06/0.3051, allocations: 0 / 0.7382 GB, free: 144 kB / 0.5294 GB
Notification: Performance of matching and sorting (n=322) (initialization): time 0.01878/0.3239, allocations: 5.943 MB / 0.744 GB, free: 10.13 MB / 0.545 GB
Notification: Performance of prepare postOptimizeDAE: time 2.735e-05/0.3239, allocations: 12 kB / 0.744 GB, free: 10.12 MB / 0.545 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.9e-05/0.3239, allocations: 11.94 kB / 0.7441 GB, free: 10.11 MB / 0.545 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.00648/0.3304, allocations: 1.786 MB / 0.7458 GB, free: 8.305 MB / 0.545 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002381/0.3328, allocations: 0.507 MB / 0.7463 GB, free: 7.797 MB / 0.545 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.03197/0.3648, allocations: 16.65 MB / 0.7626 GB, free: 6.434 MB / 0.5606 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003451/0.3683, allocations: 433.3 kB / 0.763 GB, free: 6.008 MB / 0.5606 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002936/0.3686, allocations: 99.91 kB / 0.7631 GB, free: 5.91 MB / 0.5606 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.003579/0.3722, allocations: 1.54 MB / 0.7646 GB, free: 4.363 MB / 0.5606 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.002795/0.375, allocations: 1.635 MB / 0.7662 GB, free: 2.52 MB / 0.5606 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.2631/0.6381, allocations: 2.44 MB / 0.7685 GB, free: 109.7 MB / 0.5606 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.612e-05/0.6381, allocations: 7.531 kB / 0.7686 GB, free: 109.7 MB / 0.5606 GB
Notification: Performance of matching and sorting (n=322) (initialization_lambda0): time 0.0151/0.6532, allocations: 4.855 MB / 0.7733 GB, free: 109.6 MB / 0.5606 GB
Notification: Performance of prepare postOptimizeDAE: time 1.935e-05/0.6532, allocations: 14.56 kB / 0.7733 GB, free: 109.6 MB / 0.5606 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.81e-05/0.6533, allocations: 11.34 kB / 0.7733 GB, free: 109.6 MB / 0.5606 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.005618/0.6589, allocations: 1.502 MB / 0.7748 GB, free: 109.5 MB / 0.5606 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002194/0.6611, allocations: 453 kB / 0.7752 GB, free: 109.5 MB / 0.5606 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02357/0.6847, allocations: 13.33 MB / 0.7882 GB, free: 102.4 MB / 0.5606 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003116/0.6879, allocations: 324.1 kB / 0.7885 GB, free: 102.4 MB / 0.5606 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003033/0.6882, allocations: 93.39 kB / 0.7886 GB, free: 102.4 MB / 0.5606 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 45
 * Number of states: 0 ()
 * Number of discrete variables: 21 (wind.PlantController.pI_No_Windup_notVariable.or1.y,wind.PlantController.pI_No_Windup_notVariable.or1.u2,wind.PlantController.Voltage_dip,wind.RenewableController.pI_No_Windup_notVariable.or1.y,wind.RenewableController.pI_No_Windup_notVariable.or1.u2,wind.RenewableController.pI_No_Windup.or1.y,wind.RenewableController.pI_No_Windup.or1.u2,wind.RenewableController.StateTransitionLogic.y,wind.RenewableController.Voltage_dip,wind.DriveTrain.integrator3.local_reset,wind.DriveTrain.integrator2.local_reset,wind.DriveTrain.integrator1.local_reset,wind.DriveTrain.integrator.local_reset,wind.PlantController.pI_No_Windup_notVariable.integral.local_reset,wind.PlantController.KIG.local_reset,wind.RenewableController.pI_No_Windup_notVariable.integral.local_reset,wind.RenewableController.pI_No_Windup.integral.local_reset,wind.RenewableController.integrator3.local_reset,wind.RenewableController.integrator2.local_reset,wind.RenewableGenerator.integrator1.local_reset,wind.RenewableGenerator.integrator.local_reset)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (267):
 * Single equations (assignments): 262
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 5
 * 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): 5 systems
   {(1,3), (1,8), (1,3), (1,3), (18,21)}
Notification: Performance of prepare postOptimizeDAE: time 0.0006772/0.6889, allocations: 346.6 kB / 0.789 GB, free: 102.1 MB / 0.5606 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0007656/0.6896, allocations: 300.4 kB / 0.7893 GB, free: 102 MB / 0.5606 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01599/0.7056, allocations: 5.287 MB / 0.7944 GB, free: 100.5 MB / 0.5606 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 4.581e-05/0.7057, allocations: 14.03 kB / 0.7944 GB, free: 100.5 MB / 0.5606 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.12e-06/0.7057, allocations: 0 / 0.7944 GB, free: 100.5 MB / 0.5606 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0008066/0.7065, allocations: 419.1 kB / 0.7948 GB, free: 100.2 MB / 0.5606 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0006413/0.7072, allocations: 46.62 kB / 0.7949 GB, free: 100.2 MB / 0.5606 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002406/0.7096, allocations: 255.5 kB / 0.7951 GB, free: 100.2 MB / 0.5606 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001094/0.7107, allocations: 478 kB / 0.7956 GB, free: 100.1 MB / 0.5606 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.01236/0.7231, allocations: 4.379 MB / 0.7999 GB, free: 97.93 MB / 0.5606 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.01189/0.735, allocations: 5.028 MB / 0.8048 GB, free: 93.66 MB / 0.5606 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.003504/0.7385, allocations: 1.456 MB / 0.8062 GB, free: 92.21 MB / 0.5606 GB
Notification: Performance of sorting global known variables: time 0.002686/0.7413, allocations: 1.734 MB / 0.8079 GB, free: 90.48 MB / 0.5606 GB
Notification: Performance of Backend: time 6.11e-07/0.7413, allocations: 0 / 0.8079 GB, free: 90.48 MB / 0.5606 GB
Notification: Performance of simCode: created initialization part: time 0.01514/0.7564, allocations: 6.235 MB / 0.814 GB, free: 84.34 MB / 0.5606 GB
Notification: Performance of SimCode: time 0.008009/0.7645, allocations: 6.174 MB / 0.82 GB, free: 78.17 MB / 0.5606 GB
Notification: Performance of Templates: time 0.08662/0.8511, allocations: 73.72 MB / 0.892 GB, free: 4.582 MB / 0.5606 GB
make -j1 -f OpenIPSL_dev_OpenIPSL.Tests.Renewable.PSSE.WindPlant.makefile
(rm -f OpenIPSL_dev_OpenIPSL.Tests.Renewable.PSSE.WindPlant.pipe ; mkfifo OpenIPSL_dev_OpenIPSL.Tests.Renewable.PSSE.WindPlant.pipe ; head -c 1048576 < OpenIPSL_dev_OpenIPSL.Tests.Renewable.PSSE.WindPlant.pipe >> ../files/OpenIPSL_dev_OpenIPSL.Tests.Renewable.PSSE.WindPlant.sim & ./OpenIPSL_dev_OpenIPSL.Tests.Renewable.PSSE.WindPlant  -abortSlowSimulation -alarm=480 -lv LOG_STATS > OpenIPSL_dev_OpenIPSL.Tests.Renewable.PSSE.WindPlant.pipe 2>&1)