Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr OpenIPSL_dev_OpenIPSL.Tests.Renewable.PSSE.PVPlant.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.PVPlant,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="OpenIPSL_dev_OpenIPSL.Tests.Renewable.PSSE.PVPlant")
translateModel(OpenIPSL.Tests.Renewable.PSSE.PVPlant,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="OpenIPSL_dev_OpenIPSL.Tests.Renewable.PSSE.PVPlant")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.00129/0.00129, allocations: 114.3 kB / 16.42 MB, free: 6.461 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.4/1.4, allocations: 222.9 MB / 240.1 MB, free: 4.309 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.001315/0.001315, allocations: 196.5 kB / 290.4 MB, free: 2.027 MB / 238.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.1.0-master/package.mo): time 0.522/0.522, allocations: 91.89 MB / 432.4 MB, free: 9.086 MB / 302.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.003121/0.003121, allocations: 84.28 kB / 0.5734 GB, free: 33.45 MB / 430.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1291/0.1322, allocations: 71.28 MB / 0.643 GB, free: 3.535 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.PVPlant): time 0.01236/0.1446, allocations: 11.82 MB / 0.6545 GB, free: 7.664 MB / 462.1 MB
Notification: Performance of NFInst.instExpressions: time 0.008246/0.1529, allocations: 4.058 MB / 0.6585 GB, free: 3.598 MB / 462.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002141/0.1551, allocations: 51.75 kB / 0.6586 GB, free: 3.547 MB / 462.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.001795/0.1569, allocations: 427.6 kB / 0.659 GB, free: 3.125 MB / 462.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.1.0-master/Electrical/Renewables/PSSE/ElectricalController/REECB1.mo:202:3-202:76:writable] Warning: In relation pV.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 pV.PlantController.Vref == 0.0, == on Real numbers is only allowed inside functions.
Notification: Performance of NFTyping.typeBindings: time 0.002944/0.1599, allocations: 0.7485 MB / 0.6597 GB, free: 2.371 MB / 462.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.005128/0.165, allocations: 2.417 MB / 0.6621 GB, free: 15.97 MB / 478.1 MB
Notification: Performance of NFFlatten.flatten: time 0.005346/0.1704, allocations: 3.914 MB / 0.6659 GB, free: 12.05 MB / 478.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.002429/0.1728, allocations: 1.276 MB / 0.6671 GB, free: 10.71 MB / 478.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.00236/0.1752, allocations: 1.409 MB / 0.6685 GB, free: 9.301 MB / 478.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.002214/0.1775, allocations: 1.555 MB / 0.67 GB, free: 7.738 MB / 478.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.001092/0.1786, allocations: 420 kB / 0.6704 GB, free: 7.328 MB / 478.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.001225/0.1798, allocations: 492 kB / 0.6709 GB, free: 6.848 MB / 478.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.001205/0.181, allocations: 0.8332 MB / 0.6717 GB, free: 6.012 MB / 478.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.002215/0.1833, allocations: 1.582 MB / 0.6732 GB, free: 4.422 MB / 478.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.005378/0.1886, allocations: 4.669 MB / 0.6778 GB, free: 15.74 MB / 494.1 MB
Notification: Performance of FrontEnd - DAE generated: time 5.39e-06/0.1887, allocations: 0 / 0.6778 GB, free: 15.74 MB / 494.1 MB
Notification: Performance of FrontEnd: time 2.144e-06/0.1887, allocations: 0 / 0.6778 GB, free: 15.74 MB / 494.1 MB
Notification: Performance of Transformations before backend: time 0.0001295/0.1888, allocations: 0 / 0.6778 GB, free: 15.74 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: 516
 * Number of variables: 516
