Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Dynawo_dev_Dynawo.Examples.Wind.WECC.WT4BCurrentSource.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001317/0.001317, allocations: 117.7 kB / 17.13 MB, free: 5.918 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001349/0.001349, allocations: 191.7 kB / 20.08 MB, free: 2.988 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.586/1.586, allocations: 207.6 MB / 230.5 MB, free: 4.027 MB / 174.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0-master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0-master/package.mo): time 0.6041/0.6041, allocations: 103 MB / 385.3 MB, free: 14.98 MB / 318.1 MB
"
[Timeout remaining time 179]
Using package Dynawo with version 1.7.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0-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.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
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.WT4BCurrentSource,tolerance=1e-05,outputFormat="empty",numberOfIntervals=20000,variableFilter="",fileNamePrefix="Dynawo_dev_Dynawo.Examples.Wind.WECC.WT4BCurrentSource")
translateModel(Dynawo.Examples.Wind.WECC.WT4BCurrentSource,tolerance=1e-05,outputFormat="empty",numberOfIntervals=20000,variableFilter="",fileNamePrefix="Dynawo_dev_Dynawo.Examples.Wind.WECC.WT4BCurrentSource") [Timeout 660]
"Notification: Modelica requested package Complex of version 3.2.3. Complex 4.0.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.0.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.002564/0.002564, allocations: 67.91 kB / 0.5447 GB, free: 13 MB / 414.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1812/0.1837, allocations: 75.66 MB / 0.6186 GB, free: 1.258 MB / 478.1 MB
Notification: Performance of NFInst.instantiate(Dynawo.Examples.Wind.WECC.WT4BCurrentSource): time 0.01328/0.197, allocations: 9.111 MB / 0.6275 GB, free: 8.086 MB / 494.1 MB
Notification: Performance of NFInst.instExpressions: time 0.009879/0.2069, allocations: 4.896 MB / 0.6323 GB, free: 3.176 MB / 494.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002103/0.209, allocations: 47.75 kB / 0.6324 GB, free: 3.129 MB / 494.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0-master/Electrical/Controls/Basics/SwitchOff/SwitchOffLogic.mo:20:3-20:98:writable] Warning: Connector switchOffSignal1 is not balanced: The number of potential variables (1) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0-master/Electrical/Controls/Basics/SwitchOff/SwitchOffLogic.mo:21:3-21:125:writable] Warning: Connector switchOffSignal2 is not balanced: The number of potential variables (1) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0-master/Electrical/Controls/Basics/SwitchOff/SwitchOffLogic.mo:24:3-24:105:writable] Warning: Connector running is not balanced: The number of potential variables (1) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0-master/Electrical/Controls/Basics/SwitchOff/SwitchOffLogic.mo:20:3-20:98:writable] Warning: Connector switchOffSignal1 is not balanced: The number of potential variables (1) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0-master/Electrical/Controls/Basics/SwitchOff/SwitchOffLogic.mo:21:3-21:125:writable] Warning: Connector switchOffSignal2 is not balanced: The number of potential variables (1) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0-master/Electrical/Controls/Basics/SwitchOff/SwitchOffLogic.mo:24:3-24:105:writable] Warning: Connector running is not balanced: The number of potential variables (1) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0-master/Electrical/Controls/Basics/SwitchOff/SwitchOffLogic.mo:20:3-20:98:writable] Warning: Connector switchOffSignal1 is not balanced: The number of potential variables (1) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0-master/Electrical/Controls/Basics/SwitchOff/SwitchOffLogic.mo:21:3-21:125:writable] Warning: Connector switchOffSignal2 is not balanced: The number of potential variables (1) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0-master/Electrical/Controls/Basics/SwitchOff/SwitchOffLogic.mo:22:3-22:125:writable] Warning: Connector switchOffSignal3 is not balanced: The number of potential variables (1) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0-master/Electrical/Controls/Basics/SwitchOff/SwitchOffLogic.mo:24:3-24:105:writable] Warning: Connector running is not balanced: The number of potential variables (1) is not equal to the number of flow variables (0).
Notification: Performance of NFTyping.typeComponents: time 0.001563/0.2105, allocations: 496.1 kB / 0.6328 GB, free: 2.641 MB / 494.1 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.002513/0.2131, allocations: 0.6169 MB / 0.6334 GB, free: 2.02 MB / 494.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0-master/Examples/Wind/WECC/WT4BCurrentSource.mo:33:3-33:38:writable] Warning: Conditional component 'switchOffSignal2' is used in a non-connect context.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0-master/Examples/Wind/WECC/WT4BCurrentSource.mo:35:3-35:47:writable] Warning: Conditional component 'switchOffSignal2' is used in a non-connect context.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0-master/Examples/Wind/WECC/WT4BCurrentSource.mo:36:3-36:47:writable] Warning: Conditional component 'switchOffSignal3' is used in a non-connect context.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0-master/Electrical/Controls/Basics/SwitchOff/SwitchOffLogic.mo:40:5-44:13:writable] Warning: Conditional component 'switchOffSignal2' is used in a non-connect context.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0-master/Electrical/Controls/Basics/SwitchOff/SwitchOffLogic.mo:34:5-38:13:writable] Warning: Conditional component 'switchOffSignal2' is used in a non-connect context.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0-master/Electrical/Controls/Basics/SwitchOff/SwitchOffLogic.mo:34:5-38:13:writable] Warning: Conditional component 'switchOffSignal3' is used in a non-connect context.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0-master/Electrical/Controls/Basics/SwitchOff/SwitchOffLogic.mo:34:5-38:13:writable] Warning: Conditional component 'switchOffSignal2' is used in a non-connect context.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0-master/Electrical/Controls/Basics/SwitchOff/SwitchOffLogic.mo:34:5-38:13:writable] Warning: Conditional component 'switchOffSignal3' is used in a non-connect context.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0-master/Electrical/Wind/WECC/BaseClasses/BaseWT4.mo:100:3-100:64:writable] Warning: Conditional component 'switchOffSignal2' is used in a non-connect context.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0-master/Electrical/Controls/Basics/SwitchOff/SwitchOffLogic.mo:40:5-44:13:writable] Warning: Conditional component 'switchOffSignal2' is used in a non-connect context.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0-master/Electrical/Controls/Basics/SwitchOff/SwitchOffLogic.mo:34:5-38:13:writable] Warning: Conditional component 'switchOffSignal2' is used in a non-connect context.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0-master/Electrical/Controls/Basics/SwitchOff/SwitchOffLogic.mo:34:5-38:13:writable] Warning: Conditional component 'switchOffSignal3' is used in a non-connect context.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0-master/Electrical/Controls/Basics/SwitchOff/SwitchOffLogic.mo:34:5-38:13:writable] Warning: Conditional component 'switchOffSignal2' is used in a non-connect context.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0-master/Electrical/Controls/Basics/SwitchOff/SwitchOffLogic.mo:34:5-38:13:writable] Warning: Conditional component 'switchOffSignal3' is used in a non-connect context.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0-master/Electrical/Controls/Basics/SwitchOff/SwitchOffLogic.mo:40:5-44:13:writable] Warning: Conditional component 'switchOffSignal2' is used in a non-connect context.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0-master/Electrical/Controls/Basics/SwitchOff/SwitchOffLogic.mo:34:5-38:13:writable] Warning: Conditional component 'switchOffSignal2' is used in a non-connect context.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0-master/Electrical/Controls/Basics/SwitchOff/SwitchOffLogic.mo:34:5-38:13:writable] Warning: Conditional component 'switchOffSignal3' is used in a non-connect context.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0-master/Electrical/Controls/Basics/SwitchOff/SwitchOffLogic.mo:34:5-38:13:writable] Warning: Conditional component 'switchOffSignal2' is used in a non-connect context.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0-master/Electrical/Controls/Basics/SwitchOff/SwitchOffLogic.mo:34:5-38:13:writable] Warning: Conditional component 'switchOffSignal3' is used in a non-connect context.
Notification: Performance of NFTyping.typeClassSections: time 0.004449/0.2175, allocations: 1.901 MB / 0.6353 GB, free: 132 kB / 494.1 MB
Notification: Performance of NFFlatten.flatten: time 0.3518/0.5693, allocations: 2.856 MB / 0.6381 GB, free: 14.37 MB / 494.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.001281/0.5706, allocations: 0.703 MB / 0.6388 GB, free: 14.25 MB / 494.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001336/0.5719, allocations: 1.036 MB / 0.6398 GB, free: 14.05 MB / 494.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0012/0.5731, allocations: 1.107 MB / 0.6409 GB, free: 13.79 MB / 494.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0003749/0.5735, allocations: 311.5 kB / 0.6412 GB, free: 13.79 MB / 494.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0008152/0.5743, allocations: 499.5 kB / 0.6416 GB, free: 13.79 MB / 494.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.0006159/0.5749, allocations: 0.6337 MB / 0.6422 GB, free: 13.7 MB / 494.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.001226/0.5762, allocations: 1.234 MB / 0.6435 GB, free: 13.33 MB / 494.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.005427/0.5816, allocations: 3.805 MB / 0.6472 GB, free: 12.85 MB / 494.1 MB
Notification: Performance of FrontEnd - DAE generated: time 5.831e-06/0.5816, allocations: 2.688 kB / 0.6472 GB, free: 12.85 MB / 494.1 MB
Notification: Performance of FrontEnd: time 1.804e-06/0.5816, allocations: 0 / 0.6472 GB, free: 12.85 MB / 494.1 MB
Notification: Performance of Transformations before backend: time 9.796e-05/0.5817, allocations: 3.281 kB / 0.6472 GB, free: 12.85 MB / 494.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 382
 * Number of variables: 382
