Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Dynawo_dev_Dynawo.Examples.Wind.WECC.WT3CurrentSource1.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.001332/0.001332, allocations: 108.3 kB / 19.73 MB, free: 1.898 MB / 14.72 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.001491/0.001491, allocations: 214.3 kB / 23.01 MB, free: 4.992 MB / 14.72 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 1.355/1.355, allocations: 207.7 MB / 233.9 MB, free: 9.809 MB / 190.1 MB " [Timeout remaining time 178] 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.6537/0.6537, allocations: 121.9 MB / 408 MB, free: 11.02 MB / 318.1 MB " [Timeout remaining time 179] Using package Dynawo with version 1.8.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) Ignoring simflag -noemit -noHomotopyOnFirstTry=() since it seems broken on HelloWorld Ignoring simflag -noemit -noRestart=() since it seems broken on HelloWorld Ignoring simflag -noemit -noRootFinding=() since it seems broken on HelloWorld Running command: translateModel(Dynawo.Examples.Wind.WECC.WT3CurrentSource1,tolerance=1e-05,outputFormat="mat",numberOfIntervals=20000,variableFilter="time|WT3.injector.PInjPu|WT3.injector.QInjPu|WT3.injector.UPu",fileNamePrefix="Dynawo_dev_Dynawo.Examples.Wind.WECC.WT3CurrentSource1") translateModel(Dynawo.Examples.Wind.WECC.WT3CurrentSource1,tolerance=1e-05,outputFormat="mat",numberOfIntervals=20000,variableFilter="time|WT3.injector.PInjPu|WT3.injector.QInjPu|WT3.injector.UPu",fileNamePrefix="Dynawo_dev_Dynawo.Examples.Wind.WECC.WT3CurrentSource1") [Timeout 660] "Notification: Modelica requested package Complex of version 3.2.3. Complex 4.1.0 is used instead which states that it is fully compatible without conversion script needed. Notification: Modelica requested package ModelicaServices of version 3.2.3. ModelicaServices 4.1.0 is used instead which states that it is fully compatible without conversion script needed. Notification: Performance of FrontEnd - loaded program: time 0.003752/0.003752, allocations: 77.31 kB / 0.5798 GB, free: 37.19 MB / 462.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.157/0.1607, allocations: 80.71 MB / 0.6586 GB, free: 88 kB / 494.1 MB Notification: Performance of NFInst.instantiate(Dynawo.Examples.Wind.WECC.WT3CurrentSource1): time 0.01596/0.1767, allocations: 11.78 MB / 0.6701 GB, free: 4.234 MB / 0.4981 GB Notification: Performance of NFInst.instExpressions: time 0.01187/0.1886, allocations: 6.02 MB / 0.676 GB, free: 14.2 MB / 0.5137 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.002674/0.1912, allocations: 79.33 kB / 0.6761 GB, free: 14.12 MB / 0.5137 GB Notification: Performance of NFTyping.typeComponents: time 0.002493/0.1937, allocations: 0.826 MB / 0.6769 GB, free: 13.29 MB / 0.5137 GB [/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.004416/0.1981, allocations: 1.204 MB / 0.6781 GB, free: 12.08 MB / 0.5137 GB [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo master/Electrical/Controls/WECC/BaseClasses_INIT/WECCInverterCurrentSource_INIT.mo:94:3-94:90:writable] Warning: In relation Modelica.ComplexMath.'abs'(weccInverterCurrentSource_INIT.s0Pu) == 0.0, == on Real numbers is only allowed inside functions. Notification: Performance of NFTyping.typeClassSections: time 0.006012/0.2042, allocations: 2.6 MB / 0.6806 GB, free: 9.492 MB / 0.5137 GB Notification: Performance of NFFlatten.flatten: time 0.006595/0.2108, allocations: 4.506 MB / 0.685 GB, free: 4.98 MB / 0.5137 GB Notification: Performance of NFFlatten.resolveConnections: time 0.002778/0.2135, allocations: 1.076 MB / 0.686 GB, free: 3.832 MB / 0.5137 GB Notification: Performance of NFEvalConstants.evaluate: time 0.002953/0.2165, allocations: 1.665 MB / 0.6877 GB, free: 2.16 MB / 0.5137 GB Notification: Performance of NFSimplifyModel.simplify: time 0.002659/0.2191, allocations: 1.616 MB / 0.6893 GB, free: 0.5352 MB / 0.5137 GB Notification: Performance of NFPackage.collectConstants: time 0.001184/0.2203, allocations: 484 kB / 0.6897 GB, free: 64 kB / 0.5137 GB Notification: Performance of NFFlatten.collectFunctions: time 0.001849/0.2222, allocations: 0.742 MB / 0.6904 GB, free: 15.32 MB / 0.5294 GB Notification: Performance of NFScalarize.scalarize: time 0.00139/0.2236, allocations: 1.012 MB / 0.6914 GB, free: 14.3 MB / 0.5294 GB Notification: Performance of NFVerifyModel.verify: time 0.002129/0.2257, allocations: 1.504 MB / 0.6929 GB, free: 12.79 MB / 0.5294 GB Notification: Performance of NFConvertDAE.convert: time 0.007225/0.2329, allocations: 5.974 MB / 0.6987 GB, free: 6.797 MB / 0.5294 GB Notification: Performance of FrontEnd - DAE generated: time 4.929e-06/0.2329, allocations: 0 / 0.6987 GB, free: 6.797 MB / 0.5294 GB Notification: Performance of FrontEnd: time 2.064e-06/0.2329, allocations: 0 / 0.6987 GB, free: 6.797 MB / 0.5294 GB Notification: Performance of Transformations before backend: time 0.0001033/0.233, allocations: 0 / 0.6987 GB, free: 6.797 MB / 0.5294 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 611 * Number of variables: 611 Notification: Performance of Generate backend data structure: time 0.01233/0.2454, allocations: 4.763 MB / 0.7034 GB, free: 1.949 MB / 0.5294 GB Notification: Performance of prepare preOptimizeDAE: time 4.35e-05/0.2454, allocations: 12.03 kB / 0.7034 GB, free: 1.938 MB / 0.5294 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003721/0.2491, allocations: 0.7985 MB / 0.7042 GB, free: 1.137 MB / 0.5294 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.004159/0.2533, allocations: 2.312 MB / 0.7064 GB, free: 14.77 MB / 0.545 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0008591/0.2542, allocations: 0.9613 MB / 0.7074 GB, free: 13.63 MB / 0.545 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0004183/0.2546, allocations: 255.9 kB / 0.7076 GB, free: 13.38 MB / 0.545 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.006318/0.2609, allocations: 3.33 MB / 0.7109 GB, free: 9.809 MB / 0.545 GB Notification: Performance of preOpt findStateOrder (simulation): time 5.366e-05/0.2609, allocations: 7.938 kB / 0.7109 GB, free: 9.801 MB / 0.545 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002555/0.2612, allocations: 108 kB / 0.711 GB, free: 9.695 MB / 0.545 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.098e-05/0.2612, allocations: 60 kB / 0.711 GB, free: 9.637 MB / 0.545 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.005787/0.267, allocations: 2.504 MB / 0.7135 GB, free: 7.117 MB / 0.545 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.0162/0.2832, allocations: 9.162 MB / 0.7224 GB, free: 13.77 MB / 0.5606 GB Notification: Performance of preOpt comSubExp (simulation): time 0.006537/0.2898, allocations: 2.396 MB / 0.7248 GB, free: 11.36 MB / 0.5606 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.002623/0.2924, allocations: 1.085 MB / 0.7258 GB, free: 10.27 MB / 0.5606 GB Notification: Performance of preOpt evalFunc (simulation): time 0.0001986/0.2926, allocations: 41.92 kB / 0.7259 GB, free: 10.23 MB / 0.5606 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.003422/0.296, allocations: 1.598 MB / 0.7274 GB, free: 8.605 MB / 0.5606 GB Notification: Performance of pre-optimization done (n=200): time 4.319e-06/0.296, allocations: 0 / 0.7274 GB, free: 8.605 MB / 0.5606 GB Notification: Performance of matching and sorting (n=200): time 0.01057/0.3066, allocations: 3.881 MB / 0.7312 GB, free: 4.723 MB / 0.5606 GB Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002191/0.3068, allocations: 376.1 kB / 0.7316 GB, free: 4.277 MB / 0.5606 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.004286/0.3111, allocations: 2.784 MB / 0.7343 GB, free: 1.473 MB / 0.5606 GB Notification: Performance of collectPreVariables (initialization): time 0.0003269/0.3114, allocations: 77.7 kB / 0.7344 GB, free: 1.391 MB / 0.5606 GB Notification: Performance of collectInitialEqns (initialization): time 0.001408/0.3128, allocations: 1.45 MB / 0.7358 GB, free: 15.93 MB / 0.5762 GB Notification: Performance of collectInitialBindings (initialization): time 0.0008683/0.3137, allocations: 0.713 MB / 0.7365 GB, free: 15.21 MB / 0.5762 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.001024/0.3147, allocations: 0.5691 MB / 0.737 GB, free: 14.63 MB / 0.5762 GB Notification: Performance of setup shared object (initialization): time 0.0001412/0.3149, allocations: 301.1 kB / 0.7373 GB, free: 14.33 MB / 0.5762 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.00306/0.3179, allocations: 1.356 MB / 0.7386 GB, free: 12.96 MB / 0.5762 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.003882/0.3218, allocations: 2.113 MB / 0.7407 GB, free: 10.62 MB / 0.5762 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.02136/0.3432, allocations: 6.688 MB / 0.7472 GB, free: 3.73 MB / 0.5762 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.926e-05/0.3432, allocations: 8 kB / 0.7472 GB, free: 3.723 MB / 0.5762 GB Notification: Performance of matching and sorting (n=403) (initialization): time 0.00929/0.3525, allocations: 3.957 MB / 0.7511 GB, free: 15.71 MB / 0.5919 GB Notification: Performance of prepare postOptimizeDAE: time 7.918e-05/0.3525, allocations: 57.67 kB / 0.7512 GB, free: 15.65 MB / 0.5919 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.123e-05/0.3526, allocations: 12 kB / 0.7512 GB, free: 15.64 MB / 0.5919 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.0005916/0.3532, allocations: 265.6 kB / 0.7514 GB, free: 15.38 MB / 0.5919 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005466/0.3586, allocations: 1.143 MB / 0.7525 GB, free: 14.23 MB / 0.5919 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003713/0.3623, allocations: 2.453 MB / 0.7549 GB, free: 11.68 MB / 0.5919 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002708/0.365, allocations: 362.2 kB / 0.7553 GB, free: 11.32 MB / 0.5919 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002876/0.3653, allocations: 108 kB / 0.7554 GB, free: 11.22 MB / 0.5919 GB Warning: Assuming fixed start value for the following 28 variables: WT3.LvTfo.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = WT3.LvTfo.State0 fixed = true ) \"Transformer connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) WT3.injector.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = WT3.injector.State0 fixed = true ) \"Injector connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) line.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = line.State0 fixed = true ) \"Line connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) line.running:DISCRETE(flow=false start = line.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean WT3.wecc_wtgp.limitedIntegrator.y:VARIABLE(flow=false start = WT3.wecc_wtgp.limitedIntegrator.Y0 fixed = true ) \"Connector of Real output signal\" type: Real WT3.wecc_wtgp.limitedIntegrator1.y:VARIABLE(flow=false start = WT3.wecc_wtgp.limitedIntegrator1.Y0 fixed = true ) \"Connector of Real output signal\" type: Real WT3.wecc_wtgq.firstOrder.y:VARIABLE(flow=false start = WT3.wecc_wtgq.firstOrder.y_start fixed = true ) \"Connector of Real output signal\" type: Real WT3.wecc_wtgq.firstOrder1.y:VARIABLE(flow=false start = WT3.wecc_wtgp.omegaRefWTGQPu0 fixed = true ) \"Connector of Real output signal\" type: Real WT3.wecc_wtgq.limitedIntegratorFreeze.y:VARIABLE(flow=false start = WT3.wecc_wtgq.limitedIntegratorFreeze.Y0 fixed = true ) \"Connector of Real output signal\" type: Real WT3.wecc_regc.rateLimFirstOrderFreeze2.y:VARIABLE(flow=false start = WT3.wecc_regc.rateLimFirstOrderFreeze2.Y0 fixed = true ) \"Connector of Real output signal\" type: Real WT3.wecc_regc.rateLimFirstOrderFreeze1.y:VARIABLE(flow=false start = WT3.wecc_regc.rateLimFirstOrderFreeze1.Y0 fixed = true ) \"Connector of Real output signal\" type: Real WT3.wecc_regc.firstOrder.y:VARIABLE(flow=false start = WT3.wecc_regc.firstOrder.y_start fixed = true ) \"Connector of Real output signal\" type: Real WT3.wecc_regc.offDelay.delaySignal:DISCRETE(start = false fixed = true protected = true ) type: Boolean WT3.wecc_regc.offDelay.tNext:DISCRETE(start = -1.0 unit = \"s\" fixed = true protected = true ) type: Real WT3.injector.running:DISCRETE(flow=false start = WT3.injector.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean WT3.wecc_reec.firstOrder.y:VARIABLE(flow=false start = WT3.wecc_reec.UConv0Pu fixed = true ) \"Connector of Real output signal\" type: Real WT3.wecc_reec.firstOrder1.y:VARIABLE(flow=false start = WT3.wecc_reec.firstOrder1.y_start fixed = true ) \"Connector of Real output signal\" type: Real WT3.wecc_reec.limPIDFreeze.I.y:VARIABLE(flow=false start = WT3.wecc_reec.limPIDFreeze.I.Y0 fixed = true ) \"Connector of Real output signal\" type: Real WT3.wecc_reec.rateLimFirstOrderFreeze1.y:VARIABLE(flow=false start = WT3.wecc_reec.rateLimFirstOrderFreeze1.Y0 fixed = true ) \"Connector of Real output signal\" type: Real WT3.wecc_reec.rateLimFirstOrderFreeze.y:VARIABLE(flow=false start = WT3.wecc_wtgp.PConv0Pu fixed = true ) \"Connector of Real output signal\" type: Real WT3.wecc_reec.varLimPIDFreeze.I.y:VARIABLE(flow=false start = WT3.wecc_reec.varLimPIDFreeze.I.Y0 fixed = true ) \"Connector of Real output signal\" type: Real WT3.wecc_reec.iqInjectionLogic.vDip:DISCRETE(flow=false start = false fixed = true ) \"Ongoing voltage dip\" type: Boolean WT3.wecc_reec.iqInjectionLogic.vDipInjEndTime:DISCRETE(start = -1.0 unit = \"s\" fixed = true ) \"ending time of the voltage dip start (in seconds)\" type: Real WT3.wecc_reec.currentLimitsCalculation1.ipMaxFrzPu:DISCRETE(start = 0.0 unit = \"1\" fixed = true ) type: Real WT3.wecc_reec.currentLimitsCalculation1.vDipFrzEndTime:DISCRETE(start = -1.0 unit = \"s\" fixed = true ) type: Real WT3.LvTfo.running:DISCRETE(flow=false start = WT3.LvTfo.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean WT3.wecc_reec.currentLimitsCalculation1.vDip:DISCRETE(flow=false fixed = true ) \"Ongoing voltage dip\" type: Boolean WT3.wecc_regc.offDelay.u:DISCRETE(flow=false fixed = true ) \"Boolean input signal\" type: Boolean Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.00453/0.3699, allocations: 1.996 MB / 0.7573 GB, free: 9.215 MB / 0.5919 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.00368/0.3735, allocations: 2.101 MB / 0.7594 GB, free: 6.879 MB / 0.5919 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.0218/0.3954, allocations: 6.664 MB / 0.7659 GB, free: 16 kB / 0.5919 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.239e-05/0.3954, allocations: 3.984 kB / 0.7659 GB, free: 12 kB / 0.5919 GB Notification: Performance of matching and sorting (n=403) (initialization_lambda0): time 0.009764/0.4051, allocations: 3.939 MB / 0.7698 GB, free: 12.02 MB / 0.6075 GB Notification: Performance of prepare postOptimizeDAE: time 7.217e-05/0.4052, allocations: 57.67 kB / 0.7698 GB, free: 11.96 MB / 0.6075 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.606e-05/0.4052, allocations: 8 kB / 0.7698 GB, free: 11.95 MB / 0.6075 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.0005506/0.4058, allocations: 281.1 kB / 0.7701 GB, free: 11.67 MB / 0.6075 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005357/0.4111, allocations: 1.124 MB / 0.7712 GB, free: 10.55 MB / 0.6075 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003573/0.4147, allocations: 2.44 MB / 0.7736 GB, free: 8.012 MB / 0.6075 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002662/0.4174, allocations: 354.5 kB / 0.7739 GB, free: 7.664 MB / 0.6075 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002435/0.4176, allocations: 108 kB / 0.774 GB, free: 7.559 MB / 0.6075 GB Warning: Assuming fixed start value for the following 28 variables: WT3.LvTfo.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = WT3.LvTfo.State0 fixed = true ) \"Transformer connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) WT3.injector.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = WT3.injector.State0 fixed = true ) \"Injector connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) line.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = line.State0 fixed = true ) \"Line connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) line.running:DISCRETE(flow=false start = line.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean WT3.wecc_wtgp.limitedIntegrator.y:VARIABLE(flow=false start = WT3.wecc_wtgp.limitedIntegrator.Y0 fixed = true ) \"Connector of Real output signal\" type: Real WT3.wecc_wtgp.limitedIntegrator1.y:VARIABLE(flow=false start = WT3.wecc_wtgp.limitedIntegrator1.Y0 fixed = true ) \"Connector of Real output signal\" type: Real WT3.wecc_wtgq.firstOrder.y:VARIABLE(flow=false start = WT3.wecc_wtgq.firstOrder.y_start fixed = true ) \"Connector of Real output signal\" type: Real WT3.wecc_wtgq.firstOrder1.y:VARIABLE(flow=false start = WT3.wecc_wtgp.omegaRefWTGQPu0 fixed = true ) \"Connector of Real output signal\" type: Real WT3.wecc_wtgq.limitedIntegratorFreeze.y:VARIABLE(flow=false start = WT3.wecc_wtgq.limitedIntegratorFreeze.Y0 fixed = true ) \"Connector of Real output signal\" type: Real WT3.wecc_regc.rateLimFirstOrderFreeze2.y:VARIABLE(flow=false start = WT3.wecc_regc.rateLimFirstOrderFreeze2.Y0 fixed = true ) \"Connector of Real output signal\" type: Real WT3.wecc_regc.rateLimFirstOrderFreeze1.y:VARIABLE(flow=false start = WT3.wecc_regc.rateLimFirstOrderFreeze1.Y0 fixed = true ) \"Connector of Real output signal\" type: Real WT3.wecc_regc.firstOrder.y:VARIABLE(flow=false start = WT3.wecc_regc.firstOrder.y_start fixed = true ) \"Connector of Real output signal\" type: Real WT3.wecc_regc.offDelay.delaySignal:DISCRETE(start = false fixed = true protected = true ) type: Boolean WT3.wecc_regc.offDelay.tNext:DISCRETE(start = -1.0 unit = \"s\" fixed = true protected = true ) type: Real WT3.injector.running:DISCRETE(flow=false start = WT3.injector.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean WT3.wecc_reec.firstOrder.y:VARIABLE(flow=false start = WT3.wecc_reec.UConv0Pu fixed = true ) \"Connector of Real output signal\" type: Real WT3.wecc_reec.firstOrder1.y:VARIABLE(flow=false start = WT3.wecc_reec.firstOrder1.y_start fixed = true ) \"Connector of Real output signal\" type: Real WT3.wecc_reec.limPIDFreeze.I.y:VARIABLE(flow=false start = WT3.wecc_reec.limPIDFreeze.I.Y0 fixed = true ) \"Connector of Real output signal\" type: Real WT3.wecc_reec.rateLimFirstOrderFreeze1.y:VARIABLE(flow=false start = WT3.wecc_reec.rateLimFirstOrderFreeze1.Y0 fixed = true ) \"Connector of Real output signal\" type: Real WT3.wecc_reec.rateLimFirstOrderFreeze.y:VARIABLE(flow=false start = WT3.wecc_wtgp.PConv0Pu fixed = true ) \"Connector of Real output signal\" type: Real WT3.wecc_reec.varLimPIDFreeze.I.y:VARIABLE(flow=false start = WT3.wecc_reec.varLimPIDFreeze.I.Y0 fixed = true ) \"Connector of Real output signal\" type: Real WT3.wecc_reec.iqInjectionLogic.vDip:DISCRETE(flow=false start = false fixed = true ) \"Ongoing voltage dip\" type: Boolean WT3.wecc_reec.iqInjectionLogic.vDipInjEndTime:DISCRETE(start = -1.0 unit = \"s\" fixed = true ) \"ending time of the voltage dip start (in seconds)\" type: Real WT3.wecc_reec.currentLimitsCalculation1.ipMaxFrzPu:DISCRETE(start = 0.0 unit = \"1\" fixed = true ) type: Real WT3.wecc_reec.currentLimitsCalculation1.vDipFrzEndTime:DISCRETE(start = -1.0 unit = \"s\" fixed = true ) type: Real WT3.LvTfo.running:DISCRETE(flow=false start = WT3.LvTfo.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean WT3.wecc_reec.currentLimitsCalculation1.vDip:DISCRETE(flow=false fixed = true ) \"Ongoing voltage dip\" type: Boolean WT3.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: 43 * Number of states: 0 () * Number of discrete variables: 65 ($PRE.WT3.LvTfo.state,WT3.LvTfo.state,$PRE.WT3.injector.state,WT3.injector.state,$PRE.line.state,line.state,WT3.injector.switchOffSignal3,WT3.injector.switchOffSignal2,WT3.injector.switchOffSignal1,line.switchOffSignal2,line.switchOffSignal1,WT3.wecc_regc.rateLimFirstOrderFreeze1.local_freeze,WT3.wecc_regc.rateLimFirstOrderFreeze2.local_freeze,$PRE.line.running,$PRE.WT3.wecc_regc.offDelay.delaySignal,$PRE.WT3.wecc_regc.offDelay.tNext,$PRE.WT3.injector.running,$PRE.WT3.wecc_reec.iqInjectionLogic.vDip,$PRE.WT3.wecc_reec.iqInjectionLogic.vDipInjEndTime,$PRE.WT3.wecc_reec.currentLimitsCalculation1.ipMaxFrzPu,$PRE.WT3.wecc_reec.currentLimitsCalculation1.vDipFrzEndTime,$PRE.WT3.LvTfo.running,WT3.wecc_regc.QConv0PuNeg.k,WT3.wecc_regc.QConv0PuPos.k,$PRE.WT3.wecc_reec.currentLimitsCalculation1.vDip,$PRE.WT3.wecc_regc.offDelay.u,WT3.LvTfo.running,WT3.wecc_reec.currentLimitsCalculation1.vDipFrzEndTime,WT3.wecc_reec.currentLimitsCalculation1.ipMaxFrzPu,WT3.wecc_reec.currentLimitsCalculation1.vDip,WT3.wecc_reec.iqInjectionLogic.vDipInjEndTime,WT3.wecc_reec.iqInjectionLogic.vDip,WT3.injector.running,WT3.wecc_regc.and2.y,WT3.wecc_regc.and1.y,WT3.wecc_regc.and1.u[2],WT3.wecc_regc.offDelay.tNext,WT3.wecc_regc.offDelay.delaySignal,WT3.wecc_regc.offDelay.u,line.running,$whenCondition2,$whenCondition1,$whenCondition3,$whenCondition5,$whenCondition4,$whenCondition7,$whenCondition6,$whenCondition8,$whenCondition10,$whenCondition9,$whenCondition12,$whenCondition11,$whenCondition14,$whenCondition13,$whenCondition16,$whenCondition15,$whenCondition17,WT3.wecc_reec.varLimPIDFreeze.I.resetLocal,WT3.wecc_reec.limPIDFreeze.I.resetLocal,WT3.pll.limIntegrator.local_reset,WT3.pll.integrator.local_reset,WT3.wecc_wtgt.dOmegaGenerator.local_reset,WT3.wecc_wtgt.dOmegaTurbine.local_reset,WT3.wecc_wtgt.dPhi.local_reset,WT3.wecc_wtgp.absLimRateLimFirstOrderFreeze.integrator.local_reset) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (376): * Single equations (assignments): 374 * 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 {(8,2,50.0%)} * Non-linear torn systems (#iteration vars, #inner vars): 0 systems Notification: Performance of prepare postOptimizeDAE: time 0.001006/0.4186, allocations: 494.7 kB / 0.7745 GB, free: 7.09 MB / 0.6075 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0006711/0.4193, allocations: 322 kB / 0.7748 GB, free: 6.773 MB / 0.6075 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.007461/0.4267, allocations: 2.951 MB / 0.7777 GB, free: 3.801 MB / 0.6075 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.245e-05/0.4268, allocations: 20 kB / 0.7777 GB, free: 3.781 MB / 0.6075 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 8.617e-06/0.4268, allocations: 4 kB / 0.7777 GB, free: 3.777 MB / 0.6075 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.985e-05/0.4268, allocations: 11.97 kB / 0.7777 GB, free: 3.766 MB / 0.6075 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.2875/0.7143, allocations: 5.674 MB / 0.7832 GB, free: 118.4 MB / 0.6075 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.143e-05/0.7143, allocations: 4.062 kB / 0.7832 GB, free: 118.4 MB / 0.6075 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.005179/0.7195, allocations: 0.8981 MB / 0.7841 GB, free: 118.4 MB / 0.6075 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.0005088/0.72, allocations: 257.4 kB / 0.7844 GB, free: 118.4 MB / 0.6075 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0002144/0.7202, allocations: 60.34 kB / 0.7844 GB, free: 118.4 MB / 0.6075 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.003346/0.7236, allocations: 2.436 MB / 0.7868 GB, free: 117.2 MB / 0.6075 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.6e-06/0.7236, allocations: 4.234 kB / 0.7868 GB, free: 117.2 MB / 0.6075 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.009836/0.7334, allocations: 4.621 MB / 0.7913 GB, free: 115.6 MB / 0.6075 GB Notification: Performance of postOpt removeConstants (simulation): time 0.001578/0.735, allocations: 0.6033 MB / 0.7919 GB, free: 115.4 MB / 0.6075 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0004604/0.7354, allocations: 60.19 kB / 0.792 GB, free: 115.4 MB / 0.6075 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001785/0.7372, allocations: 189.7 kB / 0.7921 GB, free: 115.3 MB / 0.6075 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0005465/0.7378, allocations: 233.7 kB / 0.7924 GB, free: 115.3 MB / 0.6075 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.000166/0.7379, allocations: 71.25 kB / 0.7924 GB, free: 115.3 MB / 0.6075 GB Notification: Performance of sorting global known variables: time 0.002691/0.7406, allocations: 1.819 MB / 0.7942 GB, free: 114.6 MB / 0.6075 GB Notification: Performance of sort global known variables: time 1.11e-07/0.7406, allocations: 0 / 0.7942 GB, free: 114.6 MB / 0.6075 GB Notification: Performance of remove unused functions: time 0.003403/0.744, allocations: 1.367 MB / 0.7955 GB, free: 114.4 MB / 0.6075 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 15 * Number of states: 21 (WT3.wecc_wtgp.limitedIntegrator.y,WT3.wecc_wtgp.limitedIntegrator1.y,WT3.wecc_wtgp.absLimRateLimFirstOrderFreeze.integrator.y,WT3.wecc_wtgq.firstOrder.y,WT3.wecc_wtgq.firstOrder1.y,WT3.wecc_wtgq.limitedIntegratorFreeze.y,WT3.wecc_wtgt.dPhi.y,WT3.wecc_wtgt.dOmegaTurbine.y,WT3.wecc_wtgt.dOmegaGenerator.y,WT3.wecc_regc.rateLimFirstOrderFreeze2.y,WT3.wecc_regc.rateLimFirstOrderFreeze1.y,WT3.wecc_regc.firstOrder.y,WT3.pll.integrator.y,WT3.pll.limIntegrator.y,WT3.wecc_reec.firstOrder.y,WT3.wecc_reec.firstOrder1.y,WT3.wecc_reec.limPIDFreeze.I.y,WT3.wecc_reec.rateLimFirstOrderFreeze1.y,WT3.wecc_reec.slewRateLimiter.y,WT3.wecc_reec.rateLimFirstOrderFreeze.y,WT3.wecc_reec.varLimPIDFreeze.I.y) * Number of discrete variables: 34 ($whenCondition17,$whenCondition15,$whenCondition16,$whenCondition13,$whenCondition14,$whenCondition11,$whenCondition12,$whenCondition9,$whenCondition10,$whenCondition8,$whenCondition6,$whenCondition7,$whenCondition4,$whenCondition5,$whenCondition3,$whenCondition1,$whenCondition2,line.running,line.state,WT3.wecc_regc.offDelay.u,WT3.wecc_regc.offDelay.delaySignal,WT3.wecc_regc.offDelay.tNext,WT3.wecc_regc.and1.u[2],WT3.wecc_regc.and1.y,WT3.wecc_regc.and2.y,WT3.injector.running,WT3.injector.state,WT3.wecc_reec.iqInjectionLogic.vDip,WT3.wecc_reec.iqInjectionLogic.vDipInjEndTime,WT3.wecc_reec.currentLimitsCalculation1.vDip,WT3.wecc_reec.currentLimitsCalculation1.ipMaxFrzPu,WT3.wecc_reec.currentLimitsCalculation1.vDipFrzEndTime,WT3.LvTfo.running,WT3.LvTfo.state) * Number of discrete states: 9 (WT3.LvTfo.running,WT3.injector.running,line.running,WT3.wecc_regc.offDelay.u,WT3.wecc_reec.currentLimitsCalculation1.vDip,WT3.wecc_reec.currentLimitsCalculation1.vDipFrzEndTime,WT3.wecc_reec.currentLimitsCalculation1.ipMaxPu,WT3.wecc_reec.iqInjectionLogic.vDip,WT3.wecc_reec.iqInjectionLogic.vDipInjEndTime) * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for simulation (199): * Single equations (assignments): 187 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 11 * 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 {(8,2,50.0%)} * Non-linear torn systems (#iteration vars, #inner vars): 0 systems Notification: Performance of Backend phase and start with SimCode phase: time 0.001661/0.7457, allocations: 0.5142 MB / 0.796 GB, free: 114.2 MB / 0.6075 GB Notification: Performance of simCode: created initialization part: time 0.01219/0.7579, allocations: 5.245 MB / 0.8012 GB, free: 112 MB / 0.6075 GB Notification: Performance of simCode: created event and clocks part: time 1.022e-05/0.7579, allocations: 1.375 kB / 0.8012 GB, free: 112 MB / 0.6075 GB Notification: Performance of simCode: created simulation system equations: time 0.003986/0.7619, allocations: 1.756 MB / 0.8029 GB, free: 111.3 MB / 0.6075 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002791/0.7647, allocations: 455.5 kB / 0.8033 GB, free: 111.1 MB / 0.6075 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01303/0.7777, allocations: 6.368 MB / 0.8095 GB, free: 108 MB / 0.6075 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001272/0.779, allocations: 1.341 MB / 0.8109 GB, free: 107.7 MB / 0.6075 GB Notification: Performance of simCode: alias equations: time 0.002192/0.7812, allocations: 408.6 kB / 0.8112 GB, free: 107.7 MB / 0.6075 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0007216/0.7819, allocations: 195.1 kB / 0.8114 GB, free: 107.6 MB / 0.6075 GB Notification: Performance of SimCode: time 9.51e-07/0.7819, allocations: 7.469 kB / 0.8114 GB, free: 107.6 MB / 0.6075 GB Notification: Performance of Templates: time 0.05822/0.8401, allocations: 42.24 MB / 0.8527 GB, free: 68.84 MB / 0.6075 GB " [Timeout remaining time 659] make -j1 -f Dynawo_dev_Dynawo.Examples.Wind.WECC.WT3CurrentSource1.makefile [Timeout 660] (rm -f Dynawo_dev_Dynawo.Examples.Wind.WECC.WT3CurrentSource1.pipe ; mkfifo Dynawo_dev_Dynawo.Examples.Wind.WECC.WT3CurrentSource1.pipe ; head -c 1048576 < Dynawo_dev_Dynawo.Examples.Wind.WECC.WT3CurrentSource1.pipe >> ../files/Dynawo_dev_Dynawo.Examples.Wind.WECC.WT3CurrentSource1.sim & ./Dynawo_dev_Dynawo.Examples.Wind.WECC.WT3CurrentSource1 -lv=LOG_STDOUT,LOG_ASSERT,LOG_STATS -s=ida -maxIntegrationOrder=2 -nls=kinsol -initialStepSize=0.00001 -maxStepSize=10 -variableFilter=.* -abortSlowSimulation -alarm=480 -emit_protected -lv LOG_STATS > Dynawo_dev_Dynawo.Examples.Wind.WECC.WT3CurrentSource1.pipe 2>&1) [Timeout 480] diffSimulationResults("Dynawo_dev_Dynawo.Examples.Wind.WECC.WT3CurrentSource1_res.mat","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/ReferenceFiles/Dynawo/dynawo/sources/Models/Modelica/Dynawo/Examples/references/Dynawo.Examples.Wind.WECC.WT3CurrentSource1_res.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Dynawo_dev_Dynawo.Examples.Wind.WECC.WT3CurrentSource1.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 660] "" [Timeout remaining time 660] Reference file matches [Calling sys.exit(0), Time elapsed: 7.921352855861187]