Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Dynawo_dev_Dynawo.Examples.Wind.IEC.Neplan.WT4BCurrentSource2015FOCB.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.001913/0.001913, allocations: 92.91 kB / 20.23 MB, free: 4.191 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.002019/0.002019, allocations: 161.3 kB / 23.55 MB, free: 0.8789 MB / 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 1.298/1.298, allocations: 158.6 MB / 185.4 MB, free: 2.867 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.6861/0.6861, allocations: 90.61 MB / 328.3 MB, free: 14.61 MB / 314.7 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 -emit_protected=() since the simulation runtime does not accept it Running command: translateModel(Dynawo.Examples.Wind.IEC.Neplan.WT4BCurrentSource2015FOCB,tolerance=1e-06,outputFormat="mat",numberOfIntervals=15000,variableFilter="time|wT4BCurrentSource.measurementsPQ.PPu|wT4BCurrentSource.measurementsPQ.QPu",fileNamePrefix="Dynawo_dev_Dynawo.Examples.Wind.IEC.Neplan.WT4BCurrentSource2015FOCB") translateModel(Dynawo.Examples.Wind.IEC.Neplan.WT4BCurrentSource2015FOCB,tolerance=1e-06,outputFormat="mat",numberOfIntervals=15000,variableFilter="time|wT4BCurrentSource.measurementsPQ.PPu|wT4BCurrentSource.measurementsPQ.QPu",fileNamePrefix="Dynawo_dev_Dynawo.Examples.Wind.IEC.Neplan.WT4BCurrentSource2015FOCB") [Timeout 660] "Notification: Performance of FrontEnd - loaded program: time 1.433e-06/1.433e-06, allocations: 0 / 432.3 MB, free: 7 MB / 410.7 MB Notification: Performance of FrontEnd - Absyn->SCode: time 2.384e-05/2.527e-05, allocations: 2.312 kB / 432.3 MB, free: 6.996 MB / 410.7 MB Notification: Performance of NFInst.instantiate(Dynawo.Examples.Wind.IEC.Neplan.WT4BCurrentSource2015FOCB): time 0.03315/0.03318, allocations: 21.25 MB / 453.5 MB, free: 1.652 MB / 426.7 MB Notification: Performance of NFInst.instExpressions: time 0.02267/0.05584, allocations: 10.2 MB / 463.7 MB, free: 7.43 MB / 442.7 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.006058/0.0619, allocations: 131.1 kB / 463.8 MB, free: 7.301 MB / 442.7 MB Notification: Performance of NFTyping.typeComponents: time 0.005519/0.06742, allocations: 1.987 MB / 465.8 MB, free: 5.297 MB / 442.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.00986/0.07728, allocations: 2.746 MB / 468.6 MB, free: 2.535 MB / 442.7 MB [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo master/Electrical/Transformers/TransformersFixedTap/TransformerFixedRatio.mo:66:5-70:11:writable] Warning: In relation transformer.terminal1.V.re == 0.0, == on Real operands is deprecated in non-function contexts. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo master/Electrical/Transformers/TransformersFixedTap/TransformerFixedRatio.mo:66:5-70:11:writable] Warning: In relation transformer.terminal1.V.im == 0.0, == on Real operands is deprecated in non-function contexts. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo master/Electrical/Transformers/TransformersFixedTap/TransformerFixedRatio.mo:71:5-75:11:writable] Warning: In relation transformer.terminal2.V.re == 0.0, == on Real operands is deprecated in non-function contexts. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo master/Electrical/Transformers/TransformersFixedTap/TransformerFixedRatio.mo:71:5-75:11:writable] Warning: In relation transformer.terminal2.V.im == 0.0, == on Real operands is deprecated in non-function contexts. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo master/Electrical/Transformers/TransformersFixedTap/TransformerFixedRatio.mo:66:5-70:11:writable] Warning: In relation transformer1.terminal1.V.re == 0.0, == on Real operands is deprecated in non-function contexts. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo master/Electrical/Transformers/TransformersFixedTap/TransformerFixedRatio.mo:66:5-70:11:writable] Warning: In relation transformer1.terminal1.V.im == 0.0, == on Real operands is deprecated in non-function contexts. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo master/Electrical/Transformers/TransformersFixedTap/TransformerFixedRatio.mo:71:5-75:11:writable] Warning: In relation transformer1.terminal2.V.re == 0.0, == on Real operands is deprecated in non-function contexts. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo master/Electrical/Transformers/TransformersFixedTap/TransformerFixedRatio.mo:71:5-75:11:writable] Warning: In relation transformer1.terminal2.V.im == 0.0, == on Real operands is deprecated in non-function contexts. Notification: Performance of NFTyping.typeClassSections: time 0.183/0.2602, allocations: 5.231 MB / 473.8 MB, free: 54.16 MB / 442.7 MB Notification: Performance of NFFlatten.flatten: time 0.009852/0.2701, allocations: 9.908 MB / 483.7 MB, free: 53.23 MB / 442.7 MB Notification: Performance of NFFlatten.resolveConnections: time 0.004242/0.2743, allocations: 2.213 MB / 485.9 MB, free: 52.41 MB / 442.7 MB Notification: Performance of NFEvalConstants.evaluate: time 0.004651/0.279, allocations: 3.313 MB / 489.2 MB, free: 50.71 MB / 442.7 MB Notification: Performance of NFSimplifyModel.simplify: time 0.003546/0.2825, allocations: 2.962 MB / 492.2 MB, free: 49.59 MB / 442.7 MB Notification: Performance of NFPackage.collectConstants: time 0.001946/0.2845, allocations: 1.036 MB / 493.2 MB, free: 49.59 MB / 442.7 MB Notification: Performance of NFFlatten.collectFunctions: time 0.002047/0.2865, allocations: 1.33 MB / 494.6 MB, free: 49.54 MB / 442.7 MB Notification: Performance of NFScalarize.scalarize: time 0.001588/0.2881, allocations: 2.657 MB / 497.2 MB, free: 47.95 MB / 442.7 MB Notification: Performance of NFVerifyModel.verify: time 0.002533/0.2907, allocations: 2.7 MB / 499.9 MB, free: 46.32 MB / 442.7 MB Notification: Performance of NFConvertDAE.convert: time 0.0142/0.3049, allocations: 15 MB / 0.5028 GB, free: 41.01 MB / 442.7 MB Notification: Performance of FrontEnd - DAE generated: time 7.204e-06/0.3049, allocations: 3.469 kB / 0.5029 GB, free: 41.01 MB / 442.7 MB Notification: Performance of FrontEnd: time 8.356e-06/0.3049, allocations: 1.312 kB / 0.5029 GB, free: 41.01 MB / 442.7 MB Notification: Performance of Transformations before backend: time 0.0003866/0.3053, allocations: 1.219 kB / 0.5029 GB, free: 41.01 MB / 442.7 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 1131 * Number of variables: 1131 Notification: Performance of Generate backend data structure: time 0.03152/0.3368, allocations: 12.18 MB / 0.5148 GB, free: 32.82 MB / 442.7 MB Notification: Performance of prepare preOptimizeDAE: time 4.477e-05/0.3368, allocations: 9.062 kB / 0.5148 GB, free: 32.82 MB / 442.7 MB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01045/0.3473, allocations: 2.495 MB / 0.5172 GB, free: 31.7 MB / 442.7 MB Notification: Performance of preOpt evaluateParameters (simulation): time 0.01073/0.358, allocations: 5.822 MB / 0.5229 GB, free: 27.79 MB / 442.7 MB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001079/0.3591, allocations: 2.846 MB / 0.5257 GB, free: 24.64 MB / 442.7 MB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0008875/0.36, allocations: 479.7 kB / 0.5261 GB, free: 24.49 MB / 442.7 MB Notification: Performance of preOpt clockPartitioning (simulation): time 0.01177/0.3717, allocations: 6.948 MB / 0.5329 GB, free: 19.78 MB / 442.7 MB Notification: Performance of preOpt findStateOrder (simulation): time 9.656e-05/0.3718, allocations: 10.41 kB / 0.5329 GB, free: 19.78 MB / 442.7 MB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0005409/0.3724, allocations: 198.5 kB / 0.5331 GB, free: 19.63 MB / 442.7 MB Notification: Performance of preOpt inlineArrayEqn (simulation): time 6.449e-05/0.3724, allocations: 112.7 kB / 0.5332 GB, free: 19.63 MB / 442.7 MB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01012/0.3826, allocations: 4.517 MB / 0.5376 GB, free: 16.48 MB / 442.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.06502/0.4476, allocations: 41.34 MB / 0.578 GB, free: 5.652 MB / 474.7 MB Notification: Performance of preOpt comSubExp (simulation): time 0.01125/0.4588, allocations: 4.257 MB / 0.5822 GB, free: 1.391 MB / 474.7 MB Notification: Performance of preOpt resolveLoops (simulation): time 0.005516/0.4644, allocations: 2.123 MB / 0.5842 GB, free: 15.25 MB / 490.7 MB Notification: Performance of preOpt evalFunc (simulation): time 0.0003832/0.4647, allocations: 90.44 kB / 0.5843 GB, free: 15.17 MB / 490.7 MB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.007306/0.472, allocations: 3.454 MB / 0.5877 GB, free: 11.62 MB / 490.7 MB Notification: Performance of pre-optimization done (n=429): time 9.248e-06/0.4721, allocations: 0 / 0.5877 GB, free: 11.62 MB / 490.7 MB Notification: Performance of matching and sorting (n=429): time 0.07155/0.5436, allocations: 15.68 MB / 0.603 GB, free: 12 MB / 0.4948 GB Notification: Performance of inlineWhenForInitialization (initialization): time 0.0009296/0.5445, allocations: 0.6788 MB / 0.6037 GB, free: 11.18 MB / 0.4948 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01935/0.5639, allocations: 9.276 MB / 0.6127 GB, free: 1.902 MB / 0.4948 GB Notification: Performance of collectPreVariables (initialization): time 0.00106/0.5649, allocations: 129.7 kB / 0.6128 GB, free: 1.77 MB / 0.4948 GB Notification: Performance of collectInitialEqns (initialization): time 0.006787/0.5717, allocations: 4.529 MB / 0.6173 GB, free: 13.27 MB / 0.5105 GB Notification: Performance of collectInitialBindings (initialization): time 0.003327/0.5751, allocations: 1.608 MB / 0.6188 GB, free: 11.7 MB / 0.5105 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.002856/0.5779, allocations: 1.427 MB / 0.6202 GB, free: 10.26 MB / 0.5105 GB Notification: Performance of setup shared object (initialization): time 0.0002337/0.5782, allocations: 476.8 kB / 0.6207 GB, free: 9.789 MB / 0.5105 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.005495/0.5836, allocations: 2.247 MB / 0.6229 GB, free: 7.516 MB / 0.5105 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.008238/0.5919, allocations: 4.336 MB / 0.6271 GB, free: 2.59 MB / 0.5105 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.01874/0.6106, allocations: 7.92 MB / 0.6349 GB, free: 10.24 MB / 0.5261 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.815e-05/0.6107, allocations: 8 kB / 0.6349 GB, free: 10.23 MB / 0.5261 GB Notification: Performance of matching and sorting (n=705) (initialization): time 0.0268/0.6375, allocations: 8.611 MB / 0.6433 GB, free: 1.691 MB / 0.5261 GB Notification: Performance of prepare postOptimizeDAE: time 0.0001552/0.6376, allocations: 96.28 kB / 0.6434 GB, free: 1.59 MB / 0.5261 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.997e-05/0.6377, allocations: 20 kB / 0.6434 GB, free: 1.57 MB / 0.5261 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.007714/0.6454, allocations: 2.358 MB / 0.6457 GB, free: 15.24 MB / 0.5417 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004211/0.6496, allocations: 0.8215 MB / 0.6465 GB, free: 14.48 MB / 0.5417 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.2409/0.8905, allocations: 23.05 MB / 0.669 GB, free: 160.1 MB / 0.5417 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005561/0.8961, allocations: 0.5155 MB / 0.6695 GB, free: 160.1 MB / 0.5417 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000669/0.8967, allocations: 195.3 kB / 0.6697 GB, free: 160.1 MB / 0.5417 GB Warning: Assuming fixed start value for the following 31 variables: 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) line1.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = line1.State0 fixed = true ) \"Line connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) line2A.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = line2A.State0 fixed = true ) \"Line connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) line2B.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = line2B.State0 fixed = true ) \"Line connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) line3.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = line3.State0 fixed = true ) \"Line connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) transformer.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = transformer.State0 fixed = true ) \"Transformer connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) transformer1.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = transformer1.State0 fixed = true ) \"Transformer connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) wT4BCurrentSource.wT4Injector.elecSystem.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = wT4BCurrentSource.wT4Injector.elecSystem.State0 fixed = true ) \"Transformer connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) wT4BCurrentSource.wT4Injector.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = wT4BCurrentSource.wT4Injector.State0 fixed = true ) \"Injector 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 line1.running:DISCRETE(flow=false start = line1.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean line2A.running:DISCRETE(flow=false start = line2A.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean line2B.running:DISCRETE(flow=false start = line2B.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean line3.running:DISCRETE(flow=false start = line3.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean transformer.running:DISCRETE(flow=false start = transformer.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean transformer1.running:DISCRETE(flow=false start = transformer1.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean wT4BCurrentSource.wT4Injector.running:DISCRETE(flow=false start = wT4BCurrentSource.wT4Injector.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean wT4BCurrentSource.wT4Injector.elecSystem.running:DISCRETE(flow=false start = wT4BCurrentSource.wT4Injector.elecSystem.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean wT4BCurrentSource.pll.fixedBooleanDelay1.y:DISCRETE(flow=false start = wT4BCurrentSource.pll.fixedBooleanDelay1.Y0 fixed = true ) \"Connector of Boolean output signal\" type: Boolean wT4BCurrentSource.pll.fixedBooleanDelay.y:DISCRETE(flow=false start = wT4BCurrentSource.pll.fixedBooleanDelay.Y0 fixed = true ) \"Connector of Boolean output signal\" type: Boolean wT4BCurrentSource.control4B.currentLimiter.firstOrder.y:VARIABLE(flow=false start = wT4BCurrentSource.control4B.currentLimiter.firstOrder.y_start fixed = true ) \"Connector of Real output signal\" type: Real wT4BCurrentSource.control4B.pControl4B.firstOrder.y:VARIABLE(flow=false start = wT4BCurrentSource.mechanical.Ip0Pu * wT4BCurrentSource.mechanical.U0Pu fixed = true ) \"Connector of Real output signal\" type: Real wT4BCurrentSource.control4B.pControl4B.firstOrder1.y:VARIABLE(flow=false start = wT4BCurrentSource.control4B.pControl4B.firstOrder1.y_start fixed = true ) \"Connector of Real output signal\" type: Real wT4BCurrentSource.control4B.qControl.firstOrder.y:VARIABLE(flow=false start = wT4BCurrentSource.control4B.qControl.vDrop.U0Pu fixed = true ) \"Connector of Real output signal\" type: Real wT4BCurrentSource.control4B.qControl.firstOrder1.y:VARIABLE(flow=false start = wT4BCurrentSource.control4B.qControl.firstOrder1.y_start fixed = true ) \"Connector of Real output signal\" type: Real wT4BCurrentSource.gridProtection.ufMeasurement.derivative.x:VARIABLE(start = wT4BCurrentSource.gridProtection.ufMeasurement.derivative.x_start fixed = true ) \"State of block\" type: Real wT4BCurrentSource.gridProtection.ufMeasurement.firstOrder.y:VARIABLE(flow=false start = wT4BCurrentSource.gridProtection.ufMeasurement.firstOrder.y_start fixed = true ) \"Connector of Real output signal\" type: Real wT4BCurrentSource.gridProtection.ufMeasurement.firstOrder1.y:VARIABLE(flow=false start = wT4BCurrentSource.gridProtection.ufMeasurement.U0Pu fixed = true ) \"Connector of Real output signal\" type: Real wT4BCurrentSource.gridProtection.ufMeasurement.firstOrder2.y:VARIABLE(flow=false start = wT4BCurrentSource.gridProtection.ufMeasurement.firstOrder2.y_start fixed = true ) \"Connector of Real output signal\" type: Real nodeFault.nodeFault:DISCRETE(flow=false start = false fixed = true ) \"True when the fault is ongoing, false otherwise\" type: Boolean nodeFault1.nodeFault:DISCRETE(flow=false start = false fixed = true ) \"True when the fault is ongoing, false otherwise\" type: Boolean Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.007789/0.9045, allocations: 3.372 MB / 0.673 GB, free: 159.8 MB / 0.5417 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.005418/0.91, allocations: 4.322 MB / 0.6772 GB, free: 157.8 MB / 0.5417 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.01367/0.9236, allocations: 7.893 MB / 0.6849 GB, free: 156 MB / 0.5417 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 3.358e-05/0.9237, allocations: 5.781 kB / 0.6849 GB, free: 156 MB / 0.5417 GB Notification: Performance of matching and sorting (n=705) (initialization_lambda0): time 0.02451/0.9482, allocations: 8.598 MB / 0.6933 GB, free: 153.3 MB / 0.5417 GB Notification: Performance of prepare postOptimizeDAE: time 0.0001066/0.9483, allocations: 90.52 kB / 0.6934 GB, free: 153.2 MB / 0.5417 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.652e-05/0.9483, allocations: 19.38 kB / 0.6934 GB, free: 153.2 MB / 0.5417 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.006311/0.9546, allocations: 2.365 MB / 0.6957 GB, free: 152.6 MB / 0.5417 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004011/0.9586, allocations: 0.8181 MB / 0.6965 GB, free: 152.5 MB / 0.5417 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.03449/0.9931, allocations: 23.06 MB / 0.719 GB, free: 137.3 MB / 0.5417 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005971/0.9991, allocations: 0.5061 MB / 0.7195 GB, free: 137 MB / 0.5417 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000989/1, allocations: 191.4 kB / 0.7197 GB, free: 136.9 MB / 0.5417 GB Warning: Assuming fixed start value for the following 31 variables: 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) line1.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = line1.State0 fixed = true ) \"Line connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) line2A.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = line2A.State0 fixed = true ) \"Line connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) line2B.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = line2B.State0 fixed = true ) \"Line connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) line3.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = line3.State0 fixed = true ) \"Line connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) transformer.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = transformer.State0 fixed = true ) \"Transformer connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) transformer1.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = transformer1.State0 fixed = true ) \"Transformer connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) wT4BCurrentSource.wT4Injector.elecSystem.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = wT4BCurrentSource.wT4Injector.elecSystem.State0 fixed = true ) \"Transformer connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) wT4BCurrentSource.wT4Injector.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = wT4BCurrentSource.wT4Injector.State0 fixed = true ) \"Injector 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 line1.running:DISCRETE(flow=false start = line1.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean line2A.running:DISCRETE(flow=false start = line2A.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean line2B.running:DISCRETE(flow=false start = line2B.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean line3.running:DISCRETE(flow=false start = line3.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean transformer.running:DISCRETE(flow=false start = transformer.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean transformer1.running:DISCRETE(flow=false start = transformer1.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean wT4BCurrentSource.wT4Injector.running:DISCRETE(flow=false start = wT4BCurrentSource.wT4Injector.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean wT4BCurrentSource.wT4Injector.elecSystem.running:DISCRETE(flow=false start = wT4BCurrentSource.wT4Injector.elecSystem.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean wT4BCurrentSource.pll.fixedBooleanDelay1.y:DISCRETE(flow=false start = wT4BCurrentSource.pll.fixedBooleanDelay1.Y0 fixed = true ) \"Connector of Boolean output signal\" type: Boolean wT4BCurrentSource.pll.fixedBooleanDelay.y:DISCRETE(flow=false start = wT4BCurrentSource.pll.fixedBooleanDelay.Y0 fixed = true ) \"Connector of Boolean output signal\" type: Boolean wT4BCurrentSource.control4B.currentLimiter.firstOrder.y:VARIABLE(flow=false start = wT4BCurrentSource.control4B.currentLimiter.firstOrder.y_start fixed = true ) \"Connector of Real output signal\" type: Real wT4BCurrentSource.control4B.pControl4B.firstOrder.y:VARIABLE(flow=false start = wT4BCurrentSource.mechanical.Ip0Pu * wT4BCurrentSource.mechanical.U0Pu fixed = true ) \"Connector of Real output signal\" type: Real wT4BCurrentSource.control4B.pControl4B.firstOrder1.y:VARIABLE(flow=false start = wT4BCurrentSource.control4B.pControl4B.firstOrder1.y_start fixed = true ) \"Connector of Real output signal\" type: Real wT4BCurrentSource.control4B.qControl.firstOrder.y:VARIABLE(flow=false start = wT4BCurrentSource.control4B.qControl.vDrop.U0Pu fixed = true ) \"Connector of Real output signal\" type: Real wT4BCurrentSource.control4B.qControl.firstOrder1.y:VARIABLE(flow=false start = wT4BCurrentSource.control4B.qControl.firstOrder1.y_start fixed = true ) \"Connector of Real output signal\" type: Real wT4BCurrentSource.gridProtection.ufMeasurement.derivative.x:VARIABLE(start = wT4BCurrentSource.gridProtection.ufMeasurement.derivative.x_start fixed = true ) \"State of block\" type: Real wT4BCurrentSource.gridProtection.ufMeasurement.firstOrder.y:VARIABLE(flow=false start = wT4BCurrentSource.gridProtection.ufMeasurement.firstOrder.y_start fixed = true ) \"Connector of Real output signal\" type: Real wT4BCurrentSource.gridProtection.ufMeasurement.firstOrder1.y:VARIABLE(flow=false start = wT4BCurrentSource.gridProtection.ufMeasurement.U0Pu fixed = true ) \"Connector of Real output signal\" type: Real wT4BCurrentSource.gridProtection.ufMeasurement.firstOrder2.y:VARIABLE(flow=false start = wT4BCurrentSource.gridProtection.ufMeasurement.firstOrder2.y_start fixed = true ) \"Connector of Real output signal\" type: Real nodeFault.nodeFault:DISCRETE(flow=false start = false fixed = true ) \"True when the fault is ongoing, false otherwise\" type: Boolean nodeFault1.nodeFault:DISCRETE(flow=false start = false fixed = true ) \"True when the fault is ongoing, false otherwise\" type: Boolean Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 92 * Number of states: 0 () * Number of discrete variables: 157 ($PRE.line.state,line.state,$PRE.line1.state,line1.state,$PRE.line2A.state,line2A.state,$PRE.line2B.state,line2B.state,$PRE.line3.state,line3.state,$PRE.transformer.state,transformer.state,$PRE.transformer1.state,transformer1.state,$PRE.wT4BCurrentSource.wT4Injector.elecSystem.state,wT4BCurrentSource.wT4Injector.elecSystem.state,$PRE.wT4BCurrentSource.wT4Injector.state,wT4BCurrentSource.wT4Injector.state,$whenCondition4,$whenCondition5,$whenCondition2,$whenCondition3,transformer1.switchOffSignal2,transformer1.switchOffSignal1,transformer.switchOffSignal2,transformer.switchOffSignal1,line3.switchOffSignal2,line3.switchOffSignal1,line2B.switchOffSignal2,line2B.switchOffSignal1,line2A.switchOffSignal2,line2A.switchOffSignal1,line1.switchOffSignal2,line1.switchOffSignal1,line.switchOffSignal2,line.switchOffSignal1,wT4BCurrentSource.wT4Injector.switchOffSignal3,wT4BCurrentSource.wT4Injector.switchOffSignal2,wT4BCurrentSource.wT4Injector.switchOffSignal1,$PRE.line.running,$PRE.line1.running,$PRE.line2A.running,$PRE.line2B.running,$PRE.line3.running,$PRE.transformer.running,$PRE.transformer1.running,$PRE.wT4BCurrentSource.wT4Injector.running,$PRE.wT4BCurrentSource.wT4Injector.elecSystem.running,$PRE.wT4BCurrentSource.pll.fixedBooleanDelay1.y,$PRE.wT4BCurrentSource.pll.fixedBooleanDelay.y,$PRE.nodeFault.nodeFault,$PRE.nodeFault1.nodeFault,$PRE.omegaRefPu.count,$PRE.omegaRefPu.T_start,$PRE.wT4BCurrentSource.gridProtection.pre1.u,$PRE.wT4BCurrentSource.gridProtection.timer3.entryTime,$PRE.wT4BCurrentSource.gridProtection.timer2.entryTime,$PRE.wT4BCurrentSource.gridProtection.timer1.entryTime,$PRE.wT4BCurrentSource.gridProtection.timer.entryTime,$PRE.wT4BCurrentSource.control4B.qControl.delayFlag.timer.entryTime,wT4BCurrentSource.control4B.currentLimiter.product1.u[2],omegaRefPu.count,omegaRefPu.T_start,nodeFault1.nodeFault,nodeFault.nodeFault,wT4BCurrentSource.gridProtection.pre1.u,wT4BCurrentSource.gridProtection.or1.u[5],wT4BCurrentSource.gridProtection.or1.u[4],wT4BCurrentSource.gridProtection.or1.u[3],wT4BCurrentSource.gridProtection.or1.u[2],wT4BCurrentSource.gridProtection.or1.u[1],wT4BCurrentSource.gridProtection.timer3.entryTime,wT4BCurrentSource.gridProtection.timer2.entryTime,wT4BCurrentSource.gridProtection.timer1.entryTime,wT4BCurrentSource.gridProtection.lessEqual3.y,wT4BCurrentSource.gridProtection.lessEqual2.y,wT4BCurrentSource.gridProtection.lessEqual1.y,wT4BCurrentSource.gridProtection.lessEqual.y,wT4BCurrentSource.gridProtection.timer.entryTime,wT4BCurrentSource.control4B.qLimiter.integerToBoolean.y,wT4BCurrentSource.control4B.qControl.fUvrt,wT4BCurrentSource.control4B.qControl.greaterEqualThreshold.y,wT4BCurrentSource.control4B.qControl.delayFlag.booleanToInteger.y,wT4BCurrentSource.control4B.qControl.delayFlag.switch1.y,wT4BCurrentSource.control4B.qControl.delayFlag.less1.y,wT4BCurrentSource.control4B.qControl.delayFlag.timer.entryTime,wT4BCurrentSource.control4B.qControl.delayFlag.fI,wT4BCurrentSource.control4B.currentLimiter.greater.y,wT4BCurrentSource.control4B.currentLimiter.product1.y,wT4BCurrentSource.pll.fixedBooleanDelay.y,wT4BCurrentSource.pll.fixedBooleanDelay1.y,wT4BCurrentSource.pll.lessThreshold1.y,wT4BCurrentSource.pll.lessThreshold.y,wT4BCurrentSource.wT4Injector.elecSystem.running,wT4BCurrentSource.wT4Injector.running,transformer1.running,transformer.running,line3.running,line2B.running,line2A.running,line1.running,line.running,$whenCondition1,$whenCondition6,$whenCondition7,$whenCondition8,$whenCondition9,$whenCondition10,$whenCondition12,$whenCondition11,$whenCondition14,$whenCondition13,$whenCondition15,$whenCondition17,$whenCondition16,$whenCondition18,$whenCondition20,$whenCondition19,$whenCondition21,$whenCondition23,$whenCondition22,$whenCondition24,$whenCondition26,$whenCondition25,$whenCondition27,$whenCondition29,$whenCondition28,$whenCondition30,$whenCondition32,$whenCondition31,$whenCondition33,$whenCondition35,$whenCondition34,$whenCondition36,$whenCondition38,$whenCondition37,$whenCondition39,$whenCondition41,$whenCondition40,$whenCondition43,$whenCondition42,$whenCondition45,$whenCondition44,wT4BCurrentSource.mechanical.pI.integrator.local_reset,wT4BCurrentSource.mechanical.integrator1.local_reset,wT4BCurrentSource.mechanical.integrator.local_reset,wT4BCurrentSource.gridProtection.ufMeasurement.rampLimiter.integrator.local_reset,wT4BCurrentSource.control4B.qLimiter.absLimRateLimFirstOrderFreeze1.integrator.local_reset,wT4BCurrentSource.control4B.qLimiter.absLimRateLimFirstOrderFreeze.integrator.local_reset,wT4BCurrentSource.control4B.qControl.absLimRateLimFeedthroughFreeze.rampLimiter.integrator.local_reset,wT4BCurrentSource.control4B.qControl.absLimRateLimFirstOrderFreeze.integrator.local_reset,wT4BCurrentSource.control4B.qControl.antiWindupIntegrator1.integrator.local_reset,wT4BCurrentSource.control4B.qControl.antiWindupIntegrator.integrator.local_reset,wT4BCurrentSource.control4B.pControl4B.absLimRateLimFirstOrderAntiWindup.integrator.local_reset,wT4BCurrentSource.pll.absLimRateLimFirstOrderFreeze.integrator.local_reset,wT4BCurrentSource.wT4Injector.genSystem.absLimRateLimFirstOrderAntiWindup1.integrator.local_reset,wT4BCurrentSource.wT4Injector.genSystem.absLimRateLimFirstOrderAntiWindup.integrator.local_reset) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (583): * Single equations (assignments): 577 * Array equations: 0 * Algorithm blocks: 2 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 4 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 3 systems {(1,1,100.0%), (1,1,100.0%), (1,1,100.0%)} * Non-linear torn systems (#iteration vars, #inner vars): 1 system {(32,73)} Notification: Performance of prepare postOptimizeDAE: time 0.001438/1.002, allocations: 0.7922 MB / 0.7205 GB, free: 136.1 MB / 0.5417 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.00237/1.004, allocations: 0.9201 MB / 0.7214 GB, free: 135.2 MB / 0.5417 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01658/1.02, allocations: 6.581 MB / 0.7278 GB, free: 129.6 MB / 0.5417 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 8.258e-05/1.021, allocations: 21.94 kB / 0.7278 GB, free: 129.6 MB / 0.5417 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 9.719e-06/1.021, allocations: 4 kB / 0.7278 GB, free: 129.6 MB / 0.5417 GB Notification: Performance of postOpt removeConstants (simulation): time 0.003403/1.024, allocations: 0.938 MB / 0.7288 GB, free: 128.7 MB / 0.5417 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.002158/1.026, allocations: 100.8 kB / 0.7288 GB, free: 128.6 MB / 0.5417 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003925/1.03, allocations: 245.9 kB / 0.7291 GB, free: 128.5 MB / 0.5417 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001063/1.031, allocations: 377.6 kB / 0.7294 GB, free: 128.2 MB / 0.5417 GB Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.01533/1.046, allocations: 7.153 MB / 0.7364 GB, free: 121.9 MB / 0.5417 GB Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.01537/1.062, allocations: 8.741 MB / 0.745 GB, free: 113.8 MB / 0.5417 GB Notification: Performance of postOpt setEvaluationStage (simulation): time 0.00431/1.066, allocations: 2.423 MB / 0.7473 GB, free: 111.6 MB / 0.5417 GB Notification: Performance of sorting global known variables: time 0.009306/1.075, allocations: 5.058 MB / 0.7523 GB, free: 106.7 MB / 0.5417 GB Notification: Performance of Backend: time 8.11e-07/1.075, allocations: 0 / 0.7523 GB, free: 106.7 MB / 0.5417 GB Notification: Performance of simCode: created initialization part: time 0.03013/1.106, allocations: 11.75 MB / 0.7637 GB, free: 94.96 MB / 0.5417 GB Notification: Performance of SimCode: time 0.02477/1.13, allocations: 14.31 MB / 0.7777 GB, free: 80.56 MB / 0.5417 GB Notification: Performance of Templates: time 0.3846/1.515, allocations: 153.8 MB / 0.928 GB, free: 147.7 MB / 0.5573 GB " [Timeout remaining time 658] make -j1 -f Dynawo_dev_Dynawo.Examples.Wind.IEC.Neplan.WT4BCurrentSource2015FOCB.makefile [Timeout 660] (rm -f Dynawo_dev_Dynawo.Examples.Wind.IEC.Neplan.WT4BCurrentSource2015FOCB.pipe ; mkfifo Dynawo_dev_Dynawo.Examples.Wind.IEC.Neplan.WT4BCurrentSource2015FOCB.pipe ; head -c 1048576 < Dynawo_dev_Dynawo.Examples.Wind.IEC.Neplan.WT4BCurrentSource2015FOCB.pipe >> ../files/Dynawo_dev_Dynawo.Examples.Wind.IEC.Neplan.WT4BCurrentSource2015FOCB.sim & ./Dynawo_dev_Dynawo.Examples.Wind.IEC.Neplan.WT4BCurrentSource2015FOCB -initialStepSize=0.001 -lv=LOG_STATS -nls=kinsol -s=ida -nlsLS=klu -maxIntegrationOrder=2 -maxStepSize=10 -abortSlowSimulation -alarm=240 -emit_protected -lv LOG_STATS > Dynawo_dev_Dynawo.Examples.Wind.IEC.Neplan.WT4BCurrentSource2015FOCB.pipe 2>&1) [Timeout 240] [Calling os._exit(0), Time elapsed: 11.209039365057833]