Notification: Performance of Generate backend data structure: time 0.009783/0.5915, allocations: 3.214 MB / 0.6503 GB, free: 11.27 MB / 494.1 MB
Notification: Performance of prepare preOptimizeDAE: time 6.315e-05/0.5915, allocations: 9.469 kB / 0.6503 GB, free: 11.27 MB / 494.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004395/0.5959, allocations: 0.7118 MB / 0.651 GB, free: 11.07 MB / 494.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.003042/0.599, allocations: 1.59 MB / 0.6526 GB, free: 10.12 MB / 494.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003876/0.5994, allocations: 0.5142 MB / 0.6531 GB, free: 9.617 MB / 494.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003055/0.5997, allocations: 157.2 kB / 0.6532 GB, free: 9.566 MB / 494.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.004717/0.6044, allocations: 2.026 MB / 0.6552 GB, free: 8.605 MB / 494.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 3.506e-05/0.6044, allocations: 2.266 kB / 0.6552 GB, free: 8.605 MB / 494.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001817/0.6046, allocations: 67.39 kB / 0.6553 GB, free: 8.559 MB / 494.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.748e-05/0.6046, allocations: 36.78 kB / 0.6553 GB, free: 8.559 MB / 494.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.004242/0.6089, allocations: 1.661 MB / 0.6569 GB, free: 7.957 MB / 494.1 MB
Warning: The model contains alias variables with redundant start and/or conflicting nominal values. It is recommended to resolve the conflicts, because otherwise the system could be hard to solve. To print the conflicting alias sets and the chosen candidates please use -d=aliasConflicts.
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.01075/0.6196, allocations: 7.665 MB / 0.6644 GB, free: 2.477 MB / 494.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.004292/0.6239, allocations: 1.701 MB / 0.6661 GB, free: 1.641 MB / 494.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001597/0.6255, allocations: 0.7325 MB / 0.6668 GB, free: 1.254 MB / 494.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001081/0.6256, allocations: 25.02 kB / 0.6668 GB, free: 1.25 MB / 494.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.002157/0.6278, allocations: 1.193 MB / 0.668 GB, free: 0.5 MB / 494.1 MB
Notification: Performance of pre-optimization done (n=135): time 3.767e-06/0.6278, allocations: 0 / 0.668 GB, free: 0.5 MB / 494.1 MB
Notification: Performance of matching and sorting (n=135): time 0.009116/0.6369, allocations: 3.001 MB / 0.6709 GB, free: 14.88 MB / 0.4981 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002211/0.6371, allocations: 289 kB / 0.6712 GB, free: 14.56 MB / 0.4981 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003927/0.6411, allocations: 1.858 MB / 0.673 GB, free: 13.55 MB / 0.4981 GB
Notification: Performance of collectPreVariables (initialization): time 0.000359/0.6414, allocations: 65.41 kB / 0.6731 GB, free: 13.49 MB / 0.4981 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001117/0.6425, allocations: 0.9223 MB / 0.674 GB, free: 12.68 MB / 0.4981 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0007061/0.6432, allocations: 463 kB / 0.6744 GB, free: 12.29 MB / 0.4981 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0005457/0.6438, allocations: 257.3 kB / 0.6746 GB, free: 12.14 MB / 0.4981 GB
Notification: Performance of setup shared object (initialization): time 0.0001626/0.6439, allocations: 306.2 kB / 0.6749 GB, free: 11.84 MB / 0.4981 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001918/0.6459, allocations: 0.7406 MB / 0.6757 GB, free: 11.45 MB / 0.4981 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002251/0.6481, allocations: 1.065 MB / 0.6767 GB, free: 10.68 MB / 0.4981 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01381/0.6619, allocations: 4.107 MB / 0.6807 GB, free: 8.453 MB / 0.4981 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.534e-05/0.6619, allocations: 2.75 kB / 0.6807 GB, free: 8.453 MB / 0.4981 GB
Notification: Performance of matching and sorting (n=188) (initialization): time 0.00659/0.6685, allocations: 2.401 MB / 0.6831 GB, free: 7.223 MB / 0.4981 GB
Notification: Performance of prepare postOptimizeDAE: time 5.62e-05/0.6686, allocations: 36.94 kB / 0.6831 GB, free: 7.188 MB / 0.4981 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.665e-05/0.6686, allocations: 9.969 kB / 0.6831 GB, free: 7.188 MB / 0.4981 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0004982/0.6691, allocations: 317.1 kB / 0.6834 GB, free: 7.051 MB / 0.4981 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00178/0.6709, allocations: 342.6 kB / 0.6837 GB, free: 6.98 MB / 0.4981 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2e-05/0.6709, allocations: 16.91 kB / 0.6838 GB, free: 6.98 MB / 0.4981 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001943/0.6728, allocations: 221.2 kB / 0.684 GB, free: 6.852 MB / 0.4981 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001303/0.673, allocations: 56.77 kB / 0.684 GB, free: 6.836 MB / 0.4981 GB
Warning: Assuming fixed start value for the following 20 variables:
         WT4B.injector.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = WT4B.injector.State0 fixed = true )  \"Injector connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined)
         WT4B.line.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = WT4B.line.State0 fixed = true )  \"Line 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.value:DISCRETE(flow=false start = line.Running0 fixed = true )  type: Boolean
         WT4B.line.running.value:DISCRETE(flow=false start = WT4B.line.Running0 fixed = true )  type: Boolean
         WT4B.wecc_reec.firstOrder.y:VARIABLE(flow=false start = WT4B.wecc_reec.UInj0Pu fixed = true )  \"Connector of Real output signal\" type: Real
         WT4B.wecc_reec.firstOrder1.y:VARIABLE(flow=false start = WT4B.wecc_reec.firstOrder1.y_start fixed = true )  \"Connector of Real output signal\" type: Real
         WT4B.wecc_reec.limPIDFreeze.I.y:VARIABLE(flow=false start = WT4B.wecc_reec.limPIDFreeze.I.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         WT4B.wecc_reec.varLimPIDFreeze.I.y:VARIABLE(flow=false start = WT4B.wecc_reec.varLimPIDFreeze.I.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         WT4B.wecc_reec.rateLimFirstOrderFreeze1.y:VARIABLE(flow=false start = WT4B.wecc_reec.rateLimFirstOrderFreeze1.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         WT4B.wecc_reec.rateLimFirstOrderFreeze.y:VARIABLE(flow=false start = WT4B.wecc_reec.rateLimFirstOrderFreeze.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         WT4B.wecc_reec.iqInjectionLogic.vDip:DISCRETE(flow=false start = false fixed = true )  \"Ongoing voltage dip\" type: Boolean
         WT4B.wecc_reec.iqInjectionLogic.vDipInjEndTime:DISCRETE(start = -1.0 unit = \"s\" fixed = true )  \"ending time of the voltage dip start (in seconds)\" type: Real
         WT4B.wecc_reec.currentLimitsCalculation1.ipMaxFrzPu:DISCRETE(start = 0.0 unit = \"1\" fixed = true )  type: Real
         WT4B.wecc_reec.currentLimitsCalculation1.vDipFrzEndTime:DISCRETE(start = -1.0 unit = \"s\" fixed = true )  type: Real
         WT4B.wecc_regc.firstOrder.y:VARIABLE(flow=false start = WT4B.wecc_regc.UInj0Pu fixed = true )  \"Connector of Real output signal\" type: Real
         WT4B.wecc_regc.rateLimFirstOrderFreeze.y:VARIABLE(flow=false start = WT4B.wecc_regc.rateLimFirstOrderFreeze.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         WT4B.wecc_regc.rateLimFirstOrderFreeze1.y:VARIABLE(flow=false start = WT4B.wecc_regc.rateLimFirstOrderFreeze1.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         WT4B.injector.running.value:DISCRETE(flow=false start = WT4B.injector.Running0 fixed = true )  type: Boolean
         WT4B.wecc_reec.currentLimitsCalculation1.vDip:DISCRETE(flow=false fixed = true )  \"Ongoing voltage dip\" type: Boolean
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.002852/0.6758, allocations: 1.175 MB / 0.6852 GB, free: 6.164 MB / 0.4981 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.002123/0.6779, allocations: 1.059 MB / 0.6862 GB, free: 5.203 MB / 0.4981 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.01313/0.6911, allocations: 4.057 MB / 0.6902 GB, free: 1.047 MB / 0.4981 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.267e-05/0.6911, allocations: 4 kB / 0.6902 GB, free: 1.043 MB / 0.4981 GB
Notification: Performance of matching and sorting (n=188) (initialization_lambda0): time 0.007232/0.6983, allocations: 2.378 MB / 0.6925 GB, free: 14.7 MB / 0.5137 GB
Notification: Performance of prepare postOptimizeDAE: time 6.451e-05/0.6984, allocations: 37.7 kB / 0.6925 GB, free: 14.66 MB / 0.5137 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.247e-05/0.6984, allocations: 14.09 kB / 0.6925 GB, free: 14.64 MB / 0.5137 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0005508/0.699, allocations: 309.1 kB / 0.6928 GB, free: 14.34 MB / 0.5137 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001933/0.7009, allocations: 345.3 kB / 0.6932 GB, free: 14.02 MB / 0.5137 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 3.257e-05/0.7009, allocations: 19.56 kB / 0.6932 GB, free: 14 MB / 0.5137 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002221/0.7031, allocations: 191.3 kB / 0.6934 GB, free: 13.82 MB / 0.5137 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001704/0.7033, allocations: 52 kB / 0.6934 GB, free: 13.77 MB / 0.5137 GB
Warning: Assuming fixed start value for the following 20 variables:
         WT4B.injector.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = WT4B.injector.State0 fixed = true )  \"Injector connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined)
         WT4B.line.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = WT4B.line.State0 fixed = true )  \"Line 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.value:DISCRETE(flow=false start = line.Running0 fixed = true )  type: Boolean
         WT4B.line.running.value:DISCRETE(flow=false start = WT4B.line.Running0 fixed = true )  type: Boolean
         WT4B.wecc_reec.firstOrder.y:VARIABLE(flow=false start = WT4B.wecc_reec.UInj0Pu fixed = true )  \"Connector of Real output signal\" type: Real
         WT4B.wecc_reec.firstOrder1.y:VARIABLE(flow=false start = WT4B.wecc_reec.firstOrder1.y_start fixed = true )  \"Connector of Real output signal\" type: Real
         WT4B.wecc_reec.limPIDFreeze.I.y:VARIABLE(flow=false start = WT4B.wecc_reec.limPIDFreeze.I.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         WT4B.wecc_reec.varLimPIDFreeze.I.y:VARIABLE(flow=false start = WT4B.wecc_reec.varLimPIDFreeze.I.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         WT4B.wecc_reec.rateLimFirstOrderFreeze1.y:VARIABLE(flow=false start = WT4B.wecc_reec.rateLimFirstOrderFreeze1.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         WT4B.wecc_reec.rateLimFirstOrderFreeze.y:VARIABLE(flow=false start = WT4B.wecc_reec.rateLimFirstOrderFreeze.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         WT4B.wecc_reec.iqInjectionLogic.vDip:DISCRETE(flow=false start = false fixed = true )  \"Ongoing voltage dip\" type: Boolean
         WT4B.wecc_reec.iqInjectionLogic.vDipInjEndTime:DISCRETE(start = -1.0 unit = \"s\" fixed = true )  \"ending time of the voltage dip start (in seconds)\" type: Real
         WT4B.wecc_reec.currentLimitsCalculation1.ipMaxFrzPu:DISCRETE(start = 0.0 unit = \"1\" fixed = true )  type: Real
         WT4B.wecc_reec.currentLimitsCalculation1.vDipFrzEndTime:DISCRETE(start = -1.0 unit = \"s\" fixed = true )  type: Real
         WT4B.wecc_regc.firstOrder.y:VARIABLE(flow=false start = WT4B.wecc_regc.UInj0Pu fixed = true )  \"Connector of Real output signal\" type: Real
         WT4B.wecc_regc.rateLimFirstOrderFreeze.y:VARIABLE(flow=false start = WT4B.wecc_regc.rateLimFirstOrderFreeze.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         WT4B.wecc_regc.rateLimFirstOrderFreeze1.y:VARIABLE(flow=false start = WT4B.wecc_regc.rateLimFirstOrderFreeze1.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         WT4B.injector.running.value:DISCRETE(flow=false start = WT4B.injector.Running0 fixed = true )  type: Boolean
         WT4B.wecc_reec.currentLimitsCalculation1.vDip:DISCRETE(flow=false fixed = true )  \"Ongoing voltage dip\" type: Boolean
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 33
 * Number of states: 0 ()
 * Number of discrete variables: 53 ($PRE.WT4B.injector.state,WT4B.injector.state,$PRE.WT4B.line.state,WT4B.line.state,$PRE.line.state,line.state,WT4B.injector.switchOffSignal3.value,WT4B.injector.switchOffSignal2.value,WT4B.injector.switchOffSignal1.value,line.switchOffSignal2.value,line.switchOffSignal1.value,WT4B.wecc_regc.rateLimFirstOrderFreeze1.local_freeze,WT4B.wecc_regc.rateLimFirstOrderFreeze.local_freeze,$PRE.line.running.value,$PRE.WT4B.line.running.value,$PRE.WT4B.wecc_reec.iqInjectionLogic.vDip,$PRE.WT4B.wecc_reec.iqInjectionLogic.vDipInjEndTime,$PRE.WT4B.wecc_reec.currentLimitsCalculation1.ipMaxFrzPu,$PRE.WT4B.wecc_reec.currentLimitsCalculation1.vDipFrzEndTime,$PRE.WT4B.injector.running.value,$PRE.WT4B.wecc_reec.currentLimitsCalculation1.vDip,WT4B.injector.running.value,WT4B.wecc_regc.offDelay.tNext,WT4B.wecc_regc.offDelay.delaySignal,WT4B.wecc_regc.offDelay.y,WT4B.wecc_reec.currentLimitsCalculation1.vDipFrzEndTime,WT4B.wecc_reec.currentLimitsCalculation1.ipMaxFrzPu,WT4B.wecc_reec.currentLimitsCalculation1.vDip,WT4B.wecc_reec.iqInjectionLogic.vDipInjEndTime,WT4B.wecc_reec.iqInjectionLogic.vDip,WT4B.line.running.value,line.running.value,$whenCondition17,$whenCondition16,$whenCondition2,$whenCondition1,$whenCondition3,$whenCondition5,$whenCondition4,$whenCondition6,$whenCondition8,$whenCondition7,$whenCondition10,$whenCondition9,$whenCondition12,$whenCondition11,$whenCondition14,$whenCondition13,$whenCondition15,WT4B.pll.limIntegrator.local_reset,WT4B.pll.integrator.local_reset,WT4B.wecc_reec.varLimPIDFreeze.I.resetLocal,WT4B.wecc_reec.limPIDFreeze.I.resetLocal)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (178):
 * Single equations (assignments): 176
 * Array equations: 0
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 1
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 1 system
   {(8,56.2%)}
 * Non-linear Jacobian (size): 0 systems
 * Without analytic Jacobian (size): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.0009158/0.7042, allocations: 421.1 kB / 0.6938 GB, free: 13.38 MB / 0.5137 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001028/0.7053, allocations: 226.6 kB / 0.694 GB, free: 13.16 MB / 0.5137 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.006844/0.7121, allocations: 2.299 MB / 0.6963 GB, free: 10.85 MB / 0.5137 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.479e-05/0.7121, allocations: 12 kB / 0.6963 GB, free: 10.84 MB / 0.5137 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.68e-05/0.7121, allocations: 4 kB / 0.6963 GB, free: 10.84 MB / 0.5137 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.653e-05/0.7122, allocations: 7.969 kB / 0.6963 GB, free: 10.83 MB / 0.5137 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01268/0.7248, allocations: 4.864 MB / 0.701 GB, free: 5.934 MB / 0.5137 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.694e-06/0.7248, allocations: 0 / 0.701 GB, free: 5.934 MB / 0.5137 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001978/0.7268, allocations: 289 kB / 0.7013 GB, free: 5.664 MB / 0.5137 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.00053/0.7273, allocations: 300.7 kB / 0.7016 GB, free: 5.367 MB / 0.5137 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001909/0.7275, allocations: 51.89 kB / 0.7017 GB, free: 5.316 MB / 0.5137 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.53e-05/0.7276, allocations: 4 kB / 0.7017 GB, free: 5.312 MB / 0.5137 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.265e-06/0.7276, allocations: 0 / 0.7017 GB, free: 5.312 MB / 0.5137 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.009247/0.7368, allocations: 3.405 MB / 0.705 GB, free: 1.887 MB / 0.5137 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001542/0.7383, allocations: 0.5109 MB / 0.7055 GB, free: 1.355 MB / 0.5137 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0007388/0.7391, allocations: 44 kB / 0.7055 GB, free: 1.312 MB / 0.5137 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001677/0.7408, allocations: 124 kB / 0.7056 GB, free: 1.191 MB / 0.5137 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0004851/0.7412, allocations: 174.1 kB / 0.7058 GB, free: 1.023 MB / 0.5137 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001694/0.7414, allocations: 51.97 kB / 0.7059 GB, free: 0.9727 MB / 0.5137 GB
Notification: Performance of sorting global known variables: time 0.003109/0.7445, allocations: 1.248 MB / 0.7071 GB, free: 15.7 MB / 0.5294 GB
Notification: Performance of sort global known variables: time 1.11e-07/0.7445, allocations: 0 / 0.7071 GB, free: 15.7 MB / 0.5294 GB
Notification: Performance of remove unused functions: time 0.003385/0.7479, allocations: 0.7367 MB / 0.7078 GB, free: 14.96 MB / 0.5294 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 12 (WT4B.wecc_reec.firstOrder.y,WT4B.wecc_reec.firstOrder1.y,WT4B.wecc_reec.limPIDFreeze.I.y,WT4B.wecc_reec.varLimPIDFreeze.I.y,WT4B.wecc_reec.rateLimFirstOrderFreeze1.y,WT4B.wecc_reec.slewRateLimiter.y,WT4B.wecc_reec.rateLimFirstOrderFreeze.y,WT4B.wecc_regc.firstOrder.y,WT4B.wecc_regc.rateLimFirstOrderFreeze.y,WT4B.wecc_regc.rateLimFirstOrderFreeze1.y,WT4B.pll.integrator.y,WT4B.pll.limIntegrator.y)
 * Number of discrete variables: 31 ($whenCondition15,$whenCondition13,$whenCondition14,$whenCondition11,$whenCondition12,$whenCondition9,$whenCondition10,$whenCondition7,$whenCondition8,$whenCondition6,$whenCondition4,$whenCondition5,$whenCondition3,$whenCondition1,$whenCondition2,$whenCondition16,$whenCondition17,line.running.value,line.state,WT4B.line.running.value,WT4B.line.state,WT4B.wecc_reec.iqInjectionLogic.vDip,WT4B.wecc_reec.iqInjectionLogic.vDipInjEndTime,WT4B.wecc_reec.currentLimitsCalculation1.vDip,WT4B.wecc_reec.currentLimitsCalculation1.ipMaxFrzPu,WT4B.wecc_reec.currentLimitsCalculation1.vDipFrzEndTime,WT4B.wecc_regc.offDelay.y,WT4B.wecc_regc.offDelay.delaySignal,WT4B.wecc_regc.offDelay.tNext,WT4B.injector.running.value,WT4B.injector.state)
 * Number of discrete states: 12 (WT4B.injector.running.value,WT4B.line.running.value,line.running.value,WT4B.wecc_regc.offDelay.tNext,WT4B.wecc_regc.offDelay.delaySignal,$whenCondition17,$whenCondition16,WT4B.wecc_reec.currentLimitsCalculation1.vDip,WT4B.wecc_reec.currentLimitsCalculation1.vDipFrzEndTime,WT4B.wecc_reec.currentLimitsCalculation1.ipMaxPu,WT4B.wecc_reec.iqInjectionLogic.vDip,WT4B.wecc_reec.iqInjectionLogic.vDipInjEndTime)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (134):
 * Single equations (assignments): 123
 * Array equations: 0
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 9
 * If-equations: 0
 * Equation systems (not torn): 1
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 1 system
   {(8,56.2%)}
 * Non-linear Jacobian (size): 0 systems
 * Without analytic Jacobian (size): 0 systems
Notification: Performance of Backend phase and start with SimCode phase: time 0.001809/0.7497, allocations: 463.8 kB / 0.7082 GB, free: 14.68 MB / 0.5294 GB
Notification: Performance of simCode: created initialization part: time 0.007601/0.7573, allocations: 3.106 MB / 0.7113 GB, free: 11.57 MB / 0.5294 GB
Notification: Performance of simCode: created event and clocks part: time 5.51e-06/0.7573, allocations: 3.469 kB / 0.7113 GB, free: 11.57 MB / 0.5294 GB
Notification: Performance of simCode: created simulation system equations: time 0.002435/0.7598, allocations: 1.072 MB / 0.7123 GB, free: 10.49 MB / 0.5294 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002247/0.762, allocations: 342 kB / 0.7127 GB, free: 10.16 MB / 0.5294 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.0091/0.7711, allocations: 3.924 MB / 0.7165 GB, free: 6.207 MB / 0.5294 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001343/0.7725, allocations: 1.409 MB / 0.7179 GB, free: 4.762 MB / 0.5294 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0008985/0.7734, allocations: 151.4 kB / 0.718 GB, free: 4.613 MB / 0.5294 GB
Notification: Performance of SimCode: time 9.42e-07/0.7734, allocations: 0 / 0.718 GB, free: 4.613 MB / 0.5294 GB
Notification: Performance of Templates: time 0.06972/0.8431, allocations: 38.26 MB / 0.7554 GB, free: 14.41 MB / 0.5762 GB
"
[Timeout remaining time 659]
make -j1 -f Dynawo_dev_Dynawo.Examples.Wind.WECC.WT4BCurrentSource.makefile [Timeout 660]
(rm -f Dynawo_dev_Dynawo.Examples.Wind.WECC.WT4BCurrentSource.pipe ; mkfifo Dynawo_dev_Dynawo.Examples.Wind.WECC.WT4BCurrentSource.pipe ; head -c 1048576 < Dynawo_dev_Dynawo.Examples.Wind.WECC.WT4BCurrentSource.pipe >> ../files/Dynawo_dev_Dynawo.Examples.Wind.WECC.WT4BCurrentSource.sim & ./Dynawo_dev_Dynawo.Examples.Wind.WECC.WT4BCurrentSource  -lv=LOG_STATS -s=ida -maxIntegrationOrder=2 -nls=kinsol -initialStepSize=0.00001 -maxStepSize=10 -abortSlowSimulation -alarm=480 -lv LOG_STATS > Dynawo_dev_Dynawo.Examples.Wind.WECC.WT4BCurrentSource.pipe 2>&1) [Timeout 480]
[Calling sys.exit(0), Time elapsed: 11.502266180003062]
Failed to read output from testmodel.py, exit status != 0:
0.8540861920919269 0.868162537 0.283374919
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f3002fce050>