Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Dynawo_Dynawo.Examples.BESS.WECC.BESScbCurrentSource.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.001276/0.001276, allocations: 109.9 kB / 17.14 MB, free: 5.93 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.001543/0.001543, allocations: 205.1 kB / 20.11 MB, free: 2.977 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.652/1.652, allocations: 207.6 MB / 230.5 MB, free: 4.016 MB / 174.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0/package.mo): time 0.7884/0.7884, allocations: 104 MB / 386.3 MB, free: 13.93 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/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.BESS.WECC.BESScbCurrentSource,tolerance=1e-05,outputFormat="empty",numberOfIntervals=3000,variableFilter="",fileNamePrefix="Dynawo_Dynawo.Examples.BESS.WECC.BESScbCurrentSource")
translateModel(Dynawo.Examples.BESS.WECC.BESScbCurrentSource,tolerance=1e-05,outputFormat="empty",numberOfIntervals=3000,variableFilter="",fileNamePrefix="Dynawo_Dynawo.Examples.BESS.WECC.BESScbCurrentSource") [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.003784/0.003784, allocations: 75.89 kB / 0.5464 GB, free: 10.32 MB / 414.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1822/0.186, allocations: 75.95 MB / 0.6206 GB, free: 14.29 MB / 494.1 MB
Notification: Performance of NFInst.instantiate(Dynawo.Examples.BESS.WECC.BESScbCurrentSource): time 0.0172/0.2032, allocations: 12.24 MB / 0.6325 GB, free: 1.965 MB / 494.1 MB
Notification: Performance of NFInst.instExpressions: time 0.4375/0.6407, allocations: 6.251 MB / 0.6386 GB, free: 13.89 MB / 494.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004267/0.6449, allocations: 91.88 kB / 0.6387 GB, free: 13.89 MB / 494.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0/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/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/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/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/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/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/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/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/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/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.002912/0.6478, allocations: 0.7243 MB / 0.6394 GB, free: 13.88 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.005121/0.653, allocations: 0.9129 MB / 0.6403 GB, free: 13.59 MB / 494.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0/Examples/BESS/WECC/BESScbCurrentSource.mo:39:3-39:38:writable] Warning: Conditional component 'switchOffSignal2' is used in a non-connect context.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0/Examples/BESS/WECC/BESScbCurrentSource.mo:41:3-41:49:writable] Warning: Conditional component 'switchOffSignal2' is used in a non-connect context.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0/Examples/BESS/WECC/BESScbCurrentSource.mo:42:3-42:49:writable] Warning: Conditional component 'switchOffSignal3' is used in a non-connect context.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0/Electrical/BESS/WECC/BaseClasses/BaseBESScbCurrentSource.mo:108:3-108:64:writable] Warning: Conditional component 'switchOffSignal2' is used in a non-connect context.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.7.0/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/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/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/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/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/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/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/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/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/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/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/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/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/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/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.007556/0.6605, allocations: 2.819 MB / 0.6431 GB, free: 13.45 MB / 494.1 MB
Notification: Performance of NFFlatten.flatten: time 0.008266/0.6688, allocations: 4.345 MB / 0.6473 GB, free: 11.51 MB / 494.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.002766/0.6716, allocations: 1.095 MB / 0.6484 GB, free: 10.79 MB / 494.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.003212/0.6748, allocations: 1.606 MB / 0.6499 GB, free: 9.867 MB / 494.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.003377/0.6781, allocations: 1.666 MB / 0.6516 GB, free: 8.91 MB / 494.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.001575/0.6797, allocations: 470.2 kB / 0.652 GB, free: 8.91 MB / 494.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.002071/0.6818, allocations: 0.6776 MB / 0.6527 GB, free: 8.844 MB / 494.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.000941/0.6827, allocations: 0.9484 MB / 0.6536 GB, free: 8.18 MB / 494.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.002342/0.6851, allocations: 1.83 MB / 0.6554 GB, free: 6.781 MB / 494.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.009285/0.6944, allocations: 5.671 MB / 0.6609 GB, free: 3.953 MB / 494.1 MB
Notification: Performance of FrontEnd - DAE generated: time 6.593e-06/0.6944, allocations: 0.75 kB / 0.6609 GB, free: 3.953 MB / 494.1 MB
Notification: Performance of FrontEnd: time 1.753e-06/0.6944, allocations: 0 / 0.6609 GB, free: 3.953 MB / 494.1 MB
Notification: Performance of Transformations before backend: time 0.0002563/0.6946, allocations: 0.875 kB / 0.6609 GB, free: 3.953 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: 548
 * Number of variables: 548
