Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Dynawo_dev_Dynawo.Examples.GridCodeSimulations.SheetSimulations.SheetI7QMin.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.001087/0.001087, allocations: 72.95 kB / 20.74 MB, free: 3.758 MB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.001089/0.001089, allocations: 169 kB / 24.16 MB, free: 336 kB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 0.8898/0.8898, allocations: 158.6 MB / 186 MB, free: 2.777 MB / 170.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo master/package.mo): time 0.4613/0.4613, allocations: 90.86 MB / 329.2 MB, free: 14.28 MB / 314.7 MB
"
[Timeout remaining time 179]
Using package Dynawo with version 2.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo master/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 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo)
Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo)
Running command: translateModel(Dynawo.Examples.GridCodeSimulations.SheetSimulations.SheetI7QMin,tolerance=1e-06,outputFormat="mat",numberOfIntervals=20000,variableFilter="time|Unit.HvMeasurements.PPu|Unit.HvMeasurements.QPu|Unit.HvMeasurements.UPu|Unit.LvMeasurements.PPu|Unit.LvMeasurements.QPu|Unit.LvMeasurements.UPu",fileNamePrefix="Dynawo_dev_Dynawo.Examples.GridCodeSimulations.SheetSimulations.SheetI7QMin")
translateModel(Dynawo.Examples.GridCodeSimulations.SheetSimulations.SheetI7QMin,tolerance=1e-06,outputFormat="mat",numberOfIntervals=20000,variableFilter="time|Unit.HvMeasurements.PPu|Unit.HvMeasurements.QPu|Unit.HvMeasurements.UPu|Unit.LvMeasurements.PPu|Unit.LvMeasurements.QPu|Unit.LvMeasurements.UPu",fileNamePrefix="Dynawo_dev_Dynawo.Examples.GridCodeSimulations.SheetSimulations.SheetI7QMin") [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 1.332e-06/1.332e-06, allocations: 0 / 380.9 MB, free: 11.07 MB / 362.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.021e-05/2.154e-05, allocations: 2.312 kB / 380.9 MB, free: 11.07 MB / 362.7 MB
Notification: Performance of NFInst.instantiate(Dynawo.Examples.GridCodeSimulations.SheetSimulations.SheetI7QMin): time 0.01597/0.01599, allocations: 17.16 MB / 398 MB, free: 9.832 MB / 378.7 MB
Notification: Performance of NFInst.instExpressions: time 0.015/0.03099, allocations: 8.584 MB / 406.6 MB, free: 1.23 MB / 378.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.00365/0.03464, allocations: 119.2 kB / 406.7 MB, free: 1.113 MB / 378.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.003248/0.03789, allocations: 1.283 MB / 408 MB, free: 15.82 MB / 394.7 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/Utilities/Strings.mo:139:3-175:14:writable] Warning: Pure function 'Modelica.Utilities.Strings.isEmpty' contains a call to impure function 'Modelica.Utilities.Strings.Advanced.skipWhiteSpace'.
Notification: Performance of NFTyping.typeBindings: time 0.005595/0.04348, allocations: 1.851 MB / 409.9 MB, free: 13.96 MB / 394.7 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo master/Electrical/Controls/WECC/BaseClasses_INIT/WECCPlantCurrentSource_INIT.mo:90:3-90:90:writable] Warning: In relation Modelica.ComplexMath.'abs'(wtgCurrentSource_INIT.s0Pu) == 0.0, == on Real operands is deprecated in non-function contexts.
Notification: Performance of NFTyping.typeClassSections: time 0.007031/0.05052, allocations: 3.872 MB / 413.7 MB, free: 10.08 MB / 394.7 MB
Notification: Performance of NFFlatten.flatten: time 0.008802/0.05932, allocations: 6.978 MB / 420.7 MB, free: 3.082 MB / 394.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.003656/0.06297, allocations: 1.551 MB / 422.3 MB, free: 1.441 MB / 394.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.003594/0.06657, allocations: 2.38 MB / 424.6 MB, free: 15.05 MB / 410.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.002863/0.06943, allocations: 2.11 MB / 426.7 MB, free: 12.94 MB / 410.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.001384/0.07082, allocations: 0.707 MB / 427.5 MB, free: 12.23 MB / 410.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.001767/0.07258, allocations: 1.093 MB / 428.5 MB, free: 11.14 MB / 410.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.001001/0.07358, allocations: 1.576 MB / 430.1 MB, free: 9.555 MB / 410.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.002077/0.07566, allocations: 1.842 MB / 432 MB, free: 7.707 MB / 410.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.005786/0.08145, allocations: 4.814 MB / 436.8 MB, free: 2.875 MB / 410.7 MB
Notification: Performance of FrontEnd - DAE generated: time 4.859e-06/0.08145, allocations: 0 / 436.8 MB, free: 2.875 MB / 410.7 MB
Notification: Performance of FrontEnd: time 1.242e-06/0.08145, allocations: 0 / 436.8 MB, free: 2.875 MB / 410.7 MB
Notification: Performance of Transformations before backend: time 7.86e-05/0.08153, allocations: 0 / 436.8 MB, free: 2.875 MB / 410.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 897
 * Number of variables: 897