Notification: Performance of Generate backend data structure: time 0.01253/0.2014, allocations: 3.943 MB / 0.6817 GB, free: 11.73 MB / 494.1 MB
Notification: Performance of prepare preOptimizeDAE: time 4.716e-05/0.2014, allocations: 12.03 kB / 0.6817 GB, free: 11.71 MB / 494.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003746/0.2052, allocations: 0.6566 MB / 0.6823 GB, free: 11.05 MB / 494.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.004742/0.2099, allocations: 1.934 MB / 0.6842 GB, free: 9.047 MB / 494.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0006407/0.2106, allocations: 0.5082 MB / 0.6847 GB, free: 8.461 MB / 494.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.000707/0.2113, allocations: 212 kB / 0.6849 GB, free: 8.254 MB / 494.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.007408/0.2187, allocations: 2.879 MB / 0.6877 GB, free: 5.188 MB / 494.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 4.681e-05/0.2188, allocations: 3.938 kB / 0.6877 GB, free: 5.184 MB / 494.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003674/0.2192, allocations: 92 kB / 0.6878 GB, free: 5.094 MB / 494.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.856e-05/0.2193, allocations: 51.94 kB / 0.6878 GB, free: 5.043 MB / 494.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.006879/0.2261, allocations: 2.498 MB / 0.6903 GB, free: 2.543 MB / 494.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.01875/0.2449, allocations: 9.983 MB / 0.7 GB, free: 8.289 MB / 0.4981 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01321/0.2582, allocations: 4.443 MB / 0.7044 GB, free: 3.633 MB / 0.4981 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.003567/0.2618, allocations: 1.299 MB / 0.7056 GB, free: 2.324 MB / 0.4981 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001935/0.262, allocations: 41.95 kB / 0.7057 GB, free: 2.285 MB / 0.4981 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 5.832e-05/0.262, allocations: 56.56 kB / 0.7057 GB, free: 2.219 MB / 0.4981 GB
Notification: Performance of pre-optimization done (n=177): time 4.729e-06/0.2621, allocations: 0 / 0.7057 GB, free: 2.219 MB / 0.4981 GB
Notification: Performance of matching and sorting (n=177): time 0.03929/0.3013, allocations: 9.412 MB / 0.7149 GB, free: 8.727 MB / 0.5137 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0003055/0.3017, allocations: 0.707 MB / 0.7156 GB, free: 7.855 MB / 0.5137 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003728/0.3054, allocations: 2.019 MB / 0.7176 GB, free: 5.809 MB / 0.5137 GB
Notification: Performance of collectPreVariables (initialization): time 0.0004526/0.3059, allocations: 61.7 kB / 0.7177 GB, free: 5.742 MB / 0.5137 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001012/0.3069, allocations: 1.087 MB / 0.7187 GB, free: 4.641 MB / 0.5137 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0009075/0.3078, allocations: 0.6162 MB / 0.7193 GB, free: 4.016 MB / 0.5137 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001261/0.3091, allocations: 431.7 kB / 0.7197 GB, free: 3.586 MB / 0.5137 GB
Notification: Performance of setup shared object (initialization): time 9.977e-05/0.3092, allocations: 301.1 kB / 0.72 GB, free: 3.289 MB / 0.5137 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003387/0.3126, allocations: 1.259 MB / 0.7212 GB, free: 2.02 MB / 0.5137 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003772/0.3164, allocations: 1.762 MB / 0.723 GB, free: 80 kB / 0.5137 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.006476/0.3229, allocations: 2.673 MB / 0.7256 GB, free: 13.3 MB / 0.5294 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.864e-06/0.3229, allocations: 4 kB / 0.7256 GB, free: 13.29 MB / 0.5294 GB
Notification: Performance of matching and sorting (n=276) (initialization): time 0.01776/0.3407, allocations: 5.442 MB / 0.7309 GB, free: 7.828 MB / 0.5294 GB
Notification: Performance of prepare postOptimizeDAE: time 3.4e-05/0.3407, allocations: 12.44 kB / 0.7309 GB, free: 7.816 MB / 0.5294 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.837e-05/0.3408, allocations: 12 kB / 0.7309 GB, free: 7.805 MB / 0.5294 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.006254/0.347, allocations: 1.662 MB / 0.7325 GB, free: 6.133 MB / 0.5294 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002274/0.3493, allocations: 459.3 kB / 0.733 GB, free: 5.684 MB / 0.5294 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02798/0.3773, allocations: 12.92 MB / 0.7456 GB, free: 8.336 MB / 0.545 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002878/0.3802, allocations: 393.7 kB / 0.746 GB, free: 7.949 MB / 0.545 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003203/0.3806, allocations: 79.98 kB / 0.746 GB, free: 7.871 MB / 0.545 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.003135/0.3837, allocations: 1.316 MB / 0.7473 GB, free: 6.547 MB / 0.545 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.002624/0.3864, allocations: 1.438 MB / 0.7487 GB, free: 4.934 MB / 0.545 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.004263/0.3906, allocations: 2.127 MB / 0.7508 GB, free: 2.707 MB / 0.545 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 6.713e-06/0.3907, allocations: 4 kB / 0.7508 GB, free: 2.703 MB / 0.545 GB
Notification: Performance of matching and sorting (n=276) (initialization_lambda0): time 0.01367/0.4043, allocations: 4.422 MB / 0.7551 GB, free: 14.26 MB / 0.5606 GB
Notification: Performance of prepare postOptimizeDAE: time 2.287e-05/0.4044, allocations: 11.94 kB / 0.7551 GB, free: 14.25 MB / 0.5606 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.717e-05/0.4044, allocations: 8.5 kB / 0.7551 GB, free: 14.24 MB / 0.5606 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.005261/0.4097, allocations: 1.423 MB / 0.7565 GB, free: 12.81 MB / 0.5606 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001869/0.4116, allocations: 399.4 kB / 0.7569 GB, free: 12.42 MB / 0.5606 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02139/0.433, allocations: 9.947 MB / 0.7666 GB, free: 2.191 MB / 0.5606 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00259/0.4356, allocations: 286.4 kB / 0.7669 GB, free: 1.91 MB / 0.5606 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002928/0.4359, allocations: 75.98 kB / 0.767 GB, free: 1.836 MB / 0.5606 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 34
 * Number of states: 0 ()
 * Number of discrete variables: 12 (pV.PlantController.pI_No_Windup_notVariable.or1.y,pV.PlantController.pI_No_Windup_notVariable.or1.u2,pV.PlantController.Voltage_dip,pV.RenewableController.Voltage_dip,pV.PlantController.pI_No_Windup_notVariable.integral.local_reset,pV.PlantController.KIG.local_reset,pV.RenewableController.integrator3.local_reset,pV.RenewableController.integrator2.local_reset,pV.RenewableController.integrator1.local_reset,pV.RenewableController.integrator.local_reset,pV.RenewableGenerator.integrator1.local_reset,pV.RenewableGenerator.integrator.local_reset)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (229):
 * Single equations (assignments): 226
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 3
 * 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): 3 systems
   {(1,6), (1,3), (18,21)}