Notification: Performance of Generate backend data structure: time 0.0163/0.7109, allocations: 4.472 MB / 0.6653 GB, free: 0.8008 MB / 494.1 MB
Notification: Performance of prepare preOptimizeDAE: time 4.691e-05/0.711, allocations: 9.625 kB / 0.6653 GB, free: 0.8008 MB / 494.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005259/0.7162, allocations: 0.8975 MB / 0.6662 GB, free: 408 kB / 494.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.005692/0.7219, allocations: 2.423 MB / 0.6685 GB, free: 14.55 MB / 0.4981 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0006276/0.7225, allocations: 0.5639 MB / 0.6691 GB, free: 14.02 MB / 0.4981 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0006845/0.7232, allocations: 223.9 kB / 0.6693 GB, free: 13.94 MB / 0.4981 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.007709/0.7309, allocations: 2.918 MB / 0.6722 GB, free: 11.99 MB / 0.4981 GB
Notification: Performance of preOpt findStateOrder (simulation): time 4.962e-05/0.731, allocations: 5.188 kB / 0.6722 GB, free: 11.98 MB / 0.4981 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003079/0.7313, allocations: 92.38 kB / 0.6722 GB, free: 11.92 MB / 0.4981 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.727e-05/0.7314, allocations: 54.38 kB / 0.6723 GB, free: 11.92 MB / 0.4981 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.006939/0.7383, allocations: 2.448 MB / 0.6747 GB, free: 10.68 MB / 0.4981 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.02231/0.7606, allocations: 11.27 MB / 0.6857 GB, free: 1.363 MB / 0.4981 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.006552/0.7672, allocations: 2.336 MB / 0.688 GB, free: 152 kB / 0.4981 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002789/0.7699, allocations: 1.045 MB / 0.689 GB, free: 15.6 MB / 0.5137 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001462/0.7701, allocations: 25.34 kB / 0.689 GB, free: 15.6 MB / 0.5137 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.003184/0.7733, allocations: 1.419 MB / 0.6904 GB, free: 14.72 MB / 0.5137 GB
Notification: Performance of pre-optimization done (n=176): time 5.28e-06/0.7733, allocations: 2.953 kB / 0.6904 GB, free: 14.72 MB / 0.5137 GB
Notification: Performance of matching and sorting (n=176): time 0.01174/0.785, allocations: 3.944 MB / 0.6943 GB, free: 12.27 MB / 0.5137 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0003251/0.7853, allocations: 0.5101 MB / 0.6948 GB, free: 11.65 MB / 0.5137 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.005559/0.7909, allocations: 2.83 MB / 0.6975 GB, free: 8.812 MB / 0.5137 GB
Notification: Performance of collectPreVariables (initialization): time 0.0005979/0.7915, allocations: 65.69 kB / 0.6976 GB, free: 8.742 MB / 0.5137 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001589/0.7931, allocations: 1.397 MB / 0.699 GB, free: 7.34 MB / 0.5137 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001027/0.7941, allocations: 0.6122 MB / 0.6995 GB, free: 6.738 MB / 0.5137 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0007032/0.7948, allocations: 351.4 kB / 0.6999 GB, free: 6.387 MB / 0.5137 GB
Notification: Performance of setup shared object (initialization): time 0.0001293/0.7949, allocations: 305.1 kB / 0.7002 GB, free: 6.086 MB / 0.5137 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002612/0.7976, allocations: 1.024 MB / 0.7012 GB, free: 5.059 MB / 0.5137 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003131/0.8007, allocations: 1.521 MB / 0.7027 GB, free: 3.359 MB / 0.5137 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01916/0.8198, allocations: 5.566 MB / 0.7081 GB, free: 13.66 MB / 0.5294 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.471e-05/0.8199, allocations: 4 kB / 0.7081 GB, free: 13.66 MB / 0.5294 GB
Notification: Performance of matching and sorting (n=243) (initialization): time 0.009932/0.8298, allocations: 3.199 MB / 0.7112 GB, free: 10.44 MB / 0.5294 GB
Notification: Performance of prepare postOptimizeDAE: time 8.727e-05/0.8299, allocations: 41.69 kB / 0.7113 GB, free: 10.39 MB / 0.5294 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.16e-05/0.8299, allocations: 15.88 kB / 0.7113 GB, free: 10.38 MB / 0.5294 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0005356/0.8304, allocations: 321.4 kB / 0.7116 GB, free: 10.06 MB / 0.5294 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002801/0.8332, allocations: 495.3 kB / 0.7121 GB, free: 9.574 MB / 0.5294 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 3.267e-05/0.8333, allocations: 19.94 kB / 0.7121 GB, free: 9.555 MB / 0.5294 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002982/0.8363, allocations: 330.4 kB / 0.7124 GB, free: 9.23 MB / 0.5294 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001951/0.8364, allocations: 75.98 kB / 0.7125 GB, free: 9.156 MB / 0.5294 GB
Warning: Assuming fixed start value for the following 21 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)
         BESScb.line.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = BESScb.line.State0 fixed = true )  \"Line connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined)
         BESScb.injector.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = BESScb.injector.State0 fixed = true )  \"Injector connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined)
         BESScb.reecC.firstOrder.y:VARIABLE(flow=false start = BESScb.reecC.UInj0Pu fixed = true )  \"Connector of Real output signal\" type: Real
         BESScb.reecC.firstOrder1.y:VARIABLE(flow=false start = BESScb.reecC.firstOrder1.y_start fixed = true )  \"Connector of Real output signal\" type: Real
         BESScb.reecC.limPIDFreeze.I.y:VARIABLE(flow=false start = BESScb.reecC.limPIDFreeze.I.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         BESScb.reecC.varLimPIDFreeze.I.y:VARIABLE(flow=false start = BESScb.reecC.varLimPIDFreeze.I.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         BESScb.reecC.rateLimFirstOrderFreeze1.y:VARIABLE(flow=false start = BESScb.reecC.rateLimFirstOrderFreeze1.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         BESScb.reecC.rateLimFirstOrderFreeze.y:VARIABLE(flow=false start = BESScb.reecC.rateLimFirstOrderFreeze.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         BESScb.regcBCS.firstOrder.y:VARIABLE(flow=false start = BESScb.regcBCS.UInj0Pu fixed = true )  \"Connector of Real output signal\" type: Real
         BESScb.regcBCS.rateLimFirstOrderFreeze.y:VARIABLE(flow=false start = BESScb.regcBCS.rateLimFirstOrderFreeze.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         BESScb.regcBCS.rateLimFirstOrderFreeze1.y:VARIABLE(flow=false start = BESScb.regcBCS.rateLimFirstOrderFreeze1.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         BESScb.injector.running.value:DISCRETE(flow=false start = BESScb.injector.Running0 fixed = true )  type: Boolean
         BESScb.line.running.value:DISCRETE(flow=false start = BESScb.line.Running0 fixed = true )  type: Boolean
         BESScb.repcA.firstOrder.y:VARIABLE(flow=false start = BESScb.repcA.firstOrder.y_start fixed = true )  \"Connector of Real output signal\" type: Real
         BESScb.repcA.firstOrder1.y:VARIABLE(flow=false start = BESScb.repcA.firstOrder1.y_start fixed = true )  \"Connector of Real output signal\" type: Real
         BESScb.repcA.firstOrder2.y:VARIABLE(flow=false start = BESScb.repcA.firstOrder2.y_start fixed = true )  \"Connector of Real output signal\" type: Real
         BESScb.repcA.firstOrder3.y:VARIABLE(flow=false start = BESScb.repcA.firstOrder3.y_start fixed = true )  \"Connector of Real output signal\" type: Real
         BESScb.repcA.limPIDFreeze.I.y:VARIABLE(flow=false start = BESScb.repcA.limPIDFreeze.I.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         BESScb.repcA.leadLag.x_scaled[1]:VARIABLE(start = BESScb.repcA.leadLag.a_end * BESScb.repcA.leadLag.x_start[1] fixed = true protected = true )  \"Scaled vector x\" type: Real [1]
         line.running.value:DISCRETE(flow=false start = line.Running0 fixed = true )  type: Boolean
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.004089/0.8405, allocations: 1.58 MB / 0.714 GB, free: 7.586 MB / 0.5294 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.003043/0.8436, allocations: 1.468 MB / 0.7154 GB, free: 5.934 MB / 0.5294 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.01865/0.8622, allocations: 5.417 MB / 0.7207 GB, free: 368 kB / 0.5294 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.191e-05/0.8622, allocations: 4 kB / 0.7207 GB, free: 364 kB / 0.5294 GB
Notification: Performance of matching and sorting (n=243) (initialization_lambda0): time 0.009477/0.8717, allocations: 3.095 MB / 0.7238 GB, free: 13.24 MB / 0.545 GB
Notification: Performance of prepare postOptimizeDAE: time 6.065e-05/0.8718, allocations: 45.62 kB / 0.7238 GB, free: 13.19 MB / 0.545 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.866e-05/0.8718, allocations: 15.98 kB / 0.7238 GB, free: 13.18 MB / 0.545 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0005004/0.8723, allocations: 312.8 kB / 0.7241 GB, free: 12.87 MB / 0.545 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002493/0.8748, allocations: 475.3 kB / 0.7246 GB, free: 12.4 MB / 0.545 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 3.214e-05/0.8748, allocations: 27.92 kB / 0.7246 GB, free: 12.38 MB / 0.545 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002968/0.8778, allocations: 286.9 kB / 0.7249 GB, free: 12.09 MB / 0.545 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001733/0.878, allocations: 71.98 kB / 0.7249 GB, free: 12.02 MB / 0.545 GB
Warning: Assuming fixed start value for the following 21 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)
         BESScb.line.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = BESScb.line.State0 fixed = true )  \"Line connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined)
         BESScb.injector.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = BESScb.injector.State0 fixed = true )  \"Injector connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined)
         BESScb.reecC.firstOrder.y:VARIABLE(flow=false start = BESScb.reecC.UInj0Pu fixed = true )  \"Connector of Real output signal\" type: Real
         BESScb.reecC.firstOrder1.y:VARIABLE(flow=false start = BESScb.reecC.firstOrder1.y_start fixed = true )  \"Connector of Real output signal\" type: Real
         BESScb.reecC.limPIDFreeze.I.y:VARIABLE(flow=false start = BESScb.reecC.limPIDFreeze.I.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         BESScb.reecC.varLimPIDFreeze.I.y:VARIABLE(flow=false start = BESScb.reecC.varLimPIDFreeze.I.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         BESScb.reecC.rateLimFirstOrderFreeze1.y:VARIABLE(flow=false start = BESScb.reecC.rateLimFirstOrderFreeze1.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         BESScb.reecC.rateLimFirstOrderFreeze.y:VARIABLE(flow=false start = BESScb.reecC.rateLimFirstOrderFreeze.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         BESScb.regcBCS.firstOrder.y:VARIABLE(flow=false start = BESScb.regcBCS.UInj0Pu fixed = true )  \"Connector of Real output signal\" type: Real
         BESScb.regcBCS.rateLimFirstOrderFreeze.y:VARIABLE(flow=false start = BESScb.regcBCS.rateLimFirstOrderFreeze.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         BESScb.regcBCS.rateLimFirstOrderFreeze1.y:VARIABLE(flow=false start = BESScb.regcBCS.rateLimFirstOrderFreeze1.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         BESScb.injector.running.value:DISCRETE(flow=false start = BESScb.injector.Running0 fixed = true )  type: Boolean
         BESScb.line.running.value:DISCRETE(flow=false start = BESScb.line.Running0 fixed = true )  type: Boolean
         BESScb.repcA.firstOrder.y:VARIABLE(flow=false start = BESScb.repcA.firstOrder.y_start fixed = true )  \"Connector of Real output signal\" type: Real
         BESScb.repcA.firstOrder1.y:VARIABLE(flow=false start = BESScb.repcA.firstOrder1.y_start fixed = true )  \"Connector of Real output signal\" type: Real
         BESScb.repcA.firstOrder2.y:VARIABLE(flow=false start = BESScb.repcA.firstOrder2.y_start fixed = true )  \"Connector of Real output signal\" type: Real
         BESScb.repcA.firstOrder3.y:VARIABLE(flow=false start = BESScb.repcA.firstOrder3.y_start fixed = true )  \"Connector of Real output signal\" type: Real
         BESScb.repcA.limPIDFreeze.I.y:VARIABLE(flow=false start = BESScb.repcA.limPIDFreeze.I.Y0 fixed = true )  \"Connector of Real output signal\" type: Real
         BESScb.repcA.leadLag.x_scaled[1]:VARIABLE(start = BESScb.repcA.leadLag.a_end * BESScb.repcA.leadLag.x_start[1] fixed = true protected = true )  \"Scaled vector x\" type: Real [1]
         line.running.value:DISCRETE(flow=false start = line.Running0 fixed = true )  type: Boolean
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 44
 * Number of states: 0 ()
 * Number of discrete variables: 42 ($PRE.line.state,line.state,$PRE.BESScb.line.state,BESScb.line.state,$PRE.BESScb.injector.state,BESScb.injector.state,BESScb.injector.switchOffSignal3.value,BESScb.injector.switchOffSignal2.value,BESScb.injector.switchOffSignal1.value,line.switchOffSignal2.value,line.switchOffSignal1.value,BESScb.regcBCS.rateLimFirstOrderFreeze1.local_freeze,BESScb.regcBCS.rateLimFirstOrderFreeze.local_freeze,$PRE.BESScb.injector.running.value,$PRE.BESScb.line.running.value,$PRE.line.running.value,line.running.value,BESScb.repcA.freeze,BESScb.line.running.value,BESScb.injector.running.value,BESScb.regcBCS.offDelay.tNext,BESScb.regcBCS.offDelay.delaySignal,BESScb.regcBCS.offDelay.y,BESScb.reecC.frtOn,$whenCondition11,$whenCondition10,$whenCondition2,$whenCondition1,$whenCondition3,$whenCondition5,$whenCondition4,$whenCondition6,$whenCondition8,$whenCondition7,$whenCondition9,BESScb.repcA.limPIDFreeze.I.resetLocal,BESScb.repcA.limPID.I.local_reset,BESScb.pll.limIntegrator.local_reset,BESScb.pll.integrator.local_reset,BESScb.reecC.integrator.local_reset,BESScb.reecC.varLimPIDFreeze.I.resetLocal,BESScb.reecC.limPIDFreeze.I.resetLocal)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (233):
 * Single equations (assignments): 231
 * 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.0009511/0.8789, allocations: 452.4 kB / 0.7254 GB, free: 11.58 MB / 0.545 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001082/0.88, allocations: 333.8 kB / 0.7257 GB, free: 11.25 MB / 0.545 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.008575/0.8886, allocations: 2.985 MB / 0.7286 GB, free: 8.242 MB / 0.545 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.809e-05/0.8886, allocations: 19.94 kB / 0.7286 GB, free: 8.223 MB / 0.545 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.255e-05/0.8886, allocations: 8 kB / 0.7286 GB, free: 8.215 MB / 0.545 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 2.306e-05/0.8886, allocations: 7.969 kB / 0.7286 GB, free: 8.207 MB / 0.545 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01627/0.9049, allocations: 6.595 MB / 0.7351 GB, free: 1.59 MB / 0.545 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 8.867e-06/0.9049, allocations: 0 / 0.7351 GB, free: 1.59 MB / 0.545 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.00277/0.9077, allocations: 423.5 kB / 0.7355 GB, free: 1.176 MB / 0.545 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0005126/0.9082, allocations: 304.7 kB / 0.7358 GB, free: 0.875 MB / 0.545 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0002364/0.9084, allocations: 51.91 kB / 0.7358 GB, free: 0.8242 MB / 0.545 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.141e-05/0.9084, allocations: 8 kB / 0.7358 GB, free: 0.8164 MB / 0.545 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.254e-06/0.9084, allocations: 4 kB / 0.7358 GB, free: 0.8125 MB / 0.545 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.0121/0.9205, allocations: 4.501 MB / 0.7402 GB, free: 12.28 MB / 0.5606 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002283/0.9228, allocations: 0.7017 MB / 0.7409 GB, free: 11.56 MB / 0.5606 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0005854/0.9234, allocations: 48 kB / 0.741 GB, free: 11.51 MB / 0.5606 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001892/0.9253, allocations: 191.8 kB / 0.7411 GB, free: 11.32 MB / 0.5606 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0003983/0.9257, allocations: 133.8 kB / 0.7413 GB, free: 11.2 MB / 0.5606 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001552/0.9259, allocations: 67.84 kB / 0.7413 GB, free: 11.13 MB / 0.5606 GB
Notification: Performance of sorting global known variables: time 0.003786/0.9296, allocations: 1.908 MB / 0.7432 GB, free: 9.223 MB / 0.5606 GB
Notification: Performance of sort global known variables: time 9e-08/0.9296, allocations: 0 / 0.7432 GB, free: 9.223 MB / 0.5606 GB
Notification: Performance of remove unused functions: time 0.003347/0.933, allocations: 1.013 MB / 0.7442 GB, free: 8.207 MB / 0.5606 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 20 (BESScb.reecC.firstOrder.y,BESScb.reecC.firstOrder1.y,BESScb.reecC.limPIDFreeze.I.y,BESScb.reecC.varLimPIDFreeze.I.y,BESScb.reecC.rateLimFirstOrderFreeze1.y,BESScb.reecC.slewRateLimiter.y,BESScb.reecC.rateLimFirstOrderFreeze.y,BESScb.reecC.integrator.y,BESScb.regcBCS.firstOrder.y,BESScb.regcBCS.rateLimFirstOrderFreeze.y,BESScb.regcBCS.rateLimFirstOrderFreeze1.y,BESScb.pll.integrator.y,BESScb.pll.limIntegrator.y,BESScb.repcA.firstOrder.y,BESScb.repcA.limPID.I.y,BESScb.repcA.firstOrder1.y,BESScb.repcA.firstOrder2.y,BESScb.repcA.firstOrder3.y,BESScb.repcA.limPIDFreeze.I.y,BESScb.repcA.leadLag.x_scaled[1])
 * Number of discrete variables: 22 ($whenCondition9,$whenCondition7,$whenCondition8,$whenCondition6,$whenCondition4,$whenCondition5,$whenCondition3,$whenCondition1,$whenCondition2,$whenCondition10,$whenCondition11,BESScb.reecC.frtOn,BESScb.regcBCS.offDelay.y,BESScb.regcBCS.offDelay.delaySignal,BESScb.regcBCS.offDelay.tNext,BESScb.injector.running.value,BESScb.injector.state,BESScb.line.running.value,BESScb.line.state,BESScb.repcA.freeze,line.running.value,line.state)
 * Number of discrete states: 7 (line.running.value,BESScb.line.running.value,BESScb.injector.running.value,BESScb.regcBCS.offDelay.tNext,BESScb.regcBCS.offDelay.delaySignal,$whenCondition11,$whenCondition10)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (175):
 * Single equations (assignments): 167
 * Array equations: 0
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 6
 * 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.001832/0.9348, allocations: 470 kB / 0.7446 GB, free: 7.879 MB / 0.5606 GB
Notification: Performance of simCode: created initialization part: time 0.01097/0.9458, allocations: 4.045 MB / 0.7486 GB, free: 3.77 MB / 0.5606 GB
Notification: Performance of simCode: created event and clocks part: time 7.805e-06/0.9458, allocations: 0 / 0.7486 GB, free: 3.77 MB / 0.5606 GB
Notification: Performance of simCode: created simulation system equations: time 0.003556/0.9494, allocations: 1.382 MB / 0.7499 GB, free: 2.359 MB / 0.5606 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003656/0.953, allocations: 0.4981 MB / 0.7504 GB, free: 1.871 MB / 0.5606 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01402/0.967, allocations: 5.682 MB / 0.756 GB, free: 12.16 MB / 0.5762 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001793/0.9688, allocations: 1.774 MB / 0.7577 GB, free: 10.36 MB / 0.5762 GB
Notification: Performance of simCode: alias equations: time 0.002191/0.971, allocations: 378.1 kB / 0.7581 GB, free: 9.988 MB / 0.5762 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0007497/0.9718, allocations: 187.4 kB / 0.7582 GB, free: 9.805 MB / 0.5762 GB
Notification: Performance of SimCode: time 1.403e-06/0.9718, allocations: 0 / 0.7582 GB, free: 9.805 MB / 0.5762 GB
Notification: Performance of Templates: time 0.07492/1.047, allocations: 34.5 MB / 0.7919 GB, free: 7.43 MB / 0.6075 GB
"
[Timeout remaining time 659]
make -j1 -f Dynawo_Dynawo.Examples.BESS.WECC.BESScbCurrentSource.makefile [Timeout 660]
(rm -f Dynawo_Dynawo.Examples.BESS.WECC.BESScbCurrentSource.pipe ; mkfifo Dynawo_Dynawo.Examples.BESS.WECC.BESScbCurrentSource.pipe ; head -c 1048576 < Dynawo_Dynawo.Examples.BESS.WECC.BESScbCurrentSource.pipe >> ../files/Dynawo_Dynawo.Examples.BESS.WECC.BESScbCurrentSource.sim & ./Dynawo_Dynawo.Examples.BESS.WECC.BESScbCurrentSource  -lv=LOG_STATS -s=ida -maxIntegrationOrder=2 -nls=kinsol -initialStepSize=0.00001 -maxStepSize=10 -abortSlowSimulation -alarm=480 -lv LOG_STATS > Dynawo_Dynawo.Examples.BESS.WECC.BESScbCurrentSource.pipe 2>&1) [Timeout 480]
[Calling sys.exit(0), Time elapsed: 7.694315887987614]
Failed to read output from testmodel.py, exit status != 0:
1.059673074632883 1.07226822 0.37444009500000003
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7faae75ed7e0>