Notification: Performance of Generate backend data structure: time 0.009249/0.09078, allocations: 6.9 MB / 443.7 MB, free: 11.88 MB / 426.7 MB
Notification: Performance of prepare preOptimizeDAE: time 3.609e-05/0.09082, allocations: 16.02 kB / 443.7 MB, free: 11.86 MB / 426.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002707/0.09352, allocations: 1.293 MB / 445 MB, free: 10.57 MB / 426.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.003407/0.09693, allocations: 2.25 MB / 447.2 MB, free: 8.25 MB / 426.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0004979/0.09743, allocations: 0.9836 MB / 448.2 MB, free: 7.105 MB / 426.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.000384/0.09781, allocations: 375.9 kB / 448.6 MB, free: 6.738 MB / 426.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003569/0.1014, allocations: 3.405 MB / 452 MB, free: 3.016 MB / 426.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 4.913e-05/0.1014, allocations: 3.938 kB / 452 MB, free: 3.012 MB / 426.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001918/0.1016, allocations: 152 kB / 452.1 MB, free: 2.863 MB / 426.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.75e-05/0.1017, allocations: 88 kB / 452.2 MB, free: 2.777 MB / 426.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001695/0.1034, allocations: 1.08 MB / 453.3 MB, free: 1.676 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 preOpt removeSimpleEquations (simulation): time 0.01213/0.1155, allocations: 9.446 MB / 462.8 MB, free: 7.992 MB / 442.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.00248/0.118, allocations: 1.759 MB / 464.5 MB, free: 6.203 MB / 442.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0006362/0.1186, allocations: 466.2 kB / 465 MB, free: 5.742 MB / 442.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001941/0.1188, allocations: 61.98 kB / 465 MB, free: 5.68 MB / 442.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001246/0.1201, allocations: 1.171 MB / 466.2 MB, free: 4.449 MB / 442.7 MB
Notification: Performance of pre-optimization done (n=292): time 5.18e-06/0.1201, allocations: 0 / 466.2 MB, free: 4.449 MB / 442.7 MB
Notification: Performance of matching and sorting (n=292): time 0.003597/0.1237, allocations: 1.821 MB / 468 MB, free: 2.586 MB / 442.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001817/0.1238, allocations: 0.5972 MB / 468.6 MB, free: 1.852 MB / 442.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.1943/0.3181, allocations: 3.268 MB / 471.9 MB, free: 68.57 MB / 442.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0005114/0.3187, allocations: 98.7 kB / 472 MB, free: 68.54 MB / 442.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.001436/0.3201, allocations: 1.474 MB / 473.5 MB, free: 68.42 MB / 442.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.001019/0.3211, allocations: 1.058 MB / 474.5 MB, free: 67.93 MB / 442.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001204/0.3223, allocations: 0.8327 MB / 475.4 MB, free: 67.87 MB / 442.7 MB
Notification: Performance of setup shared object (initialization): time 3.112e-05/0.3223, allocations: 302.7 kB / 475.6 MB, free: 67.57 MB / 442.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0015/0.3238, allocations: 0.7579 MB / 476.4 MB, free: 67.49 MB / 442.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001833/0.3257, allocations: 1.891 MB / 478.3 MB, free: 66.25 MB / 442.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.004274/0.3299, allocations: 3.304 MB / 481.6 MB, free: 65.52 MB / 442.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.432e-05/0.33, allocations: 3.719 kB / 481.6 MB, free: 65.52 MB / 442.7 MB
Notification: Performance of matching and sorting (n=586) (initialization): time 0.004115/0.3341, allocations: 2.821 MB / 484.4 MB, free: 65.29 MB / 442.7 MB
Notification: Performance of prepare postOptimizeDAE: time 6.661e-05/0.3342, allocations: 76.33 kB / 484.5 MB, free: 65.25 MB / 442.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.2e-05/0.3342, allocations: 11.12 kB / 484.5 MB, free: 65.25 MB / 442.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0005236/0.3347, allocations: 221.2 kB / 484.7 MB, free: 65.25 MB / 442.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002975/0.3377, allocations: 1.367 MB / 486.1 MB, free: 65.25 MB / 442.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001361/0.339, allocations: 1.62 MB / 487.7 MB, free: 64.11 MB / 442.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002326/0.3414, allocations: 454.1 kB / 488.2 MB, free: 63.94 MB / 442.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002683/0.3416, allocations: 116.9 kB / 488.3 MB, free: 63.94 MB / 442.7 MB
Warning: Assuming fixed start value for the following 35 variables:
         Unit.LvTfo.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = Unit.LvTfo.State0 fixed = true )  \"Transformer connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined)
         Unit.injector.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = Unit.injector.State0 fixed = true )  \"Injector connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined)
         Unit.HvTfo.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = Unit.HvTfo.State0 fixed = true )  \"Transformer connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined)
         Unit.HvTfo.running:DISCRETE(flow=false start = Unit.HvTfo.Running0 fixed = true )  \"Indicates if the component is running or not\" type: Boolean
         Unit.wecc_wtgp.limitedIntegrator.y:VARIABLE(flow=false start = Unit.wecc_wtgp.limitedIntegrator.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_wtgp.limitedIntegrator1.y:VARIABLE(flow=false start = Unit.wecc_wtgp.limitedIntegrator1.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_wtgq.firstOrder.y:VARIABLE(flow=false start = Unit.wecc_wtgq.firstOrder.y_start fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_wtgq.firstOrder1.y:VARIABLE(flow=false start = Unit.wecc_wtgp.omegaRefWTGQ0Pu fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_wtgq.limitedIntegratorFreeze.y:VARIABLE(flow=false start = Unit.wecc_wtgq.limitedIntegratorFreeze.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_regc.rateLimFirstOrderFreeze2.y:VARIABLE(flow=false start = Unit.wecc_regc.rateLimFirstOrderFreeze2.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_regc.rateLimFirstOrderFreeze1.y:VARIABLE(flow=false start = Unit.wecc_regc.rateLimFirstOrderFreeze1.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_regc.firstOrder.y:VARIABLE(flow=false start = Unit.wecc_regc.firstOrder.y_start fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_regc.offDelay.delaySignal:DISCRETE(start = false fixed = true protected = true )  type: Boolean
         Unit.wecc_regc.offDelay.tNext:DISCRETE(start = -1.0 unit = \"s\" fixed = true protected = true )  type: Real
         Unit.wecc_repc.firstOrder.y:VARIABLE(flow=false start = Unit.wecc_repc.firstOrder.y_start fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_repc.firstOrder1.y:VARIABLE(flow=false start = Unit.wecc_repc.firstOrder1.y_start fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_repc.firstOrder2.y:VARIABLE(flow=false start = Unit.wecc_repc.firstOrder2.y_start fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_repc.firstOrder3.y:VARIABLE(flow=false start = Unit.wecc_repc.firstOrder3.y_start fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_repc.limPIDFreeze.I.y:VARIABLE(flow=false start = Unit.wecc_repc.limPIDFreeze.I.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_repc.leadLag.x_scaled[1]:VARIABLE(start = Unit.wecc_repc.leadLag.X0[1] * Unit.wecc_repc.leadLag.a_end fixed = true protected = true )  \"Scaled vector x\" type: Real [1]
         Unit.injector.running:DISCRETE(flow=false start = Unit.injector.Running0 fixed = true )  \"Indicates if the component is running or not\" type: Boolean
         Unit.wecc_reec.firstOrder.y:VARIABLE(flow=false start = Unit.wecc_reec.UConv0Pu fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_reec.firstOrder1.y:VARIABLE(flow=false start = Unit.wecc_reec.firstOrder1.y_start fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_reec.limPIDFreeze.I.y:VARIABLE(flow=false start = Unit.wecc_reec.limPIDFreeze.I.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_reec.rateLimFirstOrderFreeze1.y:VARIABLE(flow=false start = Unit.wecc_reec.rateLimFirstOrderFreeze1.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_reec.rateLimFirstOrderFreeze.y:VARIABLE(flow=false start = Unit.wecc_wtgp.PConv0Pu fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_reec.varLimPIDFreeze.I.y:VARIABLE(flow=false start = Unit.wecc_reec.varLimPIDFreeze.I.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_reec.iqInjectionLogic.vDip:DISCRETE(flow=false start = false fixed = true )  \"Ongoing voltage dip\" type: Boolean
         Unit.wecc_reec.iqInjectionLogic.vDipInjEndTime:DISCRETE(start = -1.0 unit = \"s\" fixed = true )  \"ending time of the voltage dip start (in seconds)\" type: Real
         Unit.wecc_reec.currentLimitsCalculation1.ipMaxFrzPu:DISCRETE(start = 0.0 unit = \"1\" fixed = true )  type: Real
         Unit.wecc_reec.currentLimitsCalculation1.vDipFrzEndTime:DISCRETE(start = -1.0 unit = \"s\" fixed = true )  type: Real
         Unit.LvTfo.running:DISCRETE(flow=false start = Unit.LvTfo.Running0 fixed = true )  \"Indicates if the component is running or not\" type: Boolean
         Unit.Pm0Pu:VARIABLE(unit = \"1\" fixed = true )  \"Initial mechanical power in pu (base SNom)\" type: Real
         Unit.wecc_reec.currentLimitsCalculation1.vDip:DISCRETE(flow=false fixed = true )  \"Ongoing voltage dip\" type: Boolean
         Unit.wecc_regc.offDelay.u:DISCRETE(flow=false fixed = true )  \"Boolean input signal\" type: Boolean
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.002382/0.344, allocations: 1.063 MB / 489.3 MB, free: 63.77 MB / 442.7 MB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001432/0.3454, allocations: 1.888 MB / 491.2 MB, free: 62.54 MB / 442.7 MB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.003501/0.3489, allocations: 3.277 MB / 494.5 MB, free: 61.79 MB / 442.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.515e-05/0.349, allocations: 3.781 kB / 494.5 MB, free: 61.79 MB / 442.7 MB
Notification: Performance of matching and sorting (n=586) (initialization_lambda0): time 0.003696/0.3527, allocations: 2.818 MB / 497.3 MB, free: 60.9 MB / 442.7 MB
Notification: Performance of prepare postOptimizeDAE: time 4.703e-05/0.3527, allocations: 67.83 kB / 497.4 MB, free: 60.85 MB / 442.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.626e-05/0.3527, allocations: 12 kB / 497.4 MB, free: 60.84 MB / 442.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0004194/0.3531, allocations: 230.6 kB / 497.6 MB, free: 60.69 MB / 442.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002814/0.356, allocations: 1.354 MB / 499 MB, free: 59.63 MB / 442.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001234/0.3572, allocations: 1.623 MB / 0.4889 GB, free: 58.21 MB / 442.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001974/0.3592, allocations: 437.4 kB / 0.4893 GB, free: 57.9 MB / 442.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002103/0.3594, allocations: 116.4 kB / 0.4894 GB, free: 57.83 MB / 442.7 MB
Warning: Assuming fixed start value for the following 35 variables:
         Unit.LvTfo.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = Unit.LvTfo.State0 fixed = true )  \"Transformer connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined)
         Unit.injector.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = Unit.injector.State0 fixed = true )  \"Injector connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined)
         Unit.HvTfo.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = Unit.HvTfo.State0 fixed = true )  \"Transformer connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined)
         Unit.HvTfo.running:DISCRETE(flow=false start = Unit.HvTfo.Running0 fixed = true )  \"Indicates if the component is running or not\" type: Boolean
         Unit.wecc_wtgp.limitedIntegrator.y:VARIABLE(flow=false start = Unit.wecc_wtgp.limitedIntegrator.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_wtgp.limitedIntegrator1.y:VARIABLE(flow=false start = Unit.wecc_wtgp.limitedIntegrator1.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_wtgq.firstOrder.y:VARIABLE(flow=false start = Unit.wecc_wtgq.firstOrder.y_start fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_wtgq.firstOrder1.y:VARIABLE(flow=false start = Unit.wecc_wtgp.omegaRefWTGQ0Pu fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_wtgq.limitedIntegratorFreeze.y:VARIABLE(flow=false start = Unit.wecc_wtgq.limitedIntegratorFreeze.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_regc.rateLimFirstOrderFreeze2.y:VARIABLE(flow=false start = Unit.wecc_regc.rateLimFirstOrderFreeze2.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_regc.rateLimFirstOrderFreeze1.y:VARIABLE(flow=false start = Unit.wecc_regc.rateLimFirstOrderFreeze1.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_regc.firstOrder.y:VARIABLE(flow=false start = Unit.wecc_regc.firstOrder.y_start fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_regc.offDelay.delaySignal:DISCRETE(start = false fixed = true protected = true )  type: Boolean
         Unit.wecc_regc.offDelay.tNext:DISCRETE(start = -1.0 unit = \"s\" fixed = true protected = true )  type: Real
         Unit.wecc_repc.firstOrder.y:VARIABLE(flow=false start = Unit.wecc_repc.firstOrder.y_start fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_repc.firstOrder1.y:VARIABLE(flow=false start = Unit.wecc_repc.firstOrder1.y_start fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_repc.firstOrder2.y:VARIABLE(flow=false start = Unit.wecc_repc.firstOrder2.y_start fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_repc.firstOrder3.y:VARIABLE(flow=false start = Unit.wecc_repc.firstOrder3.y_start fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_repc.limPIDFreeze.I.y:VARIABLE(flow=false start = Unit.wecc_repc.limPIDFreeze.I.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_repc.leadLag.x_scaled[1]:VARIABLE(start = Unit.wecc_repc.leadLag.X0[1] * Unit.wecc_repc.leadLag.a_end fixed = true protected = true )  \"Scaled vector x\" type: Real [1]
         Unit.injector.running:DISCRETE(flow=false start = Unit.injector.Running0 fixed = true )  \"Indicates if the component is running or not\" type: Boolean
         Unit.wecc_reec.firstOrder.y:VARIABLE(flow=false start = Unit.wecc_reec.UConv0Pu fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_reec.firstOrder1.y:VARIABLE(flow=false start = Unit.wecc_reec.firstOrder1.y_start fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_reec.limPIDFreeze.I.y:VARIABLE(flow=false start = Unit.wecc_reec.limPIDFreeze.I.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_reec.rateLimFirstOrderFreeze1.y:VARIABLE(flow=false start = Unit.wecc_reec.rateLimFirstOrderFreeze1.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_reec.rateLimFirstOrderFreeze.y:VARIABLE(flow=false start = Unit.wecc_wtgp.PConv0Pu fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_reec.varLimPIDFreeze.I.y:VARIABLE(flow=false start = Unit.wecc_reec.varLimPIDFreeze.I.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         Unit.wecc_reec.iqInjectionLogic.vDip:DISCRETE(flow=false start = false fixed = true )  \"Ongoing voltage dip\" type: Boolean
         Unit.wecc_reec.iqInjectionLogic.vDipInjEndTime:DISCRETE(start = -1.0 unit = \"s\" fixed = true )  \"ending time of the voltage dip start (in seconds)\" type: Real
         Unit.wecc_reec.currentLimitsCalculation1.ipMaxFrzPu:DISCRETE(start = 0.0 unit = \"1\" fixed = true )  type: Real
         Unit.wecc_reec.currentLimitsCalculation1.vDipFrzEndTime:DISCRETE(start = -1.0 unit = \"s\" fixed = true )  type: Real
         Unit.LvTfo.running:DISCRETE(flow=false start = Unit.LvTfo.Running0 fixed = true )  \"Indicates if the component is running or not\" type: Boolean
         Unit.Pm0Pu:VARIABLE(unit = \"1\" fixed = true )  \"Initial mechanical power in pu (base SNom)\" type: Real
         Unit.wecc_reec.currentLimitsCalculation1.vDip:DISCRETE(flow=false fixed = true )  \"Ongoing voltage dip\" type: Boolean
         Unit.wecc_regc.offDelay.u:DISCRETE(flow=false fixed = true )  \"Boolean input signal\" type: Boolean
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 54
 * Number of states: 0 ()
 * Number of discrete variables: 81 ($PRE.infiniteBusFromTable.tableOmegaRefPu.nextTimeEvent,$whenCondition20,infiniteBusFromTable.tableOmegaRefPu.nextTimeEventScaled,$PRE.infiniteBusFromTable.tableOmegaRefPu.nextTimeEventScaled,infiniteBusFromTable.tableOmegaRefPu.nextTimeEvent,$PRE.Unit.LvTfo.state,Unit.LvTfo.state,$PRE.Unit.injector.state,Unit.injector.state,$PRE.Unit.HvTfo.state,Unit.HvTfo.state,$PRE.infiniteBusFromTable.tableUPhase.nextTimeEvent,$whenCondition2,$PRE.infiniteBusFromTable.tableUPu.nextTimeEvent,$whenCondition1,Unit.wecc_wtgp.absLimRateLimFirstOrderFreeze.integrator.local_reset,Unit.wecc_wtgt.dPhi.local_reset,Unit.wecc_wtgt.dOmegaTurbine.local_reset,Unit.wecc_wtgt.dOmegaGenerator.local_reset,Unit.wecc_repc.limPID.I.local_reset,Unit.wecc_repc.limPIDFreeze.I.resetLocal,Unit.pll.integrator.local_reset,Unit.pll.limIntegrator.local_reset,Unit.wecc_reec.limPIDFreeze.I.resetLocal,Unit.wecc_reec.varLimPIDFreeze.I.resetLocal,Unit.wecc_regc.rateLimFirstOrderFreeze2.local_freeze,Unit.wecc_regc.rateLimFirstOrderFreeze1.local_freeze,Unit.injector.switchOffSignal1,Unit.injector.switchOffSignal2,Unit.injector.switchOffSignal3,$PRE.Unit.HvTfo.running,$PRE.Unit.wecc_regc.offDelay.delaySignal,$PRE.Unit.wecc_regc.offDelay.tNext,$PRE.Unit.injector.running,$PRE.Unit.wecc_reec.iqInjectionLogic.vDip,$PRE.Unit.wecc_reec.iqInjectionLogic.vDipInjEndTime,$PRE.Unit.wecc_reec.currentLimitsCalculation1.ipMaxFrzPu,$PRE.Unit.wecc_reec.currentLimitsCalculation1.vDipFrzEndTime,$PRE.Unit.LvTfo.running,Unit.wecc_regc.QConv0PuPos.k,Unit.wecc_regc.QConv0PuNeg.k,$PRE.Unit.wecc_reec.currentLimitsCalculation1.vDip,$PRE.Unit.wecc_regc.offDelay.u,Unit.LvTfo.running,Unit.wecc_reec.currentLimitsCalculation1.vDipFrzEndTime,Unit.wecc_reec.currentLimitsCalculation1.ipMaxFrzPu,Unit.wecc_reec.currentLimitsCalculation1.vDip,Unit.wecc_reec.iqInjectionLogic.vDipInjEndTime,Unit.wecc_reec.iqInjectionLogic.vDip,Unit.injector.running,Unit.wecc_repc.freeze,Unit.wecc_regc.and2.y,Unit.wecc_regc.and1.y,Unit.wecc_regc.and1.u[2],Unit.wecc_regc.offDelay.tNext,Unit.wecc_regc.offDelay.delaySignal,Unit.wecc_regc.offDelay.u,Unit.HvTfo.running,infiniteBusFromTable.tableUPhase.nextTimeEventScaled,$PRE.infiniteBusFromTable.tableUPhase.nextTimeEventScaled,infiniteBusFromTable.tableUPhase.nextTimeEvent,infiniteBusFromTable.tableUPu.nextTimeEventScaled,$PRE.infiniteBusFromTable.tableUPu.nextTimeEventScaled,infiniteBusFromTable.tableUPu.nextTimeEvent,$whenCondition4,$whenCondition3,$whenCondition5,$whenCondition7,$whenCondition6,$whenCondition9,$whenCondition8,$whenCondition10,$whenCondition12,$whenCondition11,$whenCondition14,$whenCondition13,$whenCondition16,$whenCondition15,$whenCondition18,$whenCondition17,$whenCondition19)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (552):
 * Single equations (assignments): 550
 * Array equations: 0
 * Algorithm blocks: 1
 * 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
   {(6,4,72.2%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.000914/0.3603, allocations: 0.591 MB / 0.49 GB, free: 57.46 MB / 442.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0006824/0.361, allocations: 375.7 kB / 0.4903 GB, free: 57.23 MB / 442.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002374/0.3633, allocations: 1.64 MB / 0.4919 GB, free: 56.21 MB / 442.7 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.304e-05/0.3634, allocations: 28 kB / 0.492 GB, free: 56.18 MB / 442.7 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 8.035e-06/0.3634, allocations: 7.469 kB / 0.492 GB, free: 56.18 MB / 442.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.814e-05/0.3634, allocations: 17.05 kB / 0.492 GB, free: 56.18 MB / 442.7 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.005528/0.3689, allocations: 4.001 MB / 0.4959 GB, free: 53.01 MB / 442.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 8.225e-06/0.3689, allocations: 7.938 kB / 0.4959 GB, free: 53 MB / 442.7 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002544/0.3715, allocations: 0.9667 MB / 0.4968 GB, free: 52.08 MB / 442.7 MB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0004186/0.3719, allocations: 209.9 kB / 0.497 GB, free: 51.9 MB / 442.7 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001702/0.372, allocations: 73.7 kB / 0.4971 GB, free: 51.87 MB / 442.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001187/0.3732, allocations: 1.611 MB / 0.4987 GB, free: 50.35 MB / 442.7 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.148e-06/0.3732, allocations: 7.094 kB / 0.4987 GB, free: 50.35 MB / 442.7 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.003013/0.3763, allocations: 2.49 MB / 0.5011 GB, free: 47.89 MB / 442.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.001125/0.3774, allocations: 0.4902 MB / 0.5016 GB, free: 47.41 MB / 442.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0004046/0.3778, allocations: 92.3 kB / 0.5017 GB, free: 47.37 MB / 442.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001074/0.3789, allocations: 205.2 kB / 0.5019 GB, free: 47.21 MB / 442.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0003556/0.3792, allocations: 278.5 kB / 0.5022 GB, free: 47 MB / 442.7 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001136/0.3793, allocations: 78.38 kB / 0.5022 GB, free: 46.94 MB / 442.7 MB
Notification: Performance of sorting global known variables: time 0.001493/0.3808, allocations: 1.739 MB / 0.5039 GB, free: 45.48 MB / 442.7 MB
Notification: Performance of sort global known variables: time 2e-07/0.3808, allocations: 0 / 0.5039 GB, free: 45.48 MB / 442.7 MB
Notification: Performance of remove unused functions: time 0.003464/0.3843, allocations: 2.008 MB / 0.5059 GB, free: 43.66 MB / 442.7 MB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 24
 * Number of states: 28 (Unit.wecc_wtgp.limitedIntegrator.y,Unit.wecc_wtgp.limitedIntegrator1.y,Unit.wecc_wtgp.absLimRateLimFirstOrderFreeze.integrator.y,Unit.wecc_wtgq.firstOrder.y,Unit.wecc_wtgq.firstOrder1.y,Unit.wecc_wtgq.limitedIntegratorFreeze.y,Unit.wecc_wtgt.dPhi.y,Unit.wecc_wtgt.dOmegaTurbine.y,Unit.wecc_wtgt.dOmegaGenerator.y,Unit.wecc_regc.rateLimFirstOrderFreeze2.y,Unit.wecc_regc.rateLimFirstOrderFreeze1.y,Unit.wecc_regc.firstOrder.y,Unit.wecc_repc.firstOrder.y,Unit.wecc_repc.limPID.I.y,Unit.wecc_repc.firstOrder1.y,Unit.wecc_repc.firstOrder2.y,Unit.wecc_repc.firstOrder3.y,Unit.wecc_repc.limPIDFreeze.I.y,Unit.wecc_repc.leadLag.x_scaled[1],Unit.pll.integrator.y,Unit.pll.limIntegrator.y,Unit.wecc_reec.firstOrder.y,Unit.wecc_reec.firstOrder1.y,Unit.wecc_reec.limPIDFreeze.I.y,Unit.wecc_reec.rateLimFirstOrderFreeze1.y,Unit.wecc_reec.slewRateLimiter.y,Unit.wecc_reec.rateLimFirstOrderFreeze.y,Unit.wecc_reec.varLimPIDFreeze.I.y)
 * Number of discrete variables: 44 ($whenCondition19,$whenCondition17,$whenCondition18,$whenCondition15,$whenCondition16,$whenCondition13,$whenCondition14,$whenCondition11,$whenCondition12,$whenCondition10,$whenCondition8,$whenCondition9,$whenCondition6,$whenCondition7,$whenCondition5,$whenCondition3,$whenCondition4,$whenCondition2,$whenCondition1,infiniteBusFromTable.tableUPu.nextTimeEvent,infiniteBusFromTable.tableUPu.nextTimeEventScaled,infiniteBusFromTable.tableUPhase.nextTimeEvent,infiniteBusFromTable.tableUPhase.nextTimeEventScaled,Unit.HvTfo.running,Unit.HvTfo.state,Unit.wecc_regc.offDelay.u,Unit.wecc_regc.offDelay.delaySignal,Unit.wecc_regc.offDelay.tNext,Unit.wecc_regc.and1.u[2],Unit.wecc_regc.and1.y,Unit.wecc_regc.and2.y,Unit.wecc_repc.freeze,Unit.injector.running,Unit.injector.state,Unit.wecc_reec.iqInjectionLogic.vDip,Unit.wecc_reec.iqInjectionLogic.vDipInjEndTime,Unit.wecc_reec.currentLimitsCalculation1.vDip,Unit.wecc_reec.currentLimitsCalculation1.ipMaxFrzPu,Unit.wecc_reec.currentLimitsCalculation1.vDipFrzEndTime,Unit.LvTfo.running,Unit.LvTfo.state,$whenCondition20,infiniteBusFromTable.tableOmegaRefPu.nextTimeEvent,infiniteBusFromTable.tableOmegaRefPu.nextTimeEventScaled)
 * Number of discrete states: 15 (infiniteBusFromTable.tableOmegaRefPu.nextTimeEventScaled,infiniteBusFromTable.tableOmegaRefPu.nextTimeEvent,Unit.LvTfo.running,Unit.injector.running,Unit.HvTfo.running,infiniteBusFromTable.tableUPhase.nextTimeEvent,infiniteBusFromTable.tableUPu.nextTimeEvent,infiniteBusFromTable.tableUPhase.nextTimeEventScaled,infiniteBusFromTable.tableUPu.nextTimeEventScaled,Unit.wecc_regc.offDelay.u,Unit.wecc_reec.currentLimitsCalculation1.vDip,Unit.wecc_reec.currentLimitsCalculation1.vDipFrzEndTime,Unit.wecc_reec.currentLimitsCalculation1.ipMaxPu,Unit.wecc_reec.iqInjectionLogic.vDip,Unit.wecc_reec.iqInjectionLogic.vDipInjEndTime)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (293):
 * Single equations (assignments): 275
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 17
 * 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
   {(6,4,72.2%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of Backend phase and start with SimCode phase: time 0.00209/0.3864, allocations: 1.049 MB / 0.5069 GB, free: 43.2 MB / 442.7 MB
Notification: Performance of simCode: created initialization part: time 0.005551/0.3919, allocations: 4.197 MB / 0.511 GB, free: 39.53 MB / 442.7 MB
Notification: Performance of simCode: created event and clocks part: time 5.723e-05/0.392, allocations: 44.5 kB / 0.5111 GB, free: 39.48 MB / 442.7 MB
Notification: Performance of simCode: created simulation system equations: time 0.001333/0.3933, allocations: 0.9913 MB / 0.512 GB, free: 38.62 MB / 442.7 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002751/0.3961, allocations: 0.8038 MB / 0.5128 GB, free: 38.08 MB / 442.7 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01061/0.4067, allocations: 7.899 MB / 0.5205 GB, free: 30.21 MB / 442.7 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0005449/0.4072, allocations: 0.7626 MB / 0.5213 GB, free: 29.43 MB / 442.7 MB
Notification: Performance of simCode: alias equations: time 0.002278/0.4095, allocations: 0.6253 MB / 0.5219 GB, free: 28.8 MB / 442.7 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001494/0.411, allocations: 0.7499 MB / 0.5226 GB, free: 28.06 MB / 442.7 MB
Notification: Performance of SimCode: time 2.113e-06/0.411, allocations: 0 / 0.5226 GB, free: 28.06 MB / 442.7 MB
Notification: Performance of Templates: time 0.06954/0.4805, allocations: 58.46 MB / 0.5797 GB, free: 2.137 MB / 474.7 MB
"
[Timeout remaining time 660]
make -j1 -f Dynawo_dev_Dynawo.Examples.GridCodeSimulations.SheetSimulations.SheetI7QMin.makefile [Timeout 660]
(rm -f Dynawo_dev_Dynawo.Examples.GridCodeSimulations.SheetSimulations.SheetI7QMin.pipe ; mkfifo Dynawo_dev_Dynawo.Examples.GridCodeSimulations.SheetSimulations.SheetI7QMin.pipe ; head -c 1048576 < Dynawo_dev_Dynawo.Examples.GridCodeSimulations.SheetSimulations.SheetI7QMin.pipe >> ../files/Dynawo_dev_Dynawo.Examples.GridCodeSimulations.SheetSimulations.SheetI7QMin.sim & ./Dynawo_dev_Dynawo.Examples.GridCodeSimulations.SheetSimulations.SheetI7QMin  -lv=LOG_STDOUT,LOG_ASSERT,LOG_STATS -s=ida -variableFilter=.* -abortSlowSimulation -alarm=240 -s gbode -gbm=radauIIA3 -emit_protected -lv LOG_STATS > Dynawo_dev_Dynawo.Examples.GridCodeSimulations.SheetSimulations.SheetI7QMin.pipe 2>&1) [Timeout 240]
diffSimulationResults("Dynawo_dev_Dynawo.Examples.GridCodeSimulations.SheetSimulations.SheetI7QMin_res.mat","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/ReferenceFiles/Dynawo/dynawo/sources/Models/Modelica/Dynawo/Examples/references/Dynawo.Examples.GridCodeSimulations.SheetSimulations.SheetI7QMin_res.csv","",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 660]
""
[Timeout remaining time 659]
Reference file matches
[Calling sys.exit(0), Time elapsed: 5.439293371979147]