Notification: Performance of prepare postOptimizeDAE: time 0.0007678/0.4367, allocations: 313.9 kB / 0.7673 GB, free: 1.52 MB / 0.5606 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.000723/0.4374, allocations: 248.9 kB / 0.7675 GB, free: 1.273 MB / 0.5606 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.2829/0.7203, allocations: 4.851 MB / 0.7723 GB, free: 112.6 MB / 0.5606 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 6.216e-05/0.7204, allocations: 16.19 kB / 0.7723 GB, free: 112.6 MB / 0.5606 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.781e-06/0.7204, allocations: 0 / 0.7723 GB, free: 112.6 MB / 0.5606 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0007789/0.7212, allocations: 362.6 kB / 0.7726 GB, free: 112.5 MB / 0.5606 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0008146/0.722, allocations: 39.44 kB / 0.7727 GB, free: 112.5 MB / 0.5606 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002695/0.7247, allocations: 254.7 kB / 0.7729 GB, free: 112.5 MB / 0.5606 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001269/0.726, allocations: 431.3 kB / 0.7733 GB, free: 112.5 MB / 0.5606 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.01341/0.7394, allocations: 4.008 MB / 0.7772 GB, free: 112 MB / 0.5606 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.0107/0.7502, allocations: 4.562 MB / 0.7817 GB, free: 111.3 MB / 0.5606 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.002978/0.7532, allocations: 1.291 MB / 0.7829 GB, free: 110.9 MB / 0.5606 GB
Notification: Performance of sorting global known variables: time 0.002086/0.7553, allocations: 1.354 MB / 0.7843 GB, free: 110.3 MB / 0.5606 GB
Notification: Performance of Backend: time 5.31e-07/0.7553, allocations: 0 / 0.7843 GB, free: 110.3 MB / 0.5606 GB
Notification: Performance of simCode: created initialization part: time 0.01265/0.768, allocations: 4.997 MB / 0.7891 GB, free: 108.3 MB / 0.5606 GB
Notification: Performance of SimCode: time 0.006564/0.7746, allocations: 5.154 MB / 0.7942 GB, free: 105.5 MB / 0.5606 GB
Notification: Performance of Templates: time 0.07687/0.8515, allocations: 64.6 MB / 0.8573 GB, free: 42.82 MB / 0.5606 GB
make -j1 -f OpenIPSL_dev_OpenIPSL.Tests.Renewable.PSSE.PVPlant.makefile
(rm -f OpenIPSL_dev_OpenIPSL.Tests.Renewable.PSSE.PVPlant.pipe ; mkfifo OpenIPSL_dev_OpenIPSL.Tests.Renewable.PSSE.PVPlant.pipe ; head -c 1048576 < OpenIPSL_dev_OpenIPSL.Tests.Renewable.PSSE.PVPlant.pipe >> ../files/OpenIPSL_dev_OpenIPSL.Tests.Renewable.PSSE.PVPlant.sim & ./OpenIPSL_dev_OpenIPSL.Tests.Renewable.PSSE.PVPlant  -abortSlowSimulation -alarm=480 -lv LOG_STATS > OpenIPSL_dev_OpenIPSL.Tests.Renewable.PSSE.PVPlant.pipe 2>